builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1471042611.06 results: success (0) buildid: 20160812143816 builduid: b9c41b9e406445899e4fd8d1e1611a07 revision: 2ed7e61b988d2466a61528f66050596ef272ebda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.063377) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.063768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.064031) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.112627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.112888) ========= 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=41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 15:56:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-08-12 15:56:51 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115131 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.245031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.245366) ========= 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=41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019489 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.295859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.296239) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2ed7e61b988d2466a61528f66050596ef272ebda --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 2ed7e61b988d2466a61528f66050596ef272ebda --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=41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 15:56:51,610 truncating revision to first 12 chars 2016-08-12 15:56:51,610 Setting DEBUG logging. 2016-08-12 15:56:51,610 attempt 1/10 2016-08-12 15:56:51,610 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2ed7e61b988d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 15:56:51,904 unpacking tar archive at: mozilla-central-2ed7e61b988d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.931539) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.931811) ========= script_repo_revision: 2ed7e61b988d2466a61528f66050596ef272ebda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.932256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.932580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 15:56:51.965811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-12 15:56:51.966077) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:56:52 INFO - MultiFileLogger online at 20160812 15:56:52 in /builds/slave/test 15:56:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:56:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:56:52 INFO - {'append_to_log': False, 15:56:52 INFO - 'base_work_dir': '/builds/slave/test', 15:56:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:56:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:56:52 INFO - 'branch': 'Firefox-Non-PGO', 15:56:52 INFO - 'buildbot_json_path': 'buildprops.json', 15:56:52 INFO - 'config_files': ('talos/linux_config.py',), 15:56:52 INFO - 'default_actions': ('clobber', 15:56:52 INFO - 'read-buildbot-config', 15:56:52 INFO - 'download-and-extract', 15:56:52 INFO - 'populate-webroot', 15:56:52 INFO - 'create-virtualenv', 15:56:52 INFO - 'install', 15:56:52 INFO - 'run-tests'), 15:56:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:56:52 INFO - 'download_minidump_stackwalk': True, 15:56:52 INFO - 'download_symbols': 'ondemand', 15:56:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:56:52 INFO - 'tooltool.py': '/tools/tooltool.py', 15:56:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:56:52 INFO - '/tools/misc-python/virtualenv.py')}, 15:56:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:56:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:56:52 INFO - 'installer_path': 'installer.exe', 15:56:52 INFO - 'log_level': 'info', 15:56:52 INFO - 'log_name': 'talos', 15:56:52 INFO - 'log_to_console': True, 15:56:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:56:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:56:52 INFO - 'opt_config_files': (), 15:56:52 INFO - 'pip_index': False, 15:56:52 INFO - 'sps_profile': False, 15:56:52 INFO - 'sps_profile_interval': 0, 15:56:52 INFO - 'suite': 'dromaeojs', 15:56:52 INFO - 'system_bits': '32', 15:56:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:56:52 INFO - 'title': 'talos-linux64-ix-026', 15:56:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:56:52 INFO - 'use_talos_json': True, 15:56:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:56:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:56:52 INFO - 'work_dir': 'build'} 15:56:52 INFO - [mozharness: 2016-08-12 22:56:52.374312Z] Running clobber step. 15:56:52 INFO - Running pre-action listener: _resource_record_pre_action 15:56:52 INFO - Running main action method: clobber 15:56:52 INFO - rmtree: /builds/slave/test/build 15:56:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:56:52 INFO - Running post-action listener: _resource_record_post_action 15:56:52 INFO - [mozharness: 2016-08-12 22:56:52.840291Z] Finished clobber step (success) 15:56:52 INFO - [mozharness: 2016-08-12 22:56:52.840393Z] Running read-buildbot-config step. 15:56:52 INFO - Running pre-action listener: _resource_record_pre_action 15:56:52 INFO - Running main action method: read_buildbot_config 15:56:52 INFO - Using buildbot properties: 15:56:52 INFO - { 15:56:52 INFO - "project": "", 15:56:52 INFO - "product": "firefox", 15:56:52 INFO - "script_repo_revision": "production", 15:56:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:56:52 INFO - "repository": "", 15:56:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:56:52 INFO - "buildid": "20160812143816", 15:56:52 INFO - "pgo_build": "False", 15:56:52 INFO - "basedir": "/builds/slave/test", 15:56:52 INFO - "buildnumber": 593, 15:56:52 INFO - "slavename": "talos-linux64-ix-026", 15:56:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:56:52 INFO - "platform": "ubuntu64_hw", 15:56:52 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:56:52 INFO - "branch": "mozilla-central", 15:56:52 INFO - "repo_path": "mozilla-central", 15:56:52 INFO - "revision": "2ed7e61b988d2466a61528f66050596ef272ebda", 15:56:52 INFO - "stage_platform": "linux64", 15:56:52 INFO - "builduid": "b9c41b9e406445899e4fd8d1e1611a07", 15:56:52 INFO - "slavebuilddir": "test" 15:56:52 INFO - } 15:56:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:56:52 INFO - Running post-action listener: _resource_record_post_action 15:56:52 INFO - [mozharness: 2016-08-12 22:56:52.842835Z] Finished read-buildbot-config step (success) 15:56:52 INFO - [mozharness: 2016-08-12 22:56:52.842923Z] Running download-and-extract step. 15:56:52 INFO - Running pre-action listener: _resource_record_pre_action 15:56:52 INFO - Running main action method: download_and_extract 15:56:52 INFO - mkdir: /builds/slave/test/build/tests 15:56:52 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')]} 15:56:52 INFO - trying https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:56:52 INFO - Downloading https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/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 15:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/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 15:56:53 INFO - Downloaded 1361 bytes. 15:56:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:56:53 INFO - Using the following test package requirements: 15:56:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:56:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:56:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:56:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:53 INFO - u'jsshell-linux-x86_64.zip'], 15:56:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:56:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:56:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:56:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:56:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:56:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:56:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:56: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')]} 15:56:53 INFO - trying https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:56:53 INFO - Downloading https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/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 15:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/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 15:56:54 INFO - Downloaded 20264277 bytes. 15:56:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 15:56:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:56: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')]} 15:56:59 INFO - trying https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:56:59 INFO - Downloading https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/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 15:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/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 15:57:00 INFO - Downloaded 20264277 bytes. 15:57:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 15:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:04 INFO - trying https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:57:04 INFO - Downloading https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/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 15:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/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 15:57:06 INFO - Downloaded 14413719 bytes. 15:57:06 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 15:57: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')]} 15:57:06 INFO - trying https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:57:06 INFO - Downloading https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/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 15:57:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/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 15:57:10 INFO - Downloaded 55610886 bytes. 15:57:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:57:10 INFO - mkdir: /builds/slave/test/properties 15:57:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:57:10 INFO - Writing to file /builds/slave/test/properties/build_url 15:57:10 INFO - Contents: 15:57:10 INFO - build_url:https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:57:11 INFO - Running post-action listener: _resource_record_post_action 15:57:11 INFO - Running post-action listener: set_extra_try_arguments 15:57:11 INFO - [mozharness: 2016-08-12 22:57:11.716344Z] Finished download-and-extract step (success) 15:57:11 INFO - [mozharness: 2016-08-12 22:57:11.716566Z] Running populate-webroot step. 15:57:11 INFO - Running pre-action listener: _resource_record_pre_action 15:57:11 INFO - Running main action method: populate_webroot 15:57:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:57:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:57:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:57:11 INFO - '--tppagecycles', 15:57:11 INFO - '7'], 15:57:11 INFO - 'tests': ['tsvgm']}}, 15:57:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:57:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:57:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:57:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:57:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:11 INFO - 'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:57:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:57:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:11 INFO - 'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['damp', 'tps']}, 15:57:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:11 INFO - 'tests': ['damp', 'tps']}, 15:57:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['dromaeo_dom']}, 15:57:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:57:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['basic_compositor_video']}, 15:57:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:57:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['a11yr', 15:57:11 INFO - 'ts_paint', 15:57:11 INFO - 'tpaint', 15:57:11 INFO - 'sessionrestore', 15:57:11 INFO - 'sessionrestore_no_auto_restore', 15:57:11 INFO - 'tabpaint']}, 15:57:11 INFO - 'other-e10s': {'tests': ['a11yr', 15:57:11 INFO - 'ts_paint', 15:57:11 INFO - 'tpaint', 15:57:11 INFO - 'sessionrestore', 15:57:11 INFO - 'sessionrestore_no_auto_restore', 15:57:11 INFO - 'tabpaint']}, 15:57:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:57:11 INFO - 'ts_paint', 15:57:11 INFO - 'tpaint', 15:57:11 INFO - 'sessionrestore', 15:57:11 INFO - 'sessionrestore_no_auto_restore', 15:57:11 INFO - 'tabpaint']}, 15:57:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:57:11 INFO - 'ts_paint', 15:57:11 INFO - 'tpaint', 15:57:11 INFO - 'sessionrestore', 15:57:11 INFO - 'sessionrestore_no_auto_restore', 15:57:11 INFO - 'tabpaint']}, 15:57:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['a11yr', 15:57:11 INFO - 'ts_paint', 15:57:11 INFO - 'tpaint', 15:57:11 INFO - 'sessionrestore', 15:57:11 INFO - 'sessionrestore_no_auto_restore', 15:57:11 INFO - 'tabpaint']}, 15:57:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['a11yr', 15:57:11 INFO - 'ts_paint', 15:57:11 INFO - 'tpaint', 15:57:11 INFO - 'sessionrestore', 15:57:11 INFO - 'sessionrestore_no_auto_restore', 15:57:11 INFO - 'tabpaint']}, 15:57:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['tsvgx', 15:57:11 INFO - 'tsvgr_opacity', 15:57:11 INFO - 'tart', 15:57:11 INFO - 'tscrollx', 15:57:11 INFO - 'cart']}, 15:57:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:57:11 INFO - 'tsvgr_opacity', 15:57:11 INFO - 'tart', 15:57:11 INFO - 'tscrollx', 15:57:11 INFO - 'cart']}, 15:57:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:11 INFO - 'talos_options': ['--disable-e10s'], 15:57:11 INFO - 'tests': ['tp5o']}, 15:57:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:11 INFO - 'tests': ['tp5o']}, 15:57:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:11 INFO - 'talos_options': ['--disable-e10s', 15:57:11 INFO - '--xperf_path', 15:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:57:11 INFO - 'tests': ['tp5n']}, 15:57:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:11 INFO - 'talos_options': ['--xperf_path', 15:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:57:11 INFO - 'tests': ['tp5n']}}, 15:57:11 INFO - 'talos.zip': {'path': '', 15:57:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:57:11 INFO - Running post-action listener: _resource_record_post_action 15:57:11 INFO - [mozharness: 2016-08-12 22:57:11.737900Z] Finished populate-webroot step (success) 15:57:11 INFO - [mozharness: 2016-08-12 22:57:11.737988Z] Running create-virtualenv step. 15:57:11 INFO - Running pre-action listener: _resource_record_pre_action 15:57:11 INFO - Running main action method: create_virtualenv 15:57:11 INFO - Creating virtualenv /builds/slave/test/build/venv 15:57:11 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 15:57:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:57:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:57:11 INFO - Using real prefix '/usr' 15:57:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:57:12 INFO - Installing distribute.............................................................................................................................................................................................done. 15:57:14 INFO - Installing pip.................done. 15:57:14 INFO - Return code: 0 15:57:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:57:14 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')]} 15:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:14 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')]} 15:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:14 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 0x7fce1bd7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, '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': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', '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 15:57:14 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 15:57:14 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 15:57:14 INFO - Using env: {'DISPLAY': ':0', 15:57:14 INFO - 'HOME': '/home/cltbld', 15:57:14 INFO - 'LANG': 'en_US.UTF-8', 15:57:14 INFO - 'LANGUAGE': 'en_US:en', 15:57:14 INFO - 'LOGNAME': 'cltbld', 15:57:14 INFO - 'MAIL': '/var/mail/cltbld', 15:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:14 INFO - 'MOZ_NO_REMOTE': '1', 15:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:14 INFO - 'NO_EM_RESTART': '1', 15:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:14 INFO - 'PWD': '/builds/slave/test', 15:57:14 INFO - 'SHELL': '/bin/bash', 15:57:14 INFO - 'SHLVL': '1', 15:57:14 INFO - 'TERM': 'linux', 15:57:14 INFO - 'TMOUT': '86400', 15:57:14 INFO - 'USER': 'cltbld', 15:57:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:14 INFO - '_': '/tools/buildbot/bin/python'} 15:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:14 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 15:57:14 INFO - Cleaning up... 15:57:14 INFO - Return code: 0 15:57:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:57:14 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')]} 15:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:14 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')]} 15:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:14 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 0x7fce1bd7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, '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': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', '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 15:57:14 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 15:57:14 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 15:57:14 INFO - Using env: {'DISPLAY': ':0', 15:57:14 INFO - 'HOME': '/home/cltbld', 15:57:14 INFO - 'LANG': 'en_US.UTF-8', 15:57:14 INFO - 'LANGUAGE': 'en_US:en', 15:57:14 INFO - 'LOGNAME': 'cltbld', 15:57:14 INFO - 'MAIL': '/var/mail/cltbld', 15:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:14 INFO - 'MOZ_NO_REMOTE': '1', 15:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:14 INFO - 'NO_EM_RESTART': '1', 15:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:14 INFO - 'PWD': '/builds/slave/test', 15:57:14 INFO - 'SHELL': '/bin/bash', 15:57:14 INFO - 'SHLVL': '1', 15:57:14 INFO - 'TERM': 'linux', 15:57:14 INFO - 'TMOUT': '86400', 15:57:14 INFO - 'USER': 'cltbld', 15:57:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:14 INFO - '_': '/tools/buildbot/bin/python'} 15:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:14 INFO - Downloading/unpacking psutil>=3.1.1 15:57:14 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 15:57:14 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 15:57:14 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 15:57:14 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 15:57:14 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 15:57:14 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 15:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:57:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:57:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:57:16 INFO - Installing collected packages: psutil 15:57:16 INFO - Running setup.py install for psutil 15:57:16 INFO - building 'psutil._psutil_linux' extension 15:57:16 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 15:57:16 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 15:57:16 INFO - building 'psutil._psutil_posix' extension 15:57:16 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 15:57:17 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 15:57:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:57:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:57:17 INFO - Successfully installed psutil 15:57:17 INFO - Cleaning up... 15:57:17 INFO - Return code: 0 15:57:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:57:17 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')]} 15:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:17 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')]} 15:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:17 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 0x7fce1bd7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, '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': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', '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 15:57:17 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 15:57:17 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 15:57:17 INFO - Using env: {'DISPLAY': ':0', 15:57:17 INFO - 'HOME': '/home/cltbld', 15:57:17 INFO - 'LANG': 'en_US.UTF-8', 15:57:17 INFO - 'LANGUAGE': 'en_US:en', 15:57:17 INFO - 'LOGNAME': 'cltbld', 15:57:17 INFO - 'MAIL': '/var/mail/cltbld', 15:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:17 INFO - 'MOZ_NO_REMOTE': '1', 15:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:17 INFO - 'NO_EM_RESTART': '1', 15:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:17 INFO - 'PWD': '/builds/slave/test', 15:57:17 INFO - 'SHELL': '/bin/bash', 15:57:17 INFO - 'SHLVL': '1', 15:57:17 INFO - 'TERM': 'linux', 15:57:17 INFO - 'TMOUT': '86400', 15:57:17 INFO - 'USER': 'cltbld', 15:57:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:17 INFO - '_': '/tools/buildbot/bin/python'} 15:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:57:19 INFO - Installing collected packages: mozsystemmonitor 15:57:19 INFO - Running setup.py install for mozsystemmonitor 15:57:19 INFO - Successfully installed mozsystemmonitor 15:57:19 INFO - Cleaning up... 15:57:19 INFO - Return code: 0 15:57:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:57:19 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')]} 15:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:19 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')]} 15:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:19 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 0x7fce1bd7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, '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': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', '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 15:57:19 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 15:57:19 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 15:57:19 INFO - Using env: {'DISPLAY': ':0', 15:57:19 INFO - 'HOME': '/home/cltbld', 15:57:19 INFO - 'LANG': 'en_US.UTF-8', 15:57:19 INFO - 'LANGUAGE': 'en_US:en', 15:57:19 INFO - 'LOGNAME': 'cltbld', 15:57:19 INFO - 'MAIL': '/var/mail/cltbld', 15:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:19 INFO - 'MOZ_NO_REMOTE': '1', 15:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:19 INFO - 'NO_EM_RESTART': '1', 15:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:19 INFO - 'PWD': '/builds/slave/test', 15:57:19 INFO - 'SHELL': '/bin/bash', 15:57:19 INFO - 'SHLVL': '1', 15:57:19 INFO - 'TERM': 'linux', 15:57:19 INFO - 'TMOUT': '86400', 15:57:19 INFO - 'USER': 'cltbld', 15:57:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:19 INFO - '_': '/tools/buildbot/bin/python'} 15:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:19 INFO - Downloading/unpacking jsonschema==2.5.1 15:57:19 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 15:57:19 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 15:57:19 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 15:57:19 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 15:57:19 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 15:57:19 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 15:57:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:57:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:21 INFO - Downloading functools32-3.2.3-2.tar.gz 15:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:57:21 INFO - warning: no files found matching '*.txt' 15:57:21 INFO - no previously-included directories found matching 'build' 15:57:21 INFO - no previously-included directories found matching 'dist' 15:57:21 INFO - no previously-included directories found matching '.git*' 15:57:21 INFO - Installing collected packages: jsonschema, functools32 15:57:21 INFO - Running setup.py install for functools32 15:57:22 INFO - warning: no files found matching '*.txt' 15:57:22 INFO - no previously-included directories found matching 'build' 15:57:22 INFO - no previously-included directories found matching 'dist' 15:57:22 INFO - no previously-included directories found matching '.git*' 15:57:22 INFO - Successfully installed jsonschema functools32 15:57:22 INFO - Cleaning up... 15:57:22 INFO - Return code: 0 15:57:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:22 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 0x7fce1bd7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, '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': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', '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 15:57:22 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 15:57:22 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 15:57:22 INFO - Using env: {'DISPLAY': ':0', 15:57:22 INFO - 'HOME': '/home/cltbld', 15:57:22 INFO - 'LANG': 'en_US.UTF-8', 15:57:22 INFO - 'LANGUAGE': 'en_US:en', 15:57:22 INFO - 'LOGNAME': 'cltbld', 15:57:22 INFO - 'MAIL': '/var/mail/cltbld', 15:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:22 INFO - 'MOZ_NO_REMOTE': '1', 15:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:22 INFO - 'NO_EM_RESTART': '1', 15:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:22 INFO - 'PWD': '/builds/slave/test', 15:57:22 INFO - 'SHELL': '/bin/bash', 15:57:22 INFO - 'SHLVL': '1', 15:57:22 INFO - 'TERM': 'linux', 15:57:22 INFO - 'TMOUT': '86400', 15:57:22 INFO - 'USER': 'cltbld', 15:57:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:22 INFO - '_': '/tools/buildbot/bin/python'} 15:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:57:22 INFO - Cleaning up... 15:57:22 INFO - Return code: 0 15:57:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:22 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 0x7fce1bd7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, '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': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', '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 15:57:22 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 15:57:22 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 15:57:22 INFO - Using env: {'DISPLAY': ':0', 15:57:22 INFO - 'HOME': '/home/cltbld', 15:57:22 INFO - 'LANG': 'en_US.UTF-8', 15:57:22 INFO - 'LANGUAGE': 'en_US:en', 15:57:22 INFO - 'LOGNAME': 'cltbld', 15:57:22 INFO - 'MAIL': '/var/mail/cltbld', 15:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:22 INFO - 'MOZ_NO_REMOTE': '1', 15:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:22 INFO - 'NO_EM_RESTART': '1', 15:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:22 INFO - 'PWD': '/builds/slave/test', 15:57:22 INFO - 'SHELL': '/bin/bash', 15:57:22 INFO - 'SHLVL': '1', 15:57:22 INFO - 'TERM': 'linux', 15:57:22 INFO - 'TMOUT': '86400', 15:57:22 INFO - 'USER': 'cltbld', 15:57:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:22 INFO - '_': '/tools/buildbot/bin/python'} 15:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:22 INFO - Downloading/unpacking blobuploader==1.2.4 15:57:22 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 15:57:22 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 15:57:22 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 15:57:22 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 15:57:22 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 15:57:22 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 15:57:24 INFO - Downloading blobuploader-1.2.4.tar.gz 15:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:57:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:57:24 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 15:57:24 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 15:57:24 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 15:57:24 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 15:57:24 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 15:57:24 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 15:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:57:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:57:24 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 15:57:24 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 15:57:24 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 15:57:24 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 15:57:24 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 15:57:24 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 15:57:25 INFO - Downloading docopt-0.6.1.tar.gz 15:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:57:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:57:25 INFO - Running setup.py install for blobuploader 15:57:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:57:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:57:25 INFO - Running setup.py install for requests 15:57:25 INFO - Running setup.py install for docopt 15:57:25 INFO - Successfully installed blobuploader requests docopt 15:57:25 INFO - Cleaning up... 15:57:25 INFO - Return code: 0 15:57:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:25 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 0x7fce1bd7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, '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': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', '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 15:57:25 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 15:57:25 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 15:57:25 INFO - Using env: {'DISPLAY': ':0', 15:57:25 INFO - 'HOME': '/home/cltbld', 15:57:25 INFO - 'LANG': 'en_US.UTF-8', 15:57:25 INFO - 'LANGUAGE': 'en_US:en', 15:57:25 INFO - 'LOGNAME': 'cltbld', 15:57:25 INFO - 'MAIL': '/var/mail/cltbld', 15:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:25 INFO - 'MOZ_NO_REMOTE': '1', 15:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:25 INFO - 'NO_EM_RESTART': '1', 15:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:25 INFO - 'PWD': '/builds/slave/test', 15:57:25 INFO - 'SHELL': '/bin/bash', 15:57:25 INFO - 'SHLVL': '1', 15:57:25 INFO - 'TERM': 'linux', 15:57:25 INFO - 'TMOUT': '86400', 15:57:25 INFO - 'USER': 'cltbld', 15:57:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:25 INFO - '_': '/tools/buildbot/bin/python'} 15:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:57:26 INFO - Running setup.py (path:/tmp/pip-2kay3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:57:26 INFO - Running setup.py (path:/tmp/pip-nObSEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:57:26 INFO - Running setup.py (path:/tmp/pip-AwpCDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:57:26 INFO - Running setup.py (path:/tmp/pip-cCgWsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:57:26 INFO - Running setup.py (path:/tmp/pip-CPJ48Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:57:26 INFO - Running setup.py (path:/tmp/pip-RIUKoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:57:26 INFO - Running setup.py (path:/tmp/pip-XX0h8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:57:26 INFO - Running setup.py (path:/tmp/pip-AZv3kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:57:26 INFO - Running setup.py (path:/tmp/pip-Wvf7Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:57:26 INFO - Running setup.py (path:/tmp/pip-FpZ7CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:57:26 INFO - Running setup.py (path:/tmp/pip-Hxc3Bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:57:26 INFO - Running setup.py (path:/tmp/pip-h_3IbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:57:26 INFO - Running setup.py (path:/tmp/pip-HSoPbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:57:26 INFO - Running setup.py (path:/tmp/pip-P1ySNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:27 INFO - Running setup.py (path:/tmp/pip-i3zZMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:57:27 INFO - Running setup.py (path:/tmp/pip-9DUJhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:57:27 INFO - Running setup.py (path:/tmp/pip-iN8y_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:57:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:57:27 INFO - Running setup.py install for manifestparser 15:57:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:57:27 INFO - Running setup.py install for mozcrash 15:57:27 INFO - Running setup.py install for mozdebug 15:57:27 INFO - Running setup.py install for mozdevice 15:57:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:57:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:57:27 INFO - Running setup.py install for mozfile 15:57:27 INFO - Running setup.py install for mozhttpd 15:57:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:57:27 INFO - Running setup.py install for mozinfo 15:57:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:57:27 INFO - Running setup.py install for mozInstall 15:57:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:57:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:57:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:57:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:57:28 INFO - Running setup.py install for mozleak 15:57:28 INFO - Running setup.py install for mozlog 15:57:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:57:28 INFO - Running setup.py install for moznetwork 15:57:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:57:28 INFO - Running setup.py install for mozprocess 15:57:28 INFO - Running setup.py install for mozprofile 15:57:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:57:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:57:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:57:28 INFO - Running setup.py install for mozrunner 15:57:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:57:28 INFO - Running setup.py install for mozscreenshot 15:57:28 INFO - Running setup.py install for moztest 15:57:28 INFO - Running setup.py install for mozversion 15:57:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:57:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:57:29 INFO - Cleaning up... 15:57:29 INFO - Return code: 0 15:57:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:29 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 0x7fce1bd7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, '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': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', '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 15:57:29 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 15:57:29 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 15:57:29 INFO - Using env: {'DISPLAY': ':0', 15:57:29 INFO - 'HOME': '/home/cltbld', 15:57:29 INFO - 'LANG': 'en_US.UTF-8', 15:57:29 INFO - 'LANGUAGE': 'en_US:en', 15:57:29 INFO - 'LOGNAME': 'cltbld', 15:57:29 INFO - 'MAIL': '/var/mail/cltbld', 15:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:29 INFO - 'MOZ_NO_REMOTE': '1', 15:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:29 INFO - 'NO_EM_RESTART': '1', 15:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:29 INFO - 'PWD': '/builds/slave/test', 15:57:29 INFO - 'SHELL': '/bin/bash', 15:57:29 INFO - 'SHLVL': '1', 15:57:29 INFO - 'TERM': 'linux', 15:57:29 INFO - 'TMOUT': '86400', 15:57:29 INFO - 'USER': 'cltbld', 15:57:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:29 INFO - '_': '/tools/buildbot/bin/python'} 15:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:57:29 INFO - Running setup.py (path:/tmp/pip-vHTqmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:57:29 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)) 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:57:29 INFO - Running setup.py (path:/tmp/pip-WGUX00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:57:29 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)) 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:57:29 INFO - Running setup.py (path:/tmp/pip-uiabTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:57:29 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)) 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:57:29 INFO - Running setup.py (path:/tmp/pip-v9Q2Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:57:29 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)) 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:57:29 INFO - Running setup.py (path:/tmp/pip-cb6wJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:57:29 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)) 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:57:29 INFO - Running setup.py (path:/tmp/pip-Oy00N7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:57:29 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)) 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:57:29 INFO - Running setup.py (path:/tmp/pip-Pb8Q0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:57:29 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)) 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:57:29 INFO - Running setup.py (path:/tmp/pip-Xh56UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:57:29 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)) 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:57:29 INFO - Running setup.py (path:/tmp/pip-ftdD2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:57:29 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)) 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:57:29 INFO - Running setup.py (path:/tmp/pip-3oQZ3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:57:29 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)) 15:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:57:29 INFO - Running setup.py (path:/tmp/pip-W8mMH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:57:30 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)) 15:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:57:30 INFO - Running setup.py (path:/tmp/pip-WoIMNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:57:30 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)) 15:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:57:30 INFO - Running setup.py (path:/tmp/pip-15INFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:57:30 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)) 15:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:57:30 INFO - Running setup.py (path:/tmp/pip-vwiTdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:57:30 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)) 15:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:30 INFO - Running setup.py (path:/tmp/pip-L0W_Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:30 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)) 15:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:57:30 INFO - Running setup.py (path:/tmp/pip-T92PTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:57:30 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)) 15:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:57:30 INFO - Running setup.py (path:/tmp/pip-iMt5UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:57:30 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)) 15:57:30 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)) 15:57:30 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)) 15:57:30 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)) 15:57:30 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)) 15:57:30 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)) 15:57:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:57:30 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 15:57:30 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 15:57:30 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 15:57:30 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 15:57:30 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 15:57:30 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 15:57:32 INFO - Downloading blessings-1.6.tar.gz 15:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:57:32 INFO - Installing collected packages: blessings 15:57:32 INFO - Running setup.py install for blessings 15:57:32 INFO - Successfully installed blessings 15:57:32 INFO - Cleaning up... 15:57:32 INFO - Return code: 0 15:57:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:57:32 INFO - Reading from file tmpfile_stdout 15:57:32 INFO - Current package versions: 15:57:32 INFO - argparse == 1.2.1 15:57:32 INFO - blessings == 1.6 15:57:32 INFO - blobuploader == 1.2.4 15:57:32 INFO - docopt == 0.6.1 15:57:32 INFO - functools32 == 3.2.3-2 15:57:32 INFO - jsonschema == 2.5.1 15:57:32 INFO - manifestparser == 1.1 15:57:32 INFO - mozInstall == 1.12 15:57:32 INFO - mozcrash == 0.17 15:57:32 INFO - mozdebug == 0.1 15:57:32 INFO - mozdevice == 0.48 15:57:32 INFO - mozfile == 1.2 15:57:32 INFO - mozhttpd == 0.7 15:57:32 INFO - mozinfo == 0.9 15:57:32 INFO - mozleak == 0.1 15:57:32 INFO - mozlog == 3.3 15:57:32 INFO - moznetwork == 0.27 15:57:32 INFO - mozprocess == 0.23 15:57:32 INFO - mozprofile == 0.28 15:57:32 INFO - mozrunner == 6.12 15:57:32 INFO - mozscreenshot == 0.1 15:57:32 INFO - mozsystemmonitor == 0.3 15:57:32 INFO - moztest == 0.7 15:57:32 INFO - mozversion == 1.4 15:57:32 INFO - psutil == 3.1.1 15:57:32 INFO - requests == 1.2.3 15:57:32 INFO - wsgiref == 0.1.2 15:57:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:32 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 0x7fce1bd7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, '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': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', '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 15:57:32 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 15:57:32 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 15:57:32 INFO - Using env: {'DISPLAY': ':0', 15:57:32 INFO - 'HOME': '/home/cltbld', 15:57:32 INFO - 'LANG': 'en_US.UTF-8', 15:57:32 INFO - 'LANGUAGE': 'en_US:en', 15:57:32 INFO - 'LOGNAME': 'cltbld', 15:57:32 INFO - 'MAIL': '/var/mail/cltbld', 15:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:32 INFO - 'MOZ_NO_REMOTE': '1', 15:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:32 INFO - 'NO_EM_RESTART': '1', 15:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:32 INFO - 'PWD': '/builds/slave/test', 15:57:32 INFO - 'SHELL': '/bin/bash', 15:57:32 INFO - 'SHLVL': '1', 15:57:32 INFO - 'TERM': 'linux', 15:57:32 INFO - 'TMOUT': '86400', 15:57:32 INFO - 'USER': 'cltbld', 15:57:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:32 INFO - '_': '/tools/buildbot/bin/python'} 15:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:33 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)) 15:57:33 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)) 15:57:33 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)) 15:57:33 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)) 15:57:33 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)) 15:57:33 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)) 15:57:33 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)) 15:57:33 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)) 15:57:33 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)) 15:57:33 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)) 15:57:33 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)) 15:57:33 INFO - Cleaning up... 15:57:33 INFO - Return code: 0 15:57:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:57:33 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')]} 15:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:33 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')]} 15:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:33 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 0x7fce1bd7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, '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': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', '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 15:57:33 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 15:57:33 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 15:57:33 INFO - Using env: {'DISPLAY': ':0', 15:57:33 INFO - 'HOME': '/home/cltbld', 15:57:33 INFO - 'LANG': 'en_US.UTF-8', 15:57:33 INFO - 'LANGUAGE': 'en_US:en', 15:57:33 INFO - 'LOGNAME': 'cltbld', 15:57:33 INFO - 'MAIL': '/var/mail/cltbld', 15:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:33 INFO - 'MOZ_NO_REMOTE': '1', 15:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:33 INFO - 'NO_EM_RESTART': '1', 15:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:33 INFO - 'PWD': '/builds/slave/test', 15:57:33 INFO - 'SHELL': '/bin/bash', 15:57:33 INFO - 'SHLVL': '1', 15:57:33 INFO - 'TERM': 'linux', 15:57:33 INFO - 'TMOUT': '86400', 15:57:33 INFO - 'USER': 'cltbld', 15:57:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:33 INFO - '_': '/tools/buildbot/bin/python'} 15:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:57:33 INFO - Cleaning up... 15:57:33 INFO - Return code: 0 15:57:33 INFO - Running post-action listener: _resource_record_post_action 15:57:33 INFO - Running post-action listener: _start_resource_monitoring 15:57:33 INFO - Starting resource monitoring. 15:57:33 INFO - [mozharness: 2016-08-12 22:57:33.357928Z] Finished create-virtualenv step (success) 15:57:33 INFO - [mozharness: 2016-08-12 22:57:33.358394Z] Running install step. 15:57:33 INFO - Running pre-action listener: _resource_record_pre_action 15:57:33 INFO - Running main action method: install 15:57:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:57:33 INFO - Reading from file tmpfile_stdout 15:57:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:57:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:57:33 INFO - Reading from file tmpfile_stdout 15:57:33 INFO - Output received: 15:57:33 INFO - Usage: mozinstall [options] installer 15:57:33 INFO - Options: 15:57:33 INFO - -h, --help show this help message and exit 15:57:33 INFO - -d DEST, --destination=DEST 15:57:33 INFO - Directory to install application into. [default: 15:57:33 INFO - "/builds/slave/test"] 15:57:33 INFO - --app=APP Application being installed. [default: firefox] 15:57:33 INFO - mkdir: /builds/slave/test/build/application 15:57:33 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'] 15:57:33 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 15:57:49 INFO - Reading from file tmpfile_stdout 15:57:49 INFO - Output received: 15:57:49 INFO - /builds/slave/test/build/application/firefox/firefox 15:57:49 INFO - Running post-action listener: _resource_record_post_action 15:57:49 INFO - [mozharness: 2016-08-12 22:57:49.693588Z] Finished install step (success) 15:57:49 INFO - [mozharness: 2016-08-12 22:57:49.693833Z] Running run-tests step. 15:57:49 INFO - Running pre-action listener: _resource_record_pre_action 15:57:49 INFO - Running main action method: run_tests 15:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:57:49 INFO - Python 2.7.3 15:57:49 INFO - Return code: 0 15:57:49 INFO - grabbing minidump binary from tooltool 15:57:49 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')]} 15:57:49 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 0x2265d20>, '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 0x2266c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22670b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:57:49 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 15:57:49 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 15:57:49 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 15:57:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:57:49 INFO - Return code: 0 15:57:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:57:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:57:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:57:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:57:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 15:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 15:57:49 INFO - Using env: {'DISPLAY': ':0', 15:57:49 INFO - 'HOME': '/home/cltbld', 15:57:49 INFO - 'LANG': 'en_US.UTF-8', 15:57:49 INFO - 'LANGUAGE': 'en_US:en', 15:57:49 INFO - 'LOGNAME': 'cltbld', 15:57:49 INFO - 'MAIL': '/var/mail/cltbld', 15:57:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:57:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:49 INFO - 'MOZ_NO_REMOTE': '1', 15:57:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:49 INFO - 'NO_EM_RESTART': '1', 15:57:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:49 INFO - 'PWD': '/builds/slave/test', 15:57:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:57:49 INFO - 'SHELL': '/bin/bash', 15:57:49 INFO - 'SHLVL': '1', 15:57:49 INFO - 'TERM': 'linux', 15:57:49 INFO - 'TMOUT': '86400', 15:57:49 INFO - 'USER': 'cltbld', 15:57:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869', 15:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:49 INFO - '_': '/tools/buildbot/bin/python'} 15:57:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 15:57:49 INFO - mozversion application_buildid: 20160812143816 15:57:49 INFO - mozversion application_changeset: 2ed7e61b988d2466a61528f66050596ef272ebda 15:57:49 INFO - mozversion application_display_name: Nightly 15:57:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:57:49 INFO - mozversion application_name: Firefox 15:57:49 INFO - mozversion application_remotingname: firefox 15:57:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:57:49 INFO - mozversion application_vendor: Mozilla 15:57:49 INFO - mozversion application_version: 51.0a1 15:57:49 INFO - mozversion platform_buildid: 20160812143816 15:57:49 INFO - mozversion platform_changeset: 2ed7e61b988d2466a61528f66050596ef272ebda 15:57:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:57:49 INFO - mozversion platform_version: 51.0a1 15:57:49 INFO - using testdate: 1471042669 15:57:49 INFO - actual date: 1471042669 15:57:49 INFO - starting webserver on 'localhost:56378' 15:57:49 INFO - SUITE-START | Running 2 tests 15:57:49 INFO - TEST-START | dromaeo_css 15:57:49 INFO - operating with platform_type : linux_ 15:57:49 INFO - Initialising browser for dromaeo_css test... 15:57:49 INFO - TEST-INFO | started process 30764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0js7D0/profile http://localhost:56378/getInfo.html) 15:57:54 INFO - PROCESS | 30764 | __metrics Screen width/height:1600/1200 15:57:54 INFO - PROCESS | 30764 | colorDepth:24 15:57:54 INFO - PROCESS | 30764 | Browser inner width/height: 1024/697 15:57:54 INFO - PROCESS | 30764 | __metrics 15:57:55 INFO - PROCESS | 30764 | 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" 15:57:55 INFO - PROCESS | 30764 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:57:56 INFO - TEST-INFO | 30764: exit 0 15:57:56 INFO - Browser initialized. 15:57:56 INFO - Running cycle 1/1 for dromaeo_css test... 15:57:56 INFO - TEST-INFO | started process 30842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0js7D0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:58:07 INFO - PROCESS | 30842 | RSS: Main: 157175808 15:58:07 INFO - PROCESS | 30842 | 15:58:59 INFO - PROCESS | 30842 | 1471042739273 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:01:12 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:56378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56378/tests/dromaeo/cssquery-ext.html) 16:01:13 INFO - PROCESS | 30842 | RSS: Main: 263458816 16:01:13 INFO - PROCESS | 30842 | 16:04:16 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:56378/tests/dromaeo/cssquery-ext.html (next: http://localhost:56378/tests/dromaeo/cssquery-jquery.html) 16:04:16 INFO - PROCESS | 30842 | RSS: Main: 248737792 16:04:16 INFO - PROCESS | 30842 | 16:07:19 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:56378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56378/tests/dromaeo/cssquery-mootools.html) 16:07:19 INFO - PROCESS | 30842 | RSS: Main: 230801408 16:07:19 INFO - PROCESS | 30842 | 16:10:21 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:56378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56378/tests/dromaeo/cssquery-prototype.html) 16:10:22 INFO - PROCESS | 30842 | RSS: Main: 190906368 16:10:22 INFO - PROCESS | 30842 | 16:13:25 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:56378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56378/tests/dromaeo/cssquery-yui.html) 16:13:26 INFO - PROCESS | 30842 | RSS: Main: 189132800 16:13:26 INFO - PROCESS | 30842 | 16:16:29 INFO - PROCESS | 30842 | Cycle 1(1): loaded http://localhost:56378/tests/dromaeo/cssquery-yui.html (next: http://localhost:56378/tests/dromaeo/cssquery-dojo.html) 16:16:29 INFO - PROCESS | 30842 | RSS: Main: 268468224 16:16:29 INFO - PROCESS | 30842 | 16:16:29 INFO - PROCESS | 30842 | __start_tp_report 16:16:29 INFO - PROCESS | 30842 | _x_x_mozilla_page_load 16:16:29 INFO - PROCESS | 30842 | _x_x_mozilla_page_load_details 16:16:29 INFO - PROCESS | 30842 | |i|pagename|runs| 16:16:29 INFO - PROCESS | 30842 | |0;dojo.html;2633.525965326241;2643.629891815145;2669.6395986541816;2682.1685277563956;2685.4494828560137;4636.350910872472;4702.459217190024;4798.928016079757;4831.492693267204;4834.903301933964;4729.716217026981;4762.833300834472;4763;4806.231003039515;4837.346958160647;4363.825446982117;4367.606915377615;4435.756033418161;4482.282834746441;4563.49801521834;4467.084247729208;4510.797014134356;4531.184386810372;4540.364348991144;4552.203364411232;4288.485381754178;4327.7186982846015;4366.432363792718;4380.693351465398;4437.689361744679;4343.283358245885;4346.9347959780625;4369.104333611602;4448.822047118111;4456.799444025027;4383.890402739925;4384.802683879233;4389.539098394686;4397.516273209944;4442.044960333544;4699.0836786826585;4745.572898439157;4772.73749943753;4782.952170478286;4810.542998415145;5131.102057139986;5184.948150518484;5196.272521846944;5197.22041693749;5206;5217.217417387385;5220.895582088337;5263.44733802949;5267.789288428458;5273.314469119028;4560.429946256718;4681.695689780154;4760.785764640599;4795.448523419782;4877.756112194376;5248.816291429782;5278.841634750964;5314.362276526842;5323.148296272578;5337.973310133424;5052.9747351263;5058.114829904752;5080.085584594734;5099.184130539096;5110.054639891632;4993;5015.774290156952;5063.8987220255385;5079.923801142986;5160.509751573594;5144.43411224765;5148.433672296044;5149.562287205555;5149.871253218699;5178.326817513699;5143.742812859342;5154;5154.716490593053;5155.200943853709;5204.609654275944;4261.275583150872;4277.550857160016;4284.3359279311135;4334.523202447728;4430.867073987721;3787.507624008861;3820.8662696805477;3822.9044273893373;3825.254075455315;3827.1771569112775;4363.432753741993;4365.323374876899;4370.912581748411;4371.519132895379;4376.693631445832;5043.87390315245;5075.619328550373;5138.511841375063;5152.458991805806;5230.215467679803;4404.823807047746;4406.955930440655;4418.226810308248;4424.46906371231;4450.488193857748;4608.147492713859;4615.26155815068;4623.260278355447;4638.5593368629925;4654.883627909329;4716.976415117902;4802.6638135330195;4831.033793241436;4846.055019271208;4918.778654960463;5182.1190397631735;5191.636585439134;5194.168932970707;5197.532222100029;5199.896002079861;4860.6111511079735;4865.56209941107;4866.284313383539;4866.756662166948;4891.633127515522;4941.604671626334;5057.74711264428;5070.340855688737;5091.261767043832;5164.638475306692;5187.4553171916405;5192.3769147702515;5199.012187684328;5199.428062913152;5206.661566998133;5045.672031317952;5051.191809310492;5053.7220452875445;5057.519535644108;5090.847274581768;4922;4974.0797952378925;5003.574696150868;5021.5229553192385;5081.00920320534;4938.728369939688;4940.135476291706;4978.950210497994;4983.4518202996915;4990.850274491771;5020.874478138076;5031.974840125776;5033.169527028;5040.722760248222;5103.872403189802;4821.855344339676;4829.806807727651;4858.392700912386;4875.488073752205;4926.458089610212 16:16:29 INFO - PROCESS | 30842 | |1;ext.html;543.6058857328437;574.57768540123;579.9739011744471;584.0246787864266;587.3480436715246;27808.582871256924;28314.292142696417;37505.43741843875;38945.41581876274;39314.41028384576;38364.42453363195;38803.61196388035;38804;38868.41697374535;38889;7500.099988001448;7641.4268929830205;7649.311561959423;7650.61746912655;7650.961745191266;7619.695212191506;7682.347000504964;7706.422018348646;7709.074911010659;7717.72987945422;7691.500052496598;7730.652120654584;7734.806629834271;7737.961310193441;7739.380849532052;7660.348870346027;7694.461387702863;7698.384129269645;7700;7700.4224683148705;7627.084749830056;7637.961810190969;7693.038370203724;7697.076350837935;7697.884531732028;37051.073723156864;37051.44422833659;37302;37562.62437375619;37569.436458452874;2864.3268831824503;2909.301767575788;2931.589577459157;2937.1922721251613;2986.2982199183175;27735;28060.85969570139;28266.858665706746;28326.29184270389;28871.133865984055;3389.440742277521;3482.860685572574;3497.4753786932165;3513.086597484647;3562.287542491512;257503;258405.9999999981;259454;259482;259485;49084.26373604399;49371.25943110856;49407;49451.258231126565;49496;31486.527702084488;32732;32754.181145471077;34682.30635387278;52154;13629.045966782429;13763.38064787087;13766.862331376558;13766.93116534411;13782.65543361424;10392.168626510012;10491.94754026225;10514.842277365846;10516.106130978953;10521.263511554118;17358.91320543389;17516.21177047036;17603.647927041387;17618.647627047387;17697.29210831578;6510.641914694643;6568.376004279586;6638.369354911276;6735.663216839236;6779.288174741581;808.4138999225514;873.4890089297832;903.8056817784208;940.6096469964888;977.506359288569;26989.86505067462;27746.306342341602;27788.58317125245;27924.86037569799;28366.71633283682;898.5552151684958;930.8929473110679;954.3653470442217;960.2414092866696;1029.6087486755134;13832.239226842621;14148.646283842987;14277.357518911465;14398.280085995659;14516.564503064925;409832;411306;413680;413758;414142;45833.541664582925;46326.07347853092;46357.30464043042;46385;46389;1081.561967403203;1128.966131016071;1181.8109102543551;1198.9940050299692;1211.2792888231488;24820.627690585017;27849.582256265767;27890.72109278881;28287.717122828508;28560.857935655324;40011.59988400195;44911.55088449074;46396.53603463922;46526.30210546912;50355;375634;376089;376259;376512;379302;30965.088380746492;31431.842840785648;37756.43365349467;37853;38505;29082.418351632426;37150;38186.236275274896;38206.23587528178;38364;33318.83340583282;33538.49692254667;33581.664183357854;33623.4956475658;34103;32848.50727239045;33493.16267093342;33573.496397553565;33919.83040084784;34226.48660270048;30064.54903176498;33272;33386.833065834515;34855.47716784301;36009.279814404086;30037.5494367589;32151;32849.34301314008;33080.50379244265;33401.832990835865;24980.125695600567;25102.748972510042;25297.367565811;25368;25633.61549576795 16:16:29 INFO - PROCESS | 30842 | |2;jquery.html;347.1927767939538;359.1864427072681;372.888133559932;375.4237245827655;385.3391433691221;13149.605511834648;16231.431899883506;16616.335346586136;17813.37653182139;18027.098645067726;17275.568110797205;17536.473905782816;17924.731129033076;18082.909585452086;18101.90949045253;4770.189067858464;5141;5152.046871328816;5177.30106435632;5178.844634660947;3724.5716742574546;5074.213496907985;5151.948480515203;5153;5778.8266352009505;6027.487663548582;6110.541709371792;6124.448799608034;6137.171481849938;6138.693065346737;5888.057910734284;6020.5785595008365;6025.819225423201;6070.453659170652;6138.631682099066;5347.2781174541715;5348.598855085846;5352.652077614982;5355.393381985389;5362.624616276862;20770;21175.5764884703;21545.1381944722;21757.347279581638;21892.89053554722;1780.7061834797244;1916.9904150479297;1979.7525309336334;1982.2863769043277;2041.030510507512;5260.237265596467;5287.206918962148;5342.652727572696;5527.778888844441;9243.149952501068;1687.7468379743013;1697.499237724874;1731.2209505722476;1766.7791526059243;1780.6616742818824;69333.3066669337;73423.26576734218;74477.6276118616;76372.23627763707;77057.22942770556;9803.803923921625;9956.352837065568;10060.547275372626;10263.127634151031;10378.584856605652;13634.181949083088;13639.181649101085;13660.565640607792;13671.453141874412;13692.110012849133;7002.859942801116;7126.109236345457;7226.963865180641;7306.890396644055;7316.524425912298;6710.865782684319;6732.225794033749;6906.274841141708;6914.239433662293;6915.308469153045;4193.32906734927;4219.746815191098;4298.446092276347;4379.912401751947;4389.978050109793;1730.3165249726287;1788.2757483219316;1788.7853457585172;1793.0944872839132;1800.1359347513267;787.696736756353;792.1088775127981;794.6503538443067;803.269025187077;827.3463963468793;16646.417375392044;17550.912245438947;17568.38510652121;18006;18009.7298540522;832.1387364078271;834.040853019033;840.206005324962;852.7868032991752;869.3436455476201;9152.633894644272;9968.950155249177;10052.69841904744;10065.496725163712;10120.645777397756;385928;386126;388986;396576;399321;54457.45542544603;72630.63684681543;73333.26666733371;79166.6041669788;79359.60320198478;874.7157173918501;910.2081189365163;924.0343840686498;939.4551160326994;942.3544871762864;11312.886871131512;15698.136602486973;15819.604509887346;16620.750688739437;16839.326426942785;38224.80887595656;38738.80630596829;38960.22079558449;40437.59562404338;40909.590904090575;49358.75320623374;49654.75172624258;52035;52183;52431;6587.769428070186;6842.657867106725;7177.282271772781;7293.4894557382595;7892.1318654949055;11958.64124076279;11995;12289.69275768113;12461.314627695563;12562.497500099893;10517.474966130021;10588.205884558534;10672.413017284123;10811.13510919109;11065;10243.692689219335;10418.270721049454;10427.582896684047;10446.843297350697;10481.842772358574;9903.356281841945;10512.94743526308;10605.204609654153;10763.408012559385;11238.044766194638;7257.371388826872;7272.636368181676;7324.230955749569;7354;7593.8860917085185;9263.76840578964;10593.947030264799;10690.679279621623;10793.514291856729;11255.831162532404 16:16:29 INFO - PROCESS | 30842 | |3;mootools.html;1360.748261571609;1407.2611878763648;1455.1632811133595;1611.975820362694;1656.2960741684788;7445.292697193771;8009.839803203932;8021.197880211976;8021.639026243818;8035.075966263881;6831.111955445797;7524.661390237453;7678.155402905676;7690.461667683265;7984.600769961493;2167.0573300614205;2183.858049226795;2186.35502526755;2190.1567896359857;2205.106931692659;2172.771858954811;2194.3855720398315;2247.438140464884;2251.313349428424;2252.0203711385516;2086.332373640436;2100.28590279305;2183.9235626753066;2195.1877805212093;2202.174184680745;2125.181805005069;2125.5005073807642;2125.9574808503744;2129.659254519277;2131.4458240857334;2083.781202973681;2145.270607993274;2147.2699282243957;2149.881756503392;2150.387139665188;7890.408219383569;7937.563434011185;8037.517748935083;8048.436609437342;8056.395770317191;4568.086382723435;4688.624910007191;4698.4361876574685;4700.106979673885;4711.952880471185;2789.846558439285;2871.4687782760257;2937.1188643407104;2938.1038783171125;2944.6024786653743;880.903100658927;899.2850683706404;923.8798956135727;927.9211267042309;939.178219058324;10886.23796334257;10899.29154604956;10939.671809845717;11015.504302306415;11117.388543630097;4021.3967904813926;4209.684273679486;4259.318509038539;4389.231884420214;4393.51671316155;9191.954040229755;9201.953990230006;9207.723768286962;9211.355205135576;9215.63137474507;4647.233206520887;4649.442066951988;4652.837150699709;4655.255159174516;4663.48701642819;3609.097725568608;4160.521540022875;4189.811458484375;4208.473940757405;4262.041040765865;3544.3620148373025;3545.290941811648;3656.561212654445;3702.0929872181487;3706.5366829146355;1087.0108201536564;1116.5366372955132;1132.7338075552238;1222.4254600337827;1233.0751936047964;677.6239187251024;780.9765707028798;789.2462698123278;818.7543736878913;833.4540875726409;4937.136001199848;5018.723970181675;5110.616703747234;5197.350331208599;5265.76304066318;408.78334482724205;418.23045596103316;422.204145186326;425.168795005763;427.3504273504318;3557.5197348358156;3574.4459608760685;3581.4985901973746;3588.69496092835;3648.3068217038676;9478.668246611473;9887.258455615858;9913.256505762096;9960.601575936882;9962.850557241647;9875.75310617226;9916.256280778825;9921.355111917703;9923.851142232872;9929.900700993043;7055;7379.557226566423;7486.887696684554;7490.250974902466;7504.962475187589;4793;4824.6863953842885;4830.516948305141;4860.3681521401995;4867.367242258484;8710.869336959824;8801.031886492608;8825.514596697243;8852.867206991772;8889.955550222208;9051.004389517017;9284.72145835626;9290.767730806783;9292.16370526656;9306.953465232631;6046.153538504701;6688.297728738413;6869.553479023847;6980.476464265099;6989.5107342485535;7322.890156647761;7653.387728981556;7667.11828139771;7674.270944260286;7679.040119985002;6641.900371494335;6695.230048544479;6715.966420167868;6896.448284137156;6928.237893831573;6481.157449531531;6697.0958920547055;6742.73029078851;6817.113775209191;6856.24581296067;6260.217472815898;6355.682215889095;6372.299047104722;6377;6378.075179099097;4538.863834084983;4586.931196031996;4653.139169253699;4660.300954856799;4706.835260765857;4370.7159034662645;4434.977825110854;4525.683202175947;4611.815527378867;4689.038747056913 16:16:29 INFO - PROCESS | 30842 | |4;prototype.html;303.2146739943546;307.14919672507153;312.2132226788492;313.29196017001567;314.95118256670196;4838.637102217334;4859.659823812334;4863.635227357945;4881.316615673809;4885.802978270329;4837.201861692825;4838.104950584145;4843.854684359466;4846.975765121169;4852.927206091903;3633.618470060645;3744.588095309514;3787.753796003251;3853.942190867125;3895.162540053888;3852.0739630184908;3870.5872356589784;3874.7093967952515;3891.7351860645404;3906.941395879064;3816.1413681921485;3821.4840996465537;3830.00419890829;3835.884923452287;3837.616238376168;3651;3697.482352470656;3824.560175579816;3828.7319887607878;3831.7126215533945;3391.6099648540485;3393.745469089828;3404.438267685829;3405.182756138509;3427.5715535558056;4689.765511724434;4705.3647757552635;4706.482286948433;4724.622030237572;4737.763111844429;4189.329707246857;4356.738595684269;4372.344148377737;4377.321515165155;4378.846740364103;5058.58359659296;5064.518870707277;5067.290579318898;5079.288899554065;5084.593232541388;3722.292764374787;3725.236326553077;3729.738918275722;3731.1045349116016;3747.2130852521004;5045.873853153664;5295.761690723926;5298.602604804655;5326.946730532683;5337.439568845293;3645.325614761278;3681.263747250507;3685.3734865072465;3686.705063594906;3688.1517251032415;3729;3743.494628225155;3750.774953502744;3754;3770.3967365221433;4308;4315.913681726348;4316.935245971313;4320.373545835836;4325.286327755948;4972.801087956441;5092.872633923906;5093.592512598983;5147.841735609458;5173.430922598511;1261.6752409969495;1274.668586167603;1275.2284867655121;1275.8277632519678;1280.6734282757836;793.714262865368;823.7281697039963;835.1398059998212;845.6913226672343;847.4406891451736;4336.371226172188;4405.207062728676;4435.911281774346;4444.511103778582;4450.421445212167;5155.149400348975;5271.736413179402;5293.973530132324;5303.178007408857;5306.469353064663;4501.099780044005;4520.751358675305;4523.864284071483;4529.6376289896725;4539.795709193094;2663.9733602663723;2781.582762585628;2786.7909906757072;2802.6356573645703;2828.363618185933;4913.238448040559;4920.852374428773;4921.827736029221;4931.87670308238;4936.456989731127;5101.770420331094;5329.280547126166;5344.091504444254;5363.839084827461;5381.354237491526;4936.160852655057;4947.208446648519;4952.702837829742;4953.43035550909;4960.652754307236;5212.817551385683;5229.921551176812;5247.66184622934;5250.133727934848;5278.5513231374225;4970.204767237225;5114.923276150935;5115.283860259641;5132.255822905583;5155.819546315861;4877.463479017234;4901.264810278487;4903.6077113831525;4913.975430122827;4915.746484646393;3762.680172185395;3774.1885494618787;3784.3188226119564;3784.6593806557544;3803.5816060233906;4928.260760885896;5175.844724658266;5182.53357197854;5185;5214.478552144755;4981.701097934136;5029.874253143701;5045.470225626256;5060.367454068241;5062.114130027304;5049.545540901337;5055.320680039585;5074.949250507448;5105.927755171456;5108.438071812172;4739.597134243628;4893.825481884393;4935.728534930613;4994.4755800640405;5024.246363045426;4926.605871530341;4955.1012657594265;5109.339464673922;5166.844994650167;5193.324867767166;5047.268146118866;5067.847964561069;5071.438923343688;5073.518015788494;5083.983203359417 16:16:29 INFO - PROCESS | 30842 | |5;yui.html;595.3778301674749;625.0748891640375;626;634.6002018728201;644.8742495213435;12069.155159138852;14524.636884077903;15263.084214947097;15345.92327038366;15984.200789960485;15265.771013434807;15498.380064797422;15511;15520.53438396847;15530.611734706637;639.2552676132324;757.685560492395;770.9961450192741;794.9085855126648;797.7686470923426;782.4327362662082;791.2087912087912;796.2952786783709;796.7251298302076;796.8924195233657;833.0336809301211;834.8914641096649;839.3914412051275;839.496302218667;839.7312859884839;654.6235914349268;673.3670349871105;827.5737994932615;827.5903427803246;827.8344331133737;499.0268975497794;500.32955839175315;577.1112486770369;591.5504216795224;595.5711887441079;12810.871891281155;12825.551105711254;12842.87157128426;12856.742865142738;12860.421281042281;12090.455929483107;12165.695857603541;12609.621711348675;12831.230126192459;13275.203925725666;11080.279781814157;11212.495437705242;11217.607383741612;11293.661190164226;11602.709932251677;4021.1153546219784;4029.6171863672903;4064.349704047338;4219;4284.871453856358;65999.34000660028;66746.03765161127;67736.32263677349;68886.311136889;69510.65244673795;10403.791924161626;10512.264141510173;10548.736281592868;10561.260711750258;10761.946190268998;18599.44201673952;18700.532486687942;18741.81258187428;18752.718709219374;18816.247350106118;6374.330695277022;6449.355064493513;6475.740970361227;6493.253275873335;6851.07510486088;3582.0686621478603;3662.230931504361;3662.377395842713;3691.2617476504806;3733.1227161617;2906.3896581718077;3060.1125673554866;3067.3251884585356;3067.969320306813;3068.248279171617;515.0291700145253;516.0865268474854;523.0872128136426;530.2867643020131;532.7469452010264;530.7553786370954;537.7257598624651;542.4765101676821;543.7824870051932;555.6804837218615;8160.551169685606;8263.752087437386;8353.37349698775;8598.578837710034;8716;537.231758585219;548.6927320700421;550.6833570696865;561.4497792163702;573.3521121133093;3637.5816781070516;3813.961860381416;3890.591487893787;3949.664278536299;3952.703547233969;56693;68406.97389539161;95270;110132;110249.44875275572;91472;91894;93113.53443232876;94062.5296873525;94549;44610.33084503735;72196.63901680458;78299.60850195713;82691.5865420669;84572.57713711393;7326.633668316456;7533.1336896257635;7588.468807183444;7643.159252482112;7828.256315650005;47082.52917470918;47873;48733.26900096572;49976.75011624918;51174.74412627913;62232.68883655553;66223.33776662365;66933.33066669271;67578;70337.29662703308;9762.707118786448;9850.408975461496;10065.84901226497;10247.897521024992;10292.948535257276;10006.69979900604;10378.792424151323;11033.724156896142;11292.774144517229;11809.645710628694;9545;9592.568334425107;9617.807643846943;9670.371425857296;9735.026497350209;10059.497025148567;10107.69676909694;10188.083072523508;10387.220958427997;10394.948025259826;9889.159421449258;9932.205423565953;10049.447280399649;10343.896561034293;10749.516271767945;8831.779205519657;9143.13140251675;9349.719508414759;9428.481433521221;9440.527973601154;8766.693165739169;9384.343095983215;9389;9414.576344064397;9436.127744510977 16:16:29 INFO - PROCESS | 30842 | __end_tp_report 16:16:29 INFO - PROCESS | 30842 | __start_cc_report 16:16:29 INFO - PROCESS | 30842 | _x_x_mozilla_cycle_collect,1054 16:16:29 INFO - PROCESS | 30842 | __end_cc_report 16:16:29 INFO - PROCESS | 30842 | __startTimestamp1471043789297__endTimestamp 16:16:29 INFO - PROCESS | 30842 | 16:16:29 INFO - PROCESS | 30842 | ------- Summary: start ------- 16:16:29 INFO - PROCESS | 30842 | Number of tests: 6 16:16:29 INFO - PROCESS | 30842 | 16:16:29 INFO - PROCESS | 30842 | [#0] dojo.html Cycles:165 Average:4750.70 Median:4865.56 stddev:510.27 (10.5%) stddev-sans-first:484.05 16:16:29 INFO - PROCESS | 30842 | Values: 2633.5 2643.6 2669.6 2682.2 2685.4 4636.4 4702.5 4798.9 4831.5 4834.9 4729.7 4762.8 4763.0 4806.2 4837.3 4363.8 4367.6 4435.8 4482.3 4563.5 4467.1 4510.8 4531.2 4540.4 4552.2 4288.5 4327.7 4366.4 4380.7 4437.7 4343.3 4346.9 4369.1 4448.8 4456.8 4383.9 4384.8 4389.5 4397.5 4442.0 4699.1 4745.6 4772.7 4783.0 4810.5 5131.1 5184.9 5196.3 5197.2 5206.0 5217.2 5220.9 5263.4 5267.8 5273.3 4560.4 4681.7 4760.8 4795.4 4877.8 5248.8 5278.8 5314.4 5323.1 5338.0 5053.0 5058.1 5080.1 5099.2 5110.1 4993.0 5015.8 5063.9 5079.9 5160.5 5144.4 5148.4 5149.6 5149.9 5178.3 5143.7 5154.0 5154.7 5155.2 5204.6 4261.3 4277.6 4284.3 4334.5 4430.9 3787.5 3820.9 3822.9 3825.3 3827.2 4363.4 4365.3 4370.9 4371.5 4376.7 5043.9 5075.6 5138.5 5152.5 5230.2 4404.8 4407.0 4418.2 4424.5 4450.5 4608.1 4615.3 4623.3 4638.6 4654.9 4717.0 4802.7 4831.0 4846.1 4918.8 5182.1 5191.6 5194.2 5197.5 5199.9 4860.6 4865.6 4866.3 4866.8 4891.6 4941.6 5057.7 5070.3 5091.3 5164.6 5187.5 5192.4 5199.0 5199.4 5206.7 5045.7 5051.2 5053.7 5057.5 5090.8 4922.0 4974.1 5003.6 5021.5 5081.0 4938.7 4940.1 4979.0 4983.5 4990.9 5020.9 5032.0 5033.2 5040.7 5103.9 4821.9 4829.8 4858.4 4875.5 4926.5 16:16:29 INFO - PROCESS | 30842 | 16:16:29 INFO - PROCESS | 30842 | [#1] ext.html Cycles:180 Average:48917.50 Median:37051.26 stddev:94002.91 (253.7%) stddev-sans-first:94196.45 16:16:29 INFO - PROCESS | 30842 | Values: 543.6 574.6 580.0 584.0 587.3 27808.6 28314.3 37505.4 38945.4 39314.4 38364.4 38803.6 38804.0 38868.4 38889.0 7500.1 7641.4 7649.3 7650.6 7651.0 7619.7 7682.3 7706.4 7709.1 7717.7 7691.5 7730.7 7734.8 7738.0 7739.4 7660.3 7694.5 7698.4 7700.0 7700.4 7627.1 7638.0 7693.0 7697.1 7697.9 37051.1 37051.4 37302.0 37562.6 37569.4 2864.3 2909.3 2931.6 2937.2 2986.3 27735.0 28060.9 28266.9 28326.3 28871.1 3389.4 3482.9 3497.5 3513.1 3562.3 257503.0 258406.0 259454.0 259482.0 259485.0 49084.3 49371.3 49407.0 49451.3 49496.0 31486.5 32732.0 32754.2 34682.3 52154.0 13629.0 13763.4 13766.9 13766.9 13782.7 10392.2 10491.9 10514.8 10516.1 10521.3 17358.9 17516.2 17603.6 17618.6 17697.3 6510.6 6568.4 6638.4 6735.7 6779.3 808.4 873.5 903.8 940.6 977.5 26989.9 27746.3 27788.6 27924.9 28366.7 898.6 930.9 954.4 960.2 1029.6 13832.2 14148.6 14277.4 14398.3 14516.6 409832.0 411306.0 413680.0 413758.0 414142.0 45833.5 46326.1 46357.3 46385.0 46389.0 1081.6 1129.0 1181.8 1199.0 1211.3 24820.6 27849.6 27890.7 28287.7 28560.9 40011.6 44911.6 46396.5 46526.3 50355.0 375634.0 376089.0 376259.0 376512.0 379302.0 30965.1 31431.8 37756.4 37853.0 38505.0 29082.4 37150.0 38186.2 38206.2 38364.0 33318.8 33538.5 33581.7 33623.5 34103.0 32848.5 33493.2 33573.5 33919.8 34226.5 30064.5 33272.0 33386.8 34855.5 36009.3 30037.5 32151.0 32849.3 33080.5 33401.8 24980.1 25102.7 25297.4 25368.0 25633.6 16:16:29 INFO - PROCESS | 30842 | 16:16:29 INFO - PROCESS | 30842 | [#2] jquery.html Cycles:180 Average:24426.17 Median:4206.54 stddev:64654.98 (1537.0%) stddev-sans-first:64811.07 16:16:29 INFO - PROCESS | 30842 | Values: 347.2 359.2 372.9 375.4 385.3 13149.6 16231.4 16616.3 17813.4 18027.1 17275.6 17536.5 17924.7 18082.9 18101.9 4770.2 5141.0 5152.0 5177.3 5178.8 3724.6 5074.2 5151.9 5153.0 5778.8 6027.5 6110.5 6124.4 6137.2 6138.7 5888.1 6020.6 6025.8 6070.5 6138.6 5347.3 5348.6 5352.7 5355.4 5362.6 20770.0 21175.6 21545.1 21757.3 21892.9 1780.7 1917.0 1979.8 1982.3 2041.0 5260.2 5287.2 5342.7 5527.8 9243.1 1687.7 1697.5 1731.2 1766.8 1780.7 69333.3 73423.3 74477.6 76372.2 77057.2 9803.8 9956.4 10060.5 10263.1 10378.6 13634.2 13639.2 13660.6 13671.5 13692.1 7002.9 7126.1 7227.0 7306.9 7316.5 6710.9 6732.2 6906.3 6914.2 6915.3 4193.3 4219.7 4298.4 4379.9 4390.0 1730.3 1788.3 1788.8 1793.1 1800.1 787.7 792.1 794.7 803.3 827.3 16646.4 17550.9 17568.4 18006.0 18009.7 832.1 834.0 840.2 852.8 869.3 9152.6 9969.0 10052.7 10065.5 10120.6 385928.0 386126.0 388986.0 396576.0 399321.0 54457.5 72630.6 73333.3 79166.6 79359.6 874.7 910.2 924.0 939.5 942.4 11312.9 15698.1 15819.6 16620.8 16839.3 38224.8 38738.8 38960.2 40437.6 40909.6 49358.8 49654.8 52035.0 52183.0 52431.0 6587.8 6842.7 7177.3 7293.5 7892.1 11958.6 11995.0 12289.7 12461.3 12562.5 10517.5 10588.2 10672.4 10811.1 11065.0 10243.7 10418.3 10427.6 10446.8 10481.8 9903.4 10512.9 10605.2 10763.4 11238.0 7257.4 7272.6 7324.2 7354.0 7593.9 9263.8 10593.9 10690.7 10793.5 11255.8 16:16:29 INFO - PROCESS | 30842 | 16:16:29 INFO - PROCESS | 30842 | [#3] mootools.html Cycles:180 Average:5151.53 Median:4808.84 stddev:2958.98 (61.5%) stddev-sans-first:2953.57 16:16:29 INFO - PROCESS | 30842 | Values: 1360.7 1407.3 1455.2 1612.0 1656.3 7445.3 8009.8 8021.2 8021.6 8035.1 6831.1 7524.7 7678.2 7690.5 7984.6 2167.1 2183.9 2186.4 2190.2 2205.1 2172.8 2194.4 2247.4 2251.3 2252.0 2086.3 2100.3 2183.9 2195.2 2202.2 2125.2 2125.5 2126.0 2129.7 2131.4 2083.8 2145.3 2147.3 2149.9 2150.4 7890.4 7937.6 8037.5 8048.4 8056.4 4568.1 4688.6 4698.4 4700.1 4712.0 2789.8 2871.5 2937.1 2938.1 2944.6 880.9 899.3 923.9 927.9 939.2 10886.2 10899.3 10939.7 11015.5 11117.4 4021.4 4209.7 4259.3 4389.2 4393.5 9192.0 9202.0 9207.7 9211.4 9215.6 4647.2 4649.4 4652.8 4655.3 4663.5 3609.1 4160.5 4189.8 4208.5 4262.0 3544.4 3545.3 3656.6 3702.1 3706.5 1087.0 1116.5 1132.7 1222.4 1233.1 677.6 781.0 789.2 818.8 833.5 4937.1 5018.7 5110.6 5197.4 5265.8 408.8 418.2 422.2 425.2 427.4 3557.5 3574.4 3581.5 3588.7 3648.3 9478.7 9887.3 9913.3 9960.6 9962.9 9875.8 9916.3 9921.4 9923.9 9929.9 7055.0 7379.6 7486.9 7490.3 7505.0 4793.0 4824.7 4830.5 4860.4 4867.4 8710.9 8801.0 8825.5 8852.9 8890.0 9051.0 9284.7 9290.8 9292.2 9307.0 6046.2 6688.3 6869.6 6980.5 6989.5 7322.9 7653.4 7667.1 7674.3 7679.0 6641.9 6695.2 6716.0 6896.4 6928.2 6481.2 6697.1 6742.7 6817.1 6856.2 6260.2 6355.7 6372.3 6377.0 6378.1 4538.9 4586.9 4653.1 4660.3 4706.8 4370.7 4435.0 4525.7 4611.8 4689.0 16:16:29 INFO - PROCESS | 30842 | 16:16:29 INFO - PROCESS | 30842 | [#4] prototype.html Cycles:180 Average:4228.47 Median:4849.95 stddev:1222.09 (25.2%) stddev-sans-first:1189.48 16:16:29 INFO - PROCESS | 30842 | Values: 303.2 307.1 312.2 313.3 315.0 4838.6 4859.7 4863.6 4881.3 4885.8 4837.2 4838.1 4843.9 4847.0 4852.9 3633.6 3744.6 3787.8 3853.9 3895.2 3852.1 3870.6 3874.7 3891.7 3906.9 3816.1 3821.5 3830.0 3835.9 3837.6 3651.0 3697.5 3824.6 3828.7 3831.7 3391.6 3393.7 3404.4 3405.2 3427.6 4689.8 4705.4 4706.5 4724.6 4737.8 4189.3 4356.7 4372.3 4377.3 4378.8 5058.6 5064.5 5067.3 5079.3 5084.6 3722.3 3725.2 3729.7 3731.1 3747.2 5045.9 5295.8 5298.6 5326.9 5337.4 3645.3 3681.3 3685.4 3686.7 3688.2 3729.0 3743.5 3750.8 3754.0 3770.4 4308.0 4315.9 4316.9 4320.4 4325.3 4972.8 5092.9 5093.6 5147.8 5173.4 1261.7 1274.7 1275.2 1275.8 1280.7 793.7 823.7 835.1 845.7 847.4 4336.4 4405.2 4435.9 4444.5 4450.4 5155.1 5271.7 5294.0 5303.2 5306.5 4501.1 4520.8 4523.9 4529.6 4539.8 2664.0 2781.6 2786.8 2802.6 2828.4 4913.2 4920.9 4921.8 4931.9 4936.5 5101.8 5329.3 5344.1 5363.8 5381.4 4936.2 4947.2 4952.7 4953.4 4960.7 5212.8 5229.9 5247.7 5250.1 5278.6 4970.2 5114.9 5115.3 5132.3 5155.8 4877.5 4901.3 4903.6 4914.0 4915.7 3762.7 3774.2 3784.3 3784.7 3803.6 4928.3 5175.8 5182.5 5185.0 5214.5 4981.7 5029.9 5045.5 5060.4 5062.1 5049.5 5055.3 5074.9 5105.9 5108.4 4739.6 4893.8 4935.7 4994.5 5024.2 4926.6 4955.1 5109.3 5166.8 5193.3 5047.3 5067.8 5071.4 5073.5 5084.0 16:16:29 INFO - PROCESS | 30842 | 16:16:29 INFO - PROCESS | 30842 | [#5] yui.html Cycles:180 Average:17939.13 Median:546.24 stddev:26171.44 (4791.2%) stddev-sans-first:26212.46 16:16:29 INFO - PROCESS | 30842 | Values: 595.4 625.1 626.0 634.6 644.9 12069.2 14524.6 15263.1 15345.9 15984.2 15265.8 15498.4 15511.0 15520.5 15530.6 639.3 757.7 771.0 794.9 797.8 782.4 791.2 796.3 796.7 796.9 833.0 834.9 839.4 839.5 839.7 654.6 673.4 827.6 827.6 827.8 499.0 500.3 577.1 591.6 595.6 12810.9 12825.6 12842.9 12856.7 12860.4 12090.5 12165.7 12609.6 12831.2 13275.2 11080.3 11212.5 11217.6 11293.7 11602.7 4021.1 4029.6 4064.3 4219.0 4284.9 65999.3 66746.0 67736.3 68886.3 69510.7 10403.8 10512.3 10548.7 10561.3 10761.9 18599.4 18700.5 18741.8 18752.7 18816.2 6374.3 6449.4 6475.7 6493.3 6851.1 3582.1 3662.2 3662.4 3691.3 3733.1 2906.4 3060.1 3067.3 3068.0 3068.2 515.0 516.1 523.1 530.3 532.7 530.8 537.7 542.5 543.8 555.7 8160.6 8263.8 8353.4 8598.6 8716.0 537.2 548.7 550.7 561.4 573.4 3637.6 3814.0 3890.6 3949.7 3952.7 56693.0 68407.0 95270.0 110132.0 110249.4 91472.0 91894.0 93113.5 94062.5 94549.0 44610.3 72196.6 78299.6 82691.6 84572.6 7326.6 7533.1 7588.5 7643.2 7828.3 47082.5 47873.0 48733.3 49976.8 51174.7 62232.7 66223.3 66933.3 67578.0 70337.3 9762.7 9850.4 10065.8 10247.9 10292.9 10006.7 10378.8 11033.7 11292.8 11809.6 9545.0 9592.6 9617.8 9670.4 9735.0 10059.5 10107.7 10188.1 10387.2 10394.9 9889.2 9932.2 10049.4 10343.9 10749.5 8831.8 9143.1 9349.7 9428.5 9440.5 8766.7 9384.3 9389.0 9414.6 9436.1 16:16:29 INFO - PROCESS | 30842 | -------- Summary: end -------- 16:16:29 INFO - PROCESS | 30842 | 16:16:29 INFO - TEST-INFO | 30842: exit 0 16:16:30 INFO - TEST-OK | dromaeo_css | took 1120044ms 16:16:30 INFO - TEST-START | kraken 16:16:30 INFO - operating with platform_type : linux_ 16:16:30 INFO - Initialising browser for kraken test... 16:16:30 INFO - TEST-INFO | started process 31146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TZvec/profile http://localhost:56378/getInfo.html) 16:16:34 INFO - PROCESS | 31146 | __metrics Screen width/height:1600/1200 16:16:34 INFO - PROCESS | 31146 | colorDepth:24 16:16:34 INFO - PROCESS | 31146 | Browser inner width/height: 1024/697 16:16:34 INFO - PROCESS | 31146 | __metrics 16:16:34 INFO - PROCESS | 31146 | 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:16:34 INFO - PROCESS | 31146 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:16:35 INFO - TEST-INFO | 31146: exit 0 16:16:35 INFO - Browser initialized. 16:16:35 INFO - Running cycle 1/1 for kraken test... 16:16:35 INFO - TEST-INFO | started process 31227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TZvec/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:16:47 INFO - PROCESS | 31227 | RSS: Main: 156897280 16:16:47 INFO - PROCESS | 31227 | 16:16:50 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56378/tests/kraken/driver.html?testName=audio-beat-detection) 16:16:51 INFO - PROCESS | 31227 | RSS: Main: 204169216 16:16:51 INFO - PROCESS | 31227 | 16:16:54 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56378/tests/kraken/driver.html?testName=audio-dft) 16:16:54 INFO - PROCESS | 31227 | RSS: Main: 194805760 16:16:54 INFO - PROCESS | 31227 | 16:16:58 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56378/tests/kraken/driver.html?testName=audio-fft) 16:16:58 INFO - PROCESS | 31227 | RSS: Main: 276643840 16:16:58 INFO - PROCESS | 31227 | 16:17:00 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56378/tests/kraken/driver.html?testName=audio-oscillator) 16:17:01 INFO - PROCESS | 31227 | RSS: Main: 186802176 16:17:01 INFO - PROCESS | 31227 | 16:17:03 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:17:04 INFO - PROCESS | 31227 | RSS: Main: 191135744 16:17:04 INFO - PROCESS | 31227 | 16:17:07 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56378/tests/kraken/driver.html?testName=imaging-darkroom) 16:17:08 INFO - PROCESS | 31227 | RSS: Main: 227778560 16:17:08 INFO - PROCESS | 31227 | 16:17:11 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56378/tests/kraken/driver.html?testName=imaging-desaturate) 16:17:12 INFO - PROCESS | 31227 | RSS: Main: 221523968 16:17:12 INFO - PROCESS | 31227 | 16:17:15 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56378/tests/kraken/driver.html?testName=json-parse-financial) 16:17:15 INFO - PROCESS | 31227 | RSS: Main: 225439744 16:17:15 INFO - PROCESS | 31227 | 16:17:17 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:17:18 INFO - PROCESS | 31227 | RSS: Main: 188698624 16:17:18 INFO - PROCESS | 31227 | 16:17:20 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56378/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:17:20 INFO - PROCESS | 31227 | RSS: Main: 196395008 16:17:20 INFO - PROCESS | 31227 | 16:17:22 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:17:23 INFO - PROCESS | 31227 | RSS: Main: 193355776 16:17:23 INFO - PROCESS | 31227 | 16:17:26 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:17:27 INFO - PROCESS | 31227 | RSS: Main: 188223488 16:17:27 INFO - PROCESS | 31227 | 16:17:29 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:17:30 INFO - PROCESS | 31227 | RSS: Main: 191184896 16:17:30 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | Cycle 1(1): loaded http://localhost:56378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56378/tests/kraken/driver.html?testName=ai-astar) 16:17:32 INFO - PROCESS | 31227 | RSS: Main: 242737152 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | __start_tp_report 16:17:32 INFO - PROCESS | 31227 | _x_x_mozilla_page_load 16:17:32 INFO - PROCESS | 31227 | _x_x_mozilla_page_load_details 16:17:32 INFO - PROCESS | 31227 | |i|pagename|runs| 16:17:32 INFO - PROCESS | 31227 | |0;ai-astar;105;113;117;114;108;114;114;113;114;115 16:17:32 INFO - PROCESS | 31227 | |1;audio-beat-detection;150;123;122;190;127;128;145;121;167;120 16:17:32 INFO - PROCESS | 31227 | |2;audio-dft;160;160;161;162;162;162;161;162;161;161 16:17:32 INFO - PROCESS | 31227 | |3;audio-fft;76;77;76;110;78;77;76;74;101;75 16:17:32 INFO - PROCESS | 31227 | |4;audio-oscillator;86;86;126;86;88;87;121;87;87;128 16:17:32 INFO - PROCESS | 31227 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;117;117 16:17:32 INFO - PROCESS | 31227 | |6;imaging-darkroom;146;147;145;147;146;146;147;147;147;147 16:17:32 INFO - PROCESS | 31227 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 16:17:32 INFO - PROCESS | 31227 | |8;json-parse-financial;64;62;63;61;62;63;62;61;64;62 16:17:32 INFO - PROCESS | 31227 | |9;json-stringify-tinderbox;65;66;66;66;66;75;65;65;67;64 16:17:32 INFO - PROCESS | 31227 | |10;stanford-crypto-aes;84;84;82;83;82;83;83;83;83;82 16:17:32 INFO - PROCESS | 31227 | |11;stanford-crypto-ccm;137;132;138;135;132;136;131;130;167;133 16:17:32 INFO - PROCESS | 31227 | |12;stanford-crypto-pbkdf2;173;172;174;172;169;174;173;172;170;171 16:17:32 INFO - PROCESS | 31227 | |13;stanford-crypto-sha256-iterative;68;68;69;68;68;68;71;72;66;68 16:17:32 INFO - PROCESS | 31227 | __end_tp_report 16:17:32 INFO - PROCESS | 31227 | __start_cc_report 16:17:32 INFO - PROCESS | 31227 | _x_x_mozilla_cycle_collect,1982 16:17:32 INFO - PROCESS | 31227 | __end_cc_report 16:17:32 INFO - PROCESS | 31227 | __startTimestamp1471043852627__endTimestamp 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | ------- Summary: start ------- 16:17:32 INFO - PROCESS | 31227 | Number of tests: 14 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.53 (3.1%) stddev-sans-first:2.40 16:17:32 INFO - PROCESS | 31227 | Values: 105.0 113.0 117.0 114.0 108.0 114.0 114.0 113.0 114.0 115.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:136.50 stddev:23.66 (17.3%) stddev-sans-first:24.77 16:17:32 INFO - PROCESS | 31227 | Values: 150.0 123.0 122.0 190.0 127.0 128.0 145.0 121.0 167.0 120.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 16:17:32 INFO - PROCESS | 31227 | Values: 160.0 160.0 161.0 162.0 162.0 162.0 161.0 162.0 161.0 161.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.61 (16.6%) stddev-sans-first:13.19 16:17:32 INFO - PROCESS | 31227 | Values: 76.0 77.0 76.0 110.0 78.0 77.0 76.0 74.0 101.0 75.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:86.50 stddev:18.58 (21.5%) stddev-sans-first:19.18 16:17:32 INFO - PROCESS | 31227 | Values: 86.0 86.0 126.0 86.0 88.0 87.0 121.0 87.0 87.0 128.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:17:32 INFO - PROCESS | 31227 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 16:17:32 INFO - PROCESS | 31227 | Values: 146.0 147.0 145.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:17:32 INFO - PROCESS | 31227 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.50 stddev:1.07 (1.7%) stddev-sans-first:0.97 16:17:32 INFO - PROCESS | 31227 | Values: 64.0 62.0 63.0 61.0 62.0 63.0 62.0 61.0 64.0 62.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:3.10 (4.7%) stddev-sans-first:3.24 16:17:32 INFO - PROCESS | 31227 | Values: 65.0 66.0 66.0 66.0 66.0 75.0 65.0 65.0 67.0 64.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 16:17:32 INFO - PROCESS | 31227 | Values: 84.0 84.0 82.0 83.0 82.0 83.0 83.0 83.0 83.0 82.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:135.50 stddev:10.84 (8.0%) stddev-sans-first:11.49 16:17:32 INFO - PROCESS | 31227 | Values: 137.0 132.0 138.0 135.0 132.0 136.0 131.0 130.0 167.0 133.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.50 stddev:1.63 (0.9%) stddev-sans-first:1.69 16:17:32 INFO - PROCESS | 31227 | Values: 173.0 172.0 174.0 172.0 169.0 174.0 173.0 172.0 170.0 171.0 16:17:32 INFO - PROCESS | 31227 | 16:17:32 INFO - PROCESS | 31227 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:1.71 (2.5%) stddev-sans-first:1.80 16:17:32 INFO - PROCESS | 31227 | Values: 68.0 68.0 69.0 68.0 68.0 68.0 71.0 72.0 66.0 68.0 16:17:32 INFO - PROCESS | 31227 | -------- Summary: end -------- 16:17:32 INFO - PROCESS | 31227 | 16:17:33 INFO - TEST-INFO | 31227: exit 0 16:17:33 INFO - TEST-OK | kraken | took 63736ms 16:17:33 INFO - SUITE-END | took 1183s 16:17:33 INFO - Completed test suite (00:19:43) 16:17:33 INFO - javascript benchmark 16:17:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2633.525965326241, 2643.629891815145, 2669.6395986541816, 2682.1685277563956, 2685.4494828560137, 4636.350910872472, 4702.459217190024, 4798.928016079757, 4831.492693267204, 4834.903301933964, 4729.716217026981, 4762.833300834472, 4763.0, 4806.231003039515, 4837.346958160647, 4363.825446982117, 4367.606915377615, 4435.756033418161, 4482.282834746441, 4563.49801521834, 4467.084247729208, 4510.797014134356, 4531.184386810372, 4540.364348991144, 4552.203364411232, 4288.485381754178, 4327.7186982846015, 4366.432363792718, 4380.693351465398, 4437.689361744679, 4343.283358245885, 4346.9347959780625, 4369.104333611602, 4448.822047118111, 4456.799444025027, 4383.890402739925, 4384.802683879233, 4389.539098394686, 4397.516273209944, 4442.044960333544, 4699.0836786826585, 4745.572898439157, 4772.73749943753, 4782.952170478286, 4810.542998415145, 5131.102057139986, 5184.948150518484, 5196.272521846944, 5197.22041693749, 5206.0, 5217.217417387385, 5220.895582088337, 5263.44733802949, 5267.789288428458, 5273.314469119028, 4560.429946256718, 4681.695689780154, 4760.785764640599, 4795.448523419782, 4877.756112194376, 5248.816291429782, 5278.841634750964, 5314.362276526842, 5323.148296272578, 5337.973310133424, 5052.9747351263, 5058.114829904752, 5080.085584594734, 5099.184130539096, 5110.054639891632, 4993.0, 5015.774290156952, 5063.8987220255385, 5079.923801142986, 5160.509751573594, 5144.43411224765, 5148.433672296044, 5149.562287205555, 5149.871253218699, 5178.326817513699, 5143.742812859342, 5154.0, 5154.716490593053, 5155.200943853709, 5204.609654275944, 4261.275583150872, 4277.550857160016, 4284.3359279311135, 4334.523202447728, 4430.867073987721, 3787.507624008861, 3820.8662696805477, 3822.9044273893373, 3825.254075455315, 3827.1771569112775, 4363.432753741993, 4365.323374876899, 4370.912581748411, 4371.519132895379, 4376.693631445832, 5043.87390315245, 5075.619328550373, 5138.511841375063, 5152.458991805806, 5230.215467679803, 4404.823807047746, 4406.955930440655, 4418.226810308248, 4424.46906371231, 4450.488193857748, 4608.147492713859, 4615.26155815068, 4623.260278355447, 4638.5593368629925, 4654.883627909329, 4716.976415117902, 4802.6638135330195, 4831.033793241436, 4846.055019271208, 4918.778654960463, 5182.1190397631735, 5191.636585439134, 5194.168932970707, 5197.532222100029, 5199.896002079861, 4860.6111511079735, 4865.56209941107, 4866.284313383539, 4866.756662166948, 4891.633127515522, 4941.604671626334, 5057.74711264428, 5070.340855688737, 5091.261767043832, 5164.638475306692, 5187.4553171916405, 5192.3769147702515, 5199.012187684328, 5199.428062913152, 5206.661566998133, 5045.672031317952, 5051.191809310492, 5053.7220452875445, 5057.519535644108, 5090.847274581768, 4922.0, 4974.0797952378925, 5003.574696150868, 5021.5229553192385, 5081.00920320534, 4938.728369939688, 4940.135476291706, 4978.950210497994, 4983.4518202996915, 4990.850274491771, 5020.874478138076, 5031.974840125776, 5033.169527028, 5040.722760248222, 5103.872403189802, 4821.855344339676, 4829.806807727651, 4858.392700912386, 4875.488073752205, 4926.458089610212], "value": 4717.405027984407, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.6058857328437, 574.57768540123, 579.9739011744471, 584.0246787864266, 587.3480436715246, 27808.582871256924, 28314.292142696417, 37505.43741843875, 38945.41581876274, 39314.41028384576, 38364.42453363195, 38803.61196388035, 38804.0, 38868.41697374535, 38889.0, 7500.099988001448, 7641.4268929830205, 7649.311561959423, 7650.61746912655, 7650.961745191266, 7619.695212191506, 7682.347000504964, 7706.422018348646, 7709.074911010659, 7717.72987945422, 7691.500052496598, 7730.652120654584, 7734.806629834271, 7737.961310193441, 7739.380849532052, 7660.348870346027, 7694.461387702863, 7698.384129269645, 7700.0, 7700.4224683148705, 7627.084749830056, 7637.961810190969, 7693.038370203724, 7697.076350837935, 7697.884531732028, 37051.073723156864, 37051.44422833659, 37302.0, 37562.62437375619, 37569.436458452874, 2864.3268831824503, 2909.301767575788, 2931.589577459157, 2937.1922721251613, 2986.2982199183175, 27735.0, 28060.85969570139, 28266.858665706746, 28326.29184270389, 28871.133865984055, 3389.440742277521, 3482.860685572574, 3497.4753786932165, 3513.086597484647, 3562.287542491512, 257503.0, 258405.9999999981, 259454.0, 259482.0, 259485.0, 49084.26373604399, 49371.25943110856, 49407.0, 49451.258231126565, 49496.0, 31486.527702084488, 32732.0, 32754.181145471077, 34682.30635387278, 52154.0, 13629.045966782429, 13763.38064787087, 13766.862331376558, 13766.93116534411, 13782.65543361424, 10392.168626510012, 10491.94754026225, 10514.842277365846, 10516.106130978953, 10521.263511554118, 17358.91320543389, 17516.21177047036, 17603.647927041387, 17618.647627047387, 17697.29210831578, 6510.641914694643, 6568.376004279586, 6638.369354911276, 6735.663216839236, 6779.288174741581, 808.4138999225514, 873.4890089297832, 903.8056817784208, 940.6096469964888, 977.506359288569, 26989.86505067462, 27746.306342341602, 27788.58317125245, 27924.86037569799, 28366.71633283682, 898.5552151684958, 930.8929473110679, 954.3653470442217, 960.2414092866696, 1029.6087486755134, 13832.239226842621, 14148.646283842987, 14277.357518911465, 14398.280085995659, 14516.564503064925, 409832.0, 411306.0, 413680.0, 413758.0, 414142.0, 45833.541664582925, 46326.07347853092, 46357.30464043042, 46385.0, 46389.0, 1081.561967403203, 1128.966131016071, 1181.8109102543551, 1198.9940050299692, 1211.2792888231488, 24820.627690585017, 27849.582256265767, 27890.72109278881, 28287.717122828508, 28560.857935655324, 40011.59988400195, 44911.55088449074, 46396.53603463922, 46526.30210546912, 50355.0, 375634.0, 376089.0, 376259.0, 376512.0, 379302.0, 30965.088380746492, 31431.842840785648, 37756.43365349467, 37853.0, 38505.0, 29082.418351632426, 37150.0, 38186.236275274896, 38206.23587528178, 38364.0, 33318.83340583282, 33538.49692254667, 33581.664183357854, 33623.4956475658, 34103.0, 32848.50727239045, 33493.16267093342, 33573.496397553565, 33919.83040084784, 34226.48660270048, 30064.54903176498, 33272.0, 33386.833065834515, 34855.47716784301, 36009.279814404086, 30037.5494367589, 32151.0, 32849.34301314008, 33080.50379244265, 33401.832990835865, 24980.125695600567, 25102.748972510042, 25297.367565811, 25368.0, 25633.61549576795], "value": 17101.694592672055, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.1927767939538, 359.1864427072681, 372.888133559932, 375.4237245827655, 385.3391433691221, 13149.605511834648, 16231.431899883506, 16616.335346586136, 17813.37653182139, 18027.098645067726, 17275.568110797205, 17536.473905782816, 17924.731129033076, 18082.909585452086, 18101.90949045253, 4770.189067858464, 5141.0, 5152.046871328816, 5177.30106435632, 5178.844634660947, 3724.5716742574546, 5074.213496907985, 5151.948480515203, 5153.0, 5778.8266352009505, 6027.487663548582, 6110.541709371792, 6124.448799608034, 6137.171481849938, 6138.693065346737, 5888.057910734284, 6020.5785595008365, 6025.819225423201, 6070.453659170652, 6138.631682099066, 5347.2781174541715, 5348.598855085846, 5352.652077614982, 5355.393381985389, 5362.624616276862, 20770.0, 21175.5764884703, 21545.1381944722, 21757.347279581638, 21892.89053554722, 1780.7061834797244, 1916.9904150479297, 1979.7525309336334, 1982.2863769043277, 2041.030510507512, 5260.237265596467, 5287.206918962148, 5342.652727572696, 5527.778888844441, 9243.149952501068, 1687.7468379743013, 1697.499237724874, 1731.2209505722476, 1766.7791526059243, 1780.6616742818824, 69333.3066669337, 73423.26576734218, 74477.6276118616, 76372.23627763707, 77057.22942770556, 9803.803923921625, 9956.352837065568, 10060.547275372626, 10263.127634151031, 10378.584856605652, 13634.181949083088, 13639.181649101085, 13660.565640607792, 13671.453141874412, 13692.110012849133, 7002.859942801116, 7126.109236345457, 7226.963865180641, 7306.890396644055, 7316.524425912298, 6710.865782684319, 6732.225794033749, 6906.274841141708, 6914.239433662293, 6915.308469153045, 4193.32906734927, 4219.746815191098, 4298.446092276347, 4379.912401751947, 4389.978050109793, 1730.3165249726287, 1788.2757483219316, 1788.7853457585172, 1793.0944872839132, 1800.1359347513267, 787.696736756353, 792.1088775127981, 794.6503538443067, 803.269025187077, 827.3463963468793, 16646.417375392044, 17550.912245438947, 17568.38510652121, 18006.0, 18009.7298540522, 832.1387364078271, 834.040853019033, 840.206005324962, 852.7868032991752, 869.3436455476201, 9152.633894644272, 9968.950155249177, 10052.69841904744, 10065.496725163712, 10120.645777397756, 385928.0, 386126.0, 388986.0, 396576.0, 399321.0, 54457.45542544603, 72630.63684681543, 73333.26666733371, 79166.6041669788, 79359.60320198478, 874.7157173918501, 910.2081189365163, 924.0343840686498, 939.4551160326994, 942.3544871762864, 11312.886871131512, 15698.136602486973, 15819.604509887346, 16620.750688739437, 16839.326426942785, 38224.80887595656, 38738.80630596829, 38960.22079558449, 40437.59562404338, 40909.590904090575, 49358.75320623374, 49654.75172624258, 52035.0, 52183.0, 52431.0, 6587.769428070186, 6842.657867106725, 7177.282271772781, 7293.4894557382595, 7892.1318654949055, 11958.64124076279, 11995.0, 12289.69275768113, 12461.314627695563, 12562.497500099893, 10517.474966130021, 10588.205884558534, 10672.413017284123, 10811.13510919109, 11065.0, 10243.692689219335, 10418.270721049454, 10427.582896684047, 10446.843297350697, 10481.842772358574, 9903.356281841945, 10512.94743526308, 10605.204609654153, 10763.408012559385, 11238.044766194638, 7257.371388826872, 7272.636368181676, 7324.230955749569, 7354.0, 7593.8860917085185, 9263.76840578964, 10593.947030264799, 10690.679279621623, 10793.514291856729, 11255.831162532404], "value": 8167.617487208869, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.748261571609, 1407.2611878763648, 1455.1632811133595, 1611.975820362694, 1656.2960741684788, 7445.292697193771, 8009.839803203932, 8021.197880211976, 8021.639026243818, 8035.075966263881, 6831.111955445797, 7524.661390237453, 7678.155402905676, 7690.461667683265, 7984.600769961493, 2167.0573300614205, 2183.858049226795, 2186.35502526755, 2190.1567896359857, 2205.106931692659, 2172.771858954811, 2194.3855720398315, 2247.438140464884, 2251.313349428424, 2252.0203711385516, 2086.332373640436, 2100.28590279305, 2183.9235626753066, 2195.1877805212093, 2202.174184680745, 2125.181805005069, 2125.5005073807642, 2125.9574808503744, 2129.659254519277, 2131.4458240857334, 2083.781202973681, 2145.270607993274, 2147.2699282243957, 2149.881756503392, 2150.387139665188, 7890.408219383569, 7937.563434011185, 8037.517748935083, 8048.436609437342, 8056.395770317191, 4568.086382723435, 4688.624910007191, 4698.4361876574685, 4700.106979673885, 4711.952880471185, 2789.846558439285, 2871.4687782760257, 2937.1188643407104, 2938.1038783171125, 2944.6024786653743, 880.903100658927, 899.2850683706404, 923.8798956135727, 927.9211267042309, 939.178219058324, 10886.23796334257, 10899.29154604956, 10939.671809845717, 11015.504302306415, 11117.388543630097, 4021.3967904813926, 4209.684273679486, 4259.318509038539, 4389.231884420214, 4393.51671316155, 9191.954040229755, 9201.953990230006, 9207.723768286962, 9211.355205135576, 9215.63137474507, 4647.233206520887, 4649.442066951988, 4652.837150699709, 4655.255159174516, 4663.48701642819, 3609.097725568608, 4160.521540022875, 4189.811458484375, 4208.473940757405, 4262.041040765865, 3544.3620148373025, 3545.290941811648, 3656.561212654445, 3702.0929872181487, 3706.5366829146355, 1087.0108201536564, 1116.5366372955132, 1132.7338075552238, 1222.4254600337827, 1233.0751936047964, 677.6239187251024, 780.9765707028798, 789.2462698123278, 818.7543736878913, 833.4540875726409, 4937.136001199848, 5018.723970181675, 5110.616703747234, 5197.350331208599, 5265.76304066318, 408.78334482724205, 418.23045596103316, 422.204145186326, 425.168795005763, 427.3504273504318, 3557.5197348358156, 3574.4459608760685, 3581.4985901973746, 3588.69496092835, 3648.3068217038676, 9478.668246611473, 9887.258455615858, 9913.256505762096, 9960.601575936882, 9962.850557241647, 9875.75310617226, 9916.256280778825, 9921.355111917703, 9923.851142232872, 9929.900700993043, 7055.0, 7379.557226566423, 7486.887696684554, 7490.250974902466, 7504.962475187589, 4793.0, 4824.6863953842885, 4830.516948305141, 4860.3681521401995, 4867.367242258484, 8710.869336959824, 8801.031886492608, 8825.514596697243, 8852.867206991772, 8889.955550222208, 9051.004389517017, 9284.72145835626, 9290.767730806783, 9292.16370526656, 9306.953465232631, 6046.153538504701, 6688.297728738413, 6869.553479023847, 6980.476464265099, 6989.5107342485535, 7322.890156647761, 7653.387728981556, 7667.11828139771, 7674.270944260286, 7679.040119985002, 6641.900371494335, 6695.230048544479, 6715.966420167868, 6896.448284137156, 6928.237893831573, 6481.157449531531, 6697.0958920547055, 6742.73029078851, 6817.113775209191, 6856.24581296067, 6260.217472815898, 6355.682215889095, 6372.299047104722, 6377.0, 6378.075179099097, 4538.863834084983, 4586.931196031996, 4653.139169253699, 4660.300954856799, 4706.835260765857, 4370.7159034662645, 4434.977825110854, 4525.683202175947, 4611.815527378867, 4689.038747056913], "value": 4053.9516335261637, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.2146739943546, 307.14919672507153, 312.2132226788492, 313.29196017001567, 314.95118256670196, 4838.637102217334, 4859.659823812334, 4863.635227357945, 4881.316615673809, 4885.802978270329, 4837.201861692825, 4838.104950584145, 4843.854684359466, 4846.975765121169, 4852.927206091903, 3633.618470060645, 3744.588095309514, 3787.753796003251, 3853.942190867125, 3895.162540053888, 3852.0739630184908, 3870.5872356589784, 3874.7093967952515, 3891.7351860645404, 3906.941395879064, 3816.1413681921485, 3821.4840996465537, 3830.00419890829, 3835.884923452287, 3837.616238376168, 3651.0, 3697.482352470656, 3824.560175579816, 3828.7319887607878, 3831.7126215533945, 3391.6099648540485, 3393.745469089828, 3404.438267685829, 3405.182756138509, 3427.5715535558056, 4689.765511724434, 4705.3647757552635, 4706.482286948433, 4724.622030237572, 4737.763111844429, 4189.329707246857, 4356.738595684269, 4372.344148377737, 4377.321515165155, 4378.846740364103, 5058.58359659296, 5064.518870707277, 5067.290579318898, 5079.288899554065, 5084.593232541388, 3722.292764374787, 3725.236326553077, 3729.738918275722, 3731.1045349116016, 3747.2130852521004, 5045.873853153664, 5295.761690723926, 5298.602604804655, 5326.946730532683, 5337.439568845293, 3645.325614761278, 3681.263747250507, 3685.3734865072465, 3686.705063594906, 3688.1517251032415, 3729.0, 3743.494628225155, 3750.774953502744, 3754.0, 3770.3967365221433, 4308.0, 4315.913681726348, 4316.935245971313, 4320.373545835836, 4325.286327755948, 4972.801087956441, 5092.872633923906, 5093.592512598983, 5147.841735609458, 5173.430922598511, 1261.6752409969495, 1274.668586167603, 1275.2284867655121, 1275.8277632519678, 1280.6734282757836, 793.714262865368, 823.7281697039963, 835.1398059998212, 845.6913226672343, 847.4406891451736, 4336.371226172188, 4405.207062728676, 4435.911281774346, 4444.511103778582, 4450.421445212167, 5155.149400348975, 5271.736413179402, 5293.973530132324, 5303.178007408857, 5306.469353064663, 4501.099780044005, 4520.751358675305, 4523.864284071483, 4529.6376289896725, 4539.795709193094, 2663.9733602663723, 2781.582762585628, 2786.7909906757072, 2802.6356573645703, 2828.363618185933, 4913.238448040559, 4920.852374428773, 4921.827736029221, 4931.87670308238, 4936.456989731127, 5101.770420331094, 5329.280547126166, 5344.091504444254, 5363.839084827461, 5381.354237491526, 4936.160852655057, 4947.208446648519, 4952.702837829742, 4953.43035550909, 4960.652754307236, 5212.817551385683, 5229.921551176812, 5247.66184622934, 5250.133727934848, 5278.5513231374225, 4970.204767237225, 5114.923276150935, 5115.283860259641, 5132.255822905583, 5155.819546315861, 4877.463479017234, 4901.264810278487, 4903.6077113831525, 4913.975430122827, 4915.746484646393, 3762.680172185395, 3774.1885494618787, 3784.3188226119564, 3784.6593806557544, 3803.5816060233906, 4928.260760885896, 5175.844724658266, 5182.53357197854, 5185.0, 5214.478552144755, 4981.701097934136, 5029.874253143701, 5045.470225626256, 5060.367454068241, 5062.114130027304, 5049.545540901337, 5055.320680039585, 5074.949250507448, 5105.927755171456, 5108.438071812172, 4739.597134243628, 4893.825481884393, 4935.728534930613, 4994.4755800640405, 5024.246363045426, 4926.605871530341, 4955.1012657594265, 5109.339464673922, 5166.844994650167, 5193.324867767166, 5047.268146118866, 5067.847964561069, 5071.438923343688, 5073.518015788494, 5083.983203359417], "value": 3838.184613834473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.3778301674749, 625.0748891640375, 626.0, 634.6002018728201, 644.8742495213435, 12069.155159138852, 14524.636884077903, 15263.084214947097, 15345.92327038366, 15984.200789960485, 15265.771013434807, 15498.380064797422, 15511.0, 15520.53438396847, 15530.611734706637, 639.2552676132324, 757.685560492395, 770.9961450192741, 794.9085855126648, 797.7686470923426, 782.4327362662082, 791.2087912087912, 796.2952786783709, 796.7251298302076, 796.8924195233657, 833.0336809301211, 834.8914641096649, 839.3914412051275, 839.496302218667, 839.7312859884839, 654.6235914349268, 673.3670349871105, 827.5737994932615, 827.5903427803246, 827.8344331133737, 499.0268975497794, 500.32955839175315, 577.1112486770369, 591.5504216795224, 595.5711887441079, 12810.871891281155, 12825.551105711254, 12842.87157128426, 12856.742865142738, 12860.421281042281, 12090.455929483107, 12165.695857603541, 12609.621711348675, 12831.230126192459, 13275.203925725666, 11080.279781814157, 11212.495437705242, 11217.607383741612, 11293.661190164226, 11602.709932251677, 4021.1153546219784, 4029.6171863672903, 4064.349704047338, 4219.0, 4284.871453856358, 65999.34000660028, 66746.03765161127, 67736.32263677349, 68886.311136889, 69510.65244673795, 10403.791924161626, 10512.264141510173, 10548.736281592868, 10561.260711750258, 10761.946190268998, 18599.44201673952, 18700.532486687942, 18741.81258187428, 18752.718709219374, 18816.247350106118, 6374.330695277022, 6449.355064493513, 6475.740970361227, 6493.253275873335, 6851.07510486088, 3582.0686621478603, 3662.230931504361, 3662.377395842713, 3691.2617476504806, 3733.1227161617, 2906.3896581718077, 3060.1125673554866, 3067.3251884585356, 3067.969320306813, 3068.248279171617, 515.0291700145253, 516.0865268474854, 523.0872128136426, 530.2867643020131, 532.7469452010264, 530.7553786370954, 537.7257598624651, 542.4765101676821, 543.7824870051932, 555.6804837218615, 8160.551169685606, 8263.752087437386, 8353.37349698775, 8598.578837710034, 8716.0, 537.231758585219, 548.6927320700421, 550.6833570696865, 561.4497792163702, 573.3521121133093, 3637.5816781070516, 3813.961860381416, 3890.591487893787, 3949.664278536299, 3952.703547233969, 56693.0, 68406.97389539161, 95270.0, 110132.0, 110249.44875275572, 91472.0, 91894.0, 93113.53443232876, 94062.5296873525, 94549.0, 44610.33084503735, 72196.63901680458, 78299.60850195713, 82691.5865420669, 84572.57713711393, 7326.633668316456, 7533.1336896257635, 7588.468807183444, 7643.159252482112, 7828.256315650005, 47082.52917470918, 47873.0, 48733.26900096572, 49976.75011624918, 51174.74412627913, 62232.68883655553, 66223.33776662365, 66933.33066669271, 67578.0, 70337.29662703308, 9762.707118786448, 9850.408975461496, 10065.84901226497, 10247.897521024992, 10292.948535257276, 10006.69979900604, 10378.792424151323, 11033.724156896142, 11292.774144517229, 11809.645710628694, 9545.0, 9592.568334425107, 9617.807643846943, 9670.371425857296, 9735.026497350209, 10059.497025148567, 10107.69676909694, 10188.083072523508, 10387.220958427997, 10394.948025259826, 9889.159421449258, 9932.205423565953, 10049.447280399649, 10343.896561034293, 10749.516271767945, 8831.779205519657, 9143.13140251675, 9349.719508414759, 9428.481433521221, 9440.527973601154, 8766.693165739169, 9384.343095983215, 9389.0, 9414.576344064397, 9436.127744510977], "value": 6469.895502058215, "unit": "score"}], "name": "dromaeo_css", "value": 6362.551501098752, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 117.0, 114.0, 108.0, 114.0, 114.0, 113.0, 114.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 122.0, 190.0, 127.0, 128.0, 145.0, 121.0, 167.0, 120.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 110.0, 78.0, 77.0, 76.0, 74.0, 101.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 126.0, 86.0, 88.0, 87.0, 121.0, 87.0, 87.0, 128.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 61.0, 62.0, 63.0, 62.0, 61.0, 64.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 75.0, 65.0, 65.0, 67.0, 64.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 83.0, 82.0, 83.0, 83.0, 83.0, 83.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 138.0, 135.0, 132.0, 136.0, 131.0, 130.0, 167.0, 133.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 174.0, 172.0, 169.0, 174.0, 173.0, 172.0, 170.0, 171.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 71.0, 72.0, 66.0, 68.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1541.6, "alertThreshold": 2.0}]} 16:17:33 INFO - Return code: 0 16:17:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:17:33 INFO - # TBPL SUCCESS # 16:17:33 INFO - Running post-action listener: _resource_record_post_action 16:17:33 INFO - [mozharness: 2016-08-12 23:17:33.944341Z] Finished run-tests step (success) 16:17:33 INFO - Running post-run listener: _resource_record_post_run 16:17:34 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 396349440; Read time: 16; Write time: 284732 16:17:34 INFO - TinderboxPrint: CPU usage
13.0% 16:17:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:17:34 INFO - TinderboxPrint: I/O write bytes / time
396,349,440 / 284,732 16:17:34 INFO - TinderboxPrint: CPU idle
8,333.3 (87.0%) 16:17:34 INFO - TinderboxPrint: CPU user
1,200.7 (12.5%) 16:17:34 INFO - TinderboxPrint: Swap in / out
0 / 0 16:17:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113360896; Read time: 0; Write time: 59672 16:17:34 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 282988544; Read time: 0; Write time: 225060 16:17:34 INFO - Running post-run listener: _upload_blobber_files 16:17:34 INFO - Blob upload gear active. 16:17:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:17:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:17:35 INFO - (blobuploader) - INFO - Open directory for files ... 16:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:17:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:35 INFO - (blobuploader) - INFO - Done attempting. 16:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:36 INFO - (blobuploader) - INFO - Done attempting. 16:17:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:17:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:17:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:40 INFO - (blobuploader) - INFO - Done attempting. 16:17:40 INFO - (blobuploader) - INFO - Iteration through files over. 16:17:40 INFO - Return code: 0 16:17:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:17:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:17:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366b175d1ad7c3f35fbee9a44d219ec6b586c43d83b6c70008e6f71c54d90d57d99e570cdb92f21b8ca8c00dd6eb94ebdbbab0e0ad25c232211d13bec3307b56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62cb3f8af1f39ca3e2d6891d7f47662d34df213440ec3170182784109039f65c1a019e7a6f5f6ba02c5aec963e789932c5b0cf7fafea5cb789963d3eb15685e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c254e9237b3ae51b9269c97c56bd4137b0d5b567348c9fb061e47ef9a7f0d3105a1670236892ea07f05cc8c57d475704485ef2f5c04d02ac2535cd110adfdf73"} 16:17:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:17:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:17:40 INFO - Contents: 16:17:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366b175d1ad7c3f35fbee9a44d219ec6b586c43d83b6c70008e6f71c54d90d57d99e570cdb92f21b8ca8c00dd6eb94ebdbbab0e0ad25c232211d13bec3307b56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62cb3f8af1f39ca3e2d6891d7f47662d34df213440ec3170182784109039f65c1a019e7a6f5f6ba02c5aec963e789932c5b0cf7fafea5cb789963d3eb15685e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c254e9237b3ae51b9269c97c56bd4137b0d5b567348c9fb061e47ef9a7f0d3105a1670236892ea07f05cc8c57d475704485ef2f5c04d02ac2535cd110adfdf73"} 16:17:40 INFO - Running post-run listener: copy_logs_to_upload_dir 16:17:40 INFO - Copying logs to upload dir... 16:17:40 INFO - mkdir: /builds/slave/test/build/upload/logs 16:17:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.317618 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-12 16:17:40.316258) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 16:17:40.320555) ========= 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=41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366b175d1ad7c3f35fbee9a44d219ec6b586c43d83b6c70008e6f71c54d90d57d99e570cdb92f21b8ca8c00dd6eb94ebdbbab0e0ad25c232211d13bec3307b56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62cb3f8af1f39ca3e2d6891d7f47662d34df213440ec3170182784109039f65c1a019e7a6f5f6ba02c5aec963e789932c5b0cf7fafea5cb789963d3eb15685e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c254e9237b3ae51b9269c97c56bd4137b0d5b567348c9fb061e47ef9a7f0d3105a1670236892ea07f05cc8c57d475704485ef2f5c04d02ac2535cd110adfdf73"} build_url:https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010734 build_url: 'https://queue.taskcluster.net/v1/task/AnR_RmahSD6ITw_VYc1LyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366b175d1ad7c3f35fbee9a44d219ec6b586c43d83b6c70008e6f71c54d90d57d99e570cdb92f21b8ca8c00dd6eb94ebdbbab0e0ad25c232211d13bec3307b56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62cb3f8af1f39ca3e2d6891d7f47662d34df213440ec3170182784109039f65c1a019e7a6f5f6ba02c5aec963e789932c5b0cf7fafea5cb789963d3eb15685e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c254e9237b3ae51b9269c97c56bd4137b0d5b567348c9fb061e47ef9a7f0d3105a1670236892ea07f05cc8c57d475704485ef2f5c04d02ac2535cd110adfdf73"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 16:17:40.345005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 16:17:40.348342) ========= 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=41bf3e9aed84707956354da8000001c5-1471041078.437521-1465941869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004754 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 16:17:40.427097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 16:17:40.430489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 16:17:40.430856) ========= ========= Total master_lag: 0.18 =========