builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1471309471.2 results: success (0) buildid: 20160815163002 builduid: cac6cc55797c41bb939c8de7645139de revision: 054d4856cea6150a6638e5daf7913713281af97d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:31.197384) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:31.198323) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:31.198997) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:31.227901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:31.228234) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 18:04:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.3M=0s 2016-08-15 18:04:31 (88.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152857 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:31.419335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:31.419645) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.063312 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:31.492847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:31.493209) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 054d4856cea6150a6638e5daf7913713281af97d --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 054d4856cea6150a6638e5daf7913713281af97d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 18:04:31,554 truncating revision to first 12 chars 2016-08-15 18:04:31,554 Setting DEBUG logging. 2016-08-15 18:04:31,554 attempt 1/10 2016-08-15 18:04:31,554 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/054d4856cea6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 18:04:31,854 unpacking tar archive at: mozilla-central-054d4856cea6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:32.160770) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:32.161090) ========= script_repo_revision: 054d4856cea6150a6638e5daf7913713281af97d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:32.161503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:32.161767) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:32.171036) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-15 18:04:32.171318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:04:32 INFO - MultiFileLogger online at 20160815 18:04:32 in /builds/slave/test 18:04:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:04:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:04:32 INFO - {'append_to_log': False, 18:04:32 INFO - 'base_work_dir': '/builds/slave/test', 18:04:32 INFO - 'blob_upload_branch': 'Firefox', 18:04:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:04:32 INFO - 'branch': 'Firefox', 18:04:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:04:32 INFO - 'config_files': ('talos/linux_config.py',), 18:04:32 INFO - 'default_actions': ('clobber', 18:04:32 INFO - 'read-buildbot-config', 18:04:32 INFO - 'download-and-extract', 18:04:32 INFO - 'populate-webroot', 18:04:32 INFO - 'create-virtualenv', 18:04:32 INFO - 'install', 18:04:32 INFO - 'run-tests'), 18:04:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:04:32 INFO - 'download_minidump_stackwalk': True, 18:04:32 INFO - 'download_symbols': 'ondemand', 18:04:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:04:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:04:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:04:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:04:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:04:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:04:32 INFO - 'installer_path': 'installer.exe', 18:04:32 INFO - 'log_level': 'info', 18:04:32 INFO - 'log_name': 'talos', 18:04:32 INFO - 'log_to_console': True, 18:04:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:04:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:04:32 INFO - 'opt_config_files': (), 18:04:32 INFO - 'pip_index': False, 18:04:32 INFO - 'sps_profile': False, 18:04:32 INFO - 'sps_profile_interval': 0, 18:04:32 INFO - 'suite': 'dromaeojs-e10s', 18:04:32 INFO - 'system_bits': '32', 18:04:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:04:32 INFO - 'title': 'talos-linux64-ix-052', 18:04:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:04:32 INFO - 'use_talos_json': True, 18:04:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:04:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:04:32 INFO - 'work_dir': 'build'} 18:04:32 INFO - [mozharness: 2016-08-16 01:04:32.403090Z] Running clobber step. 18:04:32 INFO - Running pre-action listener: _resource_record_pre_action 18:04:32 INFO - Running main action method: clobber 18:04:32 INFO - rmtree: /builds/slave/test/build 18:04:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:04:36 INFO - Running post-action listener: _resource_record_post_action 18:04:36 INFO - [mozharness: 2016-08-16 01:04:36.518786Z] Finished clobber step (success) 18:04:36 INFO - [mozharness: 2016-08-16 01:04:36.518930Z] Running read-buildbot-config step. 18:04:36 INFO - Running pre-action listener: _resource_record_pre_action 18:04:36 INFO - Running main action method: read_buildbot_config 18:04:36 INFO - Using buildbot properties: 18:04:36 INFO - { 18:04:36 INFO - "project": "", 18:04:36 INFO - "product": "firefox", 18:04:36 INFO - "script_repo_revision": "production", 18:04:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:04:36 INFO - "repository": "", 18:04:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:04:36 INFO - "buildid": "20160815163002", 18:04:36 INFO - "pgo_build": "True", 18:04:36 INFO - "basedir": "/builds/slave/test", 18:04:36 INFO - "buildnumber": 125, 18:04:36 INFO - "slavename": "talos-linux64-ix-052", 18:04:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:04:36 INFO - "platform": "ubuntu64_hw", 18:04:36 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:04:36 INFO - "branch": "mozilla-central", 18:04:36 INFO - "repo_path": "mozilla-central", 18:04:36 INFO - "revision": "054d4856cea6150a6638e5daf7913713281af97d", 18:04:36 INFO - "stage_platform": "linux64-pgo", 18:04:36 INFO - "builduid": "cac6cc55797c41bb939c8de7645139de", 18:04:36 INFO - "slavebuilddir": "test" 18:04:36 INFO - } 18:04:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:04:36 INFO - Running post-action listener: _resource_record_post_action 18:04:36 INFO - [mozharness: 2016-08-16 01:04:36.522566Z] Finished read-buildbot-config step (success) 18:04:36 INFO - [mozharness: 2016-08-16 01:04:36.522694Z] Running download-and-extract step. 18:04:36 INFO - Running pre-action listener: _resource_record_pre_action 18:04:36 INFO - Running main action method: download_and_extract 18:04:36 INFO - mkdir: /builds/slave/test/build/tests 18:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:36 INFO - trying https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:04:36 INFO - Downloading https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/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 18:04:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/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 18:04:37 INFO - Downloaded 1361 bytes. 18:04:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:04:37 INFO - Using the following test package requirements: 18:04:37 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:04:37 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:04:37 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:04:37 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:37 INFO - u'jsshell-linux-x86_64.zip'], 18:04:37 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:04:37 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:04:37 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:04:37 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:04:37 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:04:37 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:04:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:37 INFO - trying https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:04:37 INFO - Downloading https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/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 18:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/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 18:04:37 INFO - Downloaded 21837882 bytes. 18:04:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 18:04:42 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 18:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:42 INFO - trying https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:04:42 INFO - Downloading https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/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 18:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/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 18:04:43 INFO - Downloaded 21837882 bytes. 18:04:43 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 18:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:48 INFO - trying https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:04:48 INFO - Downloading https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/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 18:04:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/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 18:04:49 INFO - Downloaded 14413719 bytes. 18:04:49 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 18:04: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')]} 18:04:49 INFO - trying https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:04:49 INFO - Downloading https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/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 18:04:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/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 18:04:50 INFO - Downloaded 59413261 bytes. 18:04:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:04:50 INFO - mkdir: /builds/slave/test/properties 18:04:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:04:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:04:50 INFO - Contents: 18:04:50 INFO - build_url:https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:04:51 INFO - Running post-action listener: _resource_record_post_action 18:04:51 INFO - Running post-action listener: set_extra_try_arguments 18:04:51 INFO - [mozharness: 2016-08-16 01:04:51.582645Z] Finished download-and-extract step (success) 18:04:51 INFO - [mozharness: 2016-08-16 01:04:51.582875Z] Running populate-webroot step. 18:04:51 INFO - Running pre-action listener: _resource_record_pre_action 18:04:51 INFO - Running main action method: populate_webroot 18:04:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:04:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:04:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:04:51 INFO - '--tppagecycles', 18:04:51 INFO - '7'], 18:04:51 INFO - 'tests': ['tsvgm']}}, 18:04:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:04:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:04:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:04:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:04:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:51 INFO - 'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:51 INFO - 'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['damp', 'tps']}, 18:04:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:51 INFO - 'tests': ['damp', 'tps']}, 18:04:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['dromaeo_dom']}, 18:04:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:04:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['basic_compositor_video']}, 18:04:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:04:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['a11yr', 18:04:51 INFO - 'ts_paint', 18:04:51 INFO - 'tpaint', 18:04:51 INFO - 'sessionrestore', 18:04:51 INFO - 'sessionrestore_no_auto_restore', 18:04:51 INFO - 'tabpaint']}, 18:04:51 INFO - 'other-e10s': {'tests': ['a11yr', 18:04:51 INFO - 'ts_paint', 18:04:51 INFO - 'tpaint', 18:04:51 INFO - 'sessionrestore', 18:04:51 INFO - 'sessionrestore_no_auto_restore', 18:04:51 INFO - 'tabpaint']}, 18:04:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:04:51 INFO - 'ts_paint', 18:04:51 INFO - 'tpaint', 18:04:51 INFO - 'sessionrestore', 18:04:51 INFO - 'sessionrestore_no_auto_restore', 18:04:51 INFO - 'tabpaint']}, 18:04:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:04:51 INFO - 'ts_paint', 18:04:51 INFO - 'tpaint', 18:04:51 INFO - 'sessionrestore', 18:04:51 INFO - 'sessionrestore_no_auto_restore', 18:04:51 INFO - 'tabpaint']}, 18:04:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['a11yr', 18:04:51 INFO - 'ts_paint', 18:04:51 INFO - 'tpaint', 18:04:51 INFO - 'sessionrestore', 18:04:51 INFO - 'sessionrestore_no_auto_restore', 18:04:51 INFO - 'tabpaint']}, 18:04:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['a11yr', 18:04:51 INFO - 'ts_paint', 18:04:51 INFO - 'tpaint', 18:04:51 INFO - 'sessionrestore', 18:04:51 INFO - 'sessionrestore_no_auto_restore', 18:04:51 INFO - 'tabpaint']}, 18:04:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['tsvgx', 18:04:51 INFO - 'tsvgr_opacity', 18:04:51 INFO - 'tart', 18:04:51 INFO - 'tscrollx', 18:04:51 INFO - 'cart']}, 18:04:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:04:51 INFO - 'tsvgr_opacity', 18:04:51 INFO - 'tart', 18:04:51 INFO - 'tscrollx', 18:04:51 INFO - 'cart']}, 18:04:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:51 INFO - 'talos_options': ['--disable-e10s'], 18:04:51 INFO - 'tests': ['tp5o']}, 18:04:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:51 INFO - 'tests': ['tp5o']}, 18:04:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:51 INFO - 'talos_options': ['--disable-e10s', 18:04:51 INFO - '--xperf_path', 18:04:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:51 INFO - 'tests': ['tp5n']}, 18:04:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:51 INFO - 'talos_options': ['--xperf_path', 18:04:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:51 INFO - 'tests': ['tp5n']}}, 18:04:51 INFO - 'talos.zip': {'path': '', 18:04:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:04:51 INFO - Running post-action listener: _resource_record_post_action 18:04:51 INFO - [mozharness: 2016-08-16 01:04:51.605367Z] Finished populate-webroot step (success) 18:04:51 INFO - [mozharness: 2016-08-16 01:04:51.605455Z] Running create-virtualenv step. 18:04:51 INFO - Running pre-action listener: _resource_record_pre_action 18:04:51 INFO - Running main action method: create_virtualenv 18:04:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:04:51 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 18:04:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:04:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:04:51 INFO - Using real prefix '/usr' 18:04:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:04:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:04:54 INFO - Installing pip.................done. 18:04:54 INFO - Return code: 0 18:04:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:04:54 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')]} 18:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:54 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')]} 18:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:54 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 0x7ff0f0239f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', '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 18:04:54 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 18:04:54 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 18:04:54 INFO - Using env: {'DISPLAY': ':0', 18:04:54 INFO - 'HOME': '/home/cltbld', 18:04:54 INFO - 'LANG': 'en_US.UTF-8', 18:04:54 INFO - 'LANGUAGE': 'en_US:en', 18:04:54 INFO - 'LOGNAME': 'cltbld', 18:04:54 INFO - 'MAIL': '/var/mail/cltbld', 18:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:54 INFO - 'MOZ_NO_REMOTE': '1', 18:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:54 INFO - 'NO_EM_RESTART': '1', 18:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:54 INFO - 'PWD': '/builds/slave/test', 18:04:54 INFO - 'SHELL': '/bin/bash', 18:04:54 INFO - 'SHLVL': '1', 18:04:54 INFO - 'TERM': 'linux', 18:04:54 INFO - 'TMOUT': '86400', 18:04:54 INFO - 'USER': 'cltbld', 18:04:54 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:54 INFO - '_': '/tools/buildbot/bin/python'} 18:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:54 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 18:04:54 INFO - Cleaning up... 18:04:54 INFO - Return code: 0 18:04:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:04:54 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')]} 18:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:54 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')]} 18:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:54 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 0x7ff0f0239f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', '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 18:04:54 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 18:04:54 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 18:04:54 INFO - Using env: {'DISPLAY': ':0', 18:04:54 INFO - 'HOME': '/home/cltbld', 18:04:54 INFO - 'LANG': 'en_US.UTF-8', 18:04:54 INFO - 'LANGUAGE': 'en_US:en', 18:04:54 INFO - 'LOGNAME': 'cltbld', 18:04:54 INFO - 'MAIL': '/var/mail/cltbld', 18:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:54 INFO - 'MOZ_NO_REMOTE': '1', 18:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:54 INFO - 'NO_EM_RESTART': '1', 18:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:54 INFO - 'PWD': '/builds/slave/test', 18:04:54 INFO - 'SHELL': '/bin/bash', 18:04:54 INFO - 'SHLVL': '1', 18:04:54 INFO - 'TERM': 'linux', 18:04:54 INFO - 'TMOUT': '86400', 18:04:54 INFO - 'USER': 'cltbld', 18:04:54 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:54 INFO - '_': '/tools/buildbot/bin/python'} 18:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:55 INFO - Downloading/unpacking psutil>=3.1.1 18:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:04:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:04:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:04:57 INFO - Installing collected packages: psutil 18:04:57 INFO - Running setup.py install for psutil 18:04:57 INFO - building 'psutil._psutil_linux' extension 18:04:57 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 18:04:58 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 18:04:58 INFO - building 'psutil._psutil_posix' extension 18:04:58 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 18:04:58 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 18:04:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:04:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:04:58 INFO - Successfully installed psutil 18:04:58 INFO - Cleaning up... 18:04:58 INFO - Return code: 0 18:04:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:04:58 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')]} 18:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:58 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')]} 18:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:58 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 0x7ff0f0239f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', '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 18:04:58 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 18:04:58 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 18:04:58 INFO - Using env: {'DISPLAY': ':0', 18:04:58 INFO - 'HOME': '/home/cltbld', 18:04:58 INFO - 'LANG': 'en_US.UTF-8', 18:04:58 INFO - 'LANGUAGE': 'en_US:en', 18:04:58 INFO - 'LOGNAME': 'cltbld', 18:04:58 INFO - 'MAIL': '/var/mail/cltbld', 18:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:58 INFO - 'MOZ_NO_REMOTE': '1', 18:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:58 INFO - 'NO_EM_RESTART': '1', 18:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:58 INFO - 'PWD': '/builds/slave/test', 18:04:58 INFO - 'SHELL': '/bin/bash', 18:04:58 INFO - 'SHLVL': '1', 18:04:58 INFO - 'TERM': 'linux', 18:04:58 INFO - 'TMOUT': '86400', 18:04:58 INFO - 'USER': 'cltbld', 18:04:58 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:58 INFO - '_': '/tools/buildbot/bin/python'} 18:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:05:00 INFO - Installing collected packages: mozsystemmonitor 18:05:00 INFO - Running setup.py install for mozsystemmonitor 18:05:00 INFO - Successfully installed mozsystemmonitor 18:05:00 INFO - Cleaning up... 18:05:00 INFO - Return code: 0 18:05:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:05:00 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')]} 18:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:00 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')]} 18:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:00 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 0x7ff0f0239f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', '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 18:05:00 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 18:05:00 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 18:05:00 INFO - Using env: {'DISPLAY': ':0', 18:05:00 INFO - 'HOME': '/home/cltbld', 18:05:00 INFO - 'LANG': 'en_US.UTF-8', 18:05:00 INFO - 'LANGUAGE': 'en_US:en', 18:05:00 INFO - 'LOGNAME': 'cltbld', 18:05:00 INFO - 'MAIL': '/var/mail/cltbld', 18:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:00 INFO - 'MOZ_NO_REMOTE': '1', 18:05:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:00 INFO - 'NO_EM_RESTART': '1', 18:05:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:00 INFO - 'PWD': '/builds/slave/test', 18:05:00 INFO - 'SHELL': '/bin/bash', 18:05:00 INFO - 'SHLVL': '1', 18:05:00 INFO - 'TERM': 'linux', 18:05:00 INFO - 'TMOUT': '86400', 18:05:00 INFO - 'USER': 'cltbld', 18:05:00 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:00 INFO - '_': '/tools/buildbot/bin/python'} 18:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:01 INFO - Downloading/unpacking jsonschema==2.5.1 18:05:01 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 18:05:01 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 18:05:01 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 18:05:01 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 18:05:01 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 18:05:01 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 18:05:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:05:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:05:02 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 18:05:02 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 18:05:02 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 18:05:02 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 18:05:02 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 18:05:02 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 18:05:03 INFO - Downloading functools32-3.2.3-2.tar.gz 18:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:05:03 INFO - warning: no files found matching '*.txt' 18:05:03 INFO - no previously-included directories found matching 'build' 18:05:03 INFO - no previously-included directories found matching 'dist' 18:05:03 INFO - no previously-included directories found matching '.git*' 18:05:03 INFO - Installing collected packages: jsonschema, functools32 18:05:03 INFO - Running setup.py install for functools32 18:05:03 INFO - warning: no files found matching '*.txt' 18:05:03 INFO - no previously-included directories found matching 'build' 18:05:03 INFO - no previously-included directories found matching 'dist' 18:05:03 INFO - no previously-included directories found matching '.git*' 18:05:03 INFO - Successfully installed jsonschema functools32 18:05:03 INFO - Cleaning up... 18:05:03 INFO - Return code: 0 18:05:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:03 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 0x7ff0f0239f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', '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 18:05:03 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 18:05:03 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 18:05:03 INFO - Using env: {'DISPLAY': ':0', 18:05:03 INFO - 'HOME': '/home/cltbld', 18:05:03 INFO - 'LANG': 'en_US.UTF-8', 18:05:03 INFO - 'LANGUAGE': 'en_US:en', 18:05:03 INFO - 'LOGNAME': 'cltbld', 18:05:03 INFO - 'MAIL': '/var/mail/cltbld', 18:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:03 INFO - 'MOZ_NO_REMOTE': '1', 18:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:03 INFO - 'NO_EM_RESTART': '1', 18:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:03 INFO - 'PWD': '/builds/slave/test', 18:05:03 INFO - 'SHELL': '/bin/bash', 18:05:03 INFO - 'SHLVL': '1', 18:05:03 INFO - 'TERM': 'linux', 18:05:03 INFO - 'TMOUT': '86400', 18:05:03 INFO - 'USER': 'cltbld', 18:05:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:03 INFO - '_': '/tools/buildbot/bin/python'} 18:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:05:03 INFO - Cleaning up... 18:05:03 INFO - Return code: 0 18:05:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:03 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 0x7ff0f0239f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', '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 18:05:03 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 18:05:03 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 18:05:03 INFO - Using env: {'DISPLAY': ':0', 18:05:03 INFO - 'HOME': '/home/cltbld', 18:05:03 INFO - 'LANG': 'en_US.UTF-8', 18:05:03 INFO - 'LANGUAGE': 'en_US:en', 18:05:03 INFO - 'LOGNAME': 'cltbld', 18:05:03 INFO - 'MAIL': '/var/mail/cltbld', 18:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:03 INFO - 'MOZ_NO_REMOTE': '1', 18:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:03 INFO - 'NO_EM_RESTART': '1', 18:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:03 INFO - 'PWD': '/builds/slave/test', 18:05:03 INFO - 'SHELL': '/bin/bash', 18:05:03 INFO - 'SHLVL': '1', 18:05:03 INFO - 'TERM': 'linux', 18:05:03 INFO - 'TMOUT': '86400', 18:05:03 INFO - 'USER': 'cltbld', 18:05:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:03 INFO - '_': '/tools/buildbot/bin/python'} 18:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:05:03 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 18:05:03 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 18:05:03 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 18:05:03 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 18:05:03 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 18:05:03 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 18:05:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:05:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:05:05 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 18:05:05 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 18:05:05 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 18:05:05 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 18:05:05 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 18:05:05 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 18:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:05:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:05:06 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 18:05:06 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 18:05:06 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 18:05:06 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 18:05:06 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 18:05:06 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 18:05:06 INFO - Downloading docopt-0.6.1.tar.gz 18:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:05:06 INFO - Installing collected packages: blobuploader, requests, docopt 18:05:06 INFO - Running setup.py install for blobuploader 18:05:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:05:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:05:06 INFO - Running setup.py install for requests 18:05:06 INFO - Running setup.py install for docopt 18:05:07 INFO - Successfully installed blobuploader requests docopt 18:05:07 INFO - Cleaning up... 18:05:07 INFO - Return code: 0 18:05:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:07 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 0x7ff0f0239f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', '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 18:05:07 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 18:05:07 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 18:05:07 INFO - Using env: {'DISPLAY': ':0', 18:05:07 INFO - 'HOME': '/home/cltbld', 18:05:07 INFO - 'LANG': 'en_US.UTF-8', 18:05:07 INFO - 'LANGUAGE': 'en_US:en', 18:05:07 INFO - 'LOGNAME': 'cltbld', 18:05:07 INFO - 'MAIL': '/var/mail/cltbld', 18:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:07 INFO - 'MOZ_NO_REMOTE': '1', 18:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:07 INFO - 'NO_EM_RESTART': '1', 18:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:07 INFO - 'PWD': '/builds/slave/test', 18:05:07 INFO - 'SHELL': '/bin/bash', 18:05:07 INFO - 'SHLVL': '1', 18:05:07 INFO - 'TERM': 'linux', 18:05:07 INFO - 'TMOUT': '86400', 18:05:07 INFO - 'USER': 'cltbld', 18:05:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:07 INFO - '_': '/tools/buildbot/bin/python'} 18:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:07 INFO - Running setup.py (path:/tmp/pip-KBbLmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:07 INFO - Running setup.py (path:/tmp/pip-dVXMSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:07 INFO - Running setup.py (path:/tmp/pip-t6ZIRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:07 INFO - Running setup.py (path:/tmp/pip-F9O7Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:07 INFO - Running setup.py (path:/tmp/pip-GKcmFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:07 INFO - Running setup.py (path:/tmp/pip-p9s8kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:07 INFO - Running setup.py (path:/tmp/pip-IBRd7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:07 INFO - Running setup.py (path:/tmp/pip-QbpIVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:07 INFO - Running setup.py (path:/tmp/pip-pyR8ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:07 INFO - Running setup.py (path:/tmp/pip-w2umTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:08 INFO - Running setup.py (path:/tmp/pip-HsBEiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:08 INFO - Running setup.py (path:/tmp/pip-PyxlY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:08 INFO - Running setup.py (path:/tmp/pip-G9MYG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:08 INFO - Running setup.py (path:/tmp/pip-rZyhI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:08 INFO - Running setup.py (path:/tmp/pip-KmqZdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:08 INFO - Running setup.py (path:/tmp/pip-1M7WVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:08 INFO - Running setup.py (path:/tmp/pip-swsTvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:05:08 INFO - Running setup.py install for manifestparser 18:05:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:05:08 INFO - Running setup.py install for mozcrash 18:05:08 INFO - Running setup.py install for mozdebug 18:05:08 INFO - Running setup.py install for mozdevice 18:05:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:05:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:05:08 INFO - Running setup.py install for mozfile 18:05:09 INFO - Running setup.py install for mozhttpd 18:05:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Running setup.py install for mozinfo 18:05:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Running setup.py install for mozInstall 18:05:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Running setup.py install for mozleak 18:05:09 INFO - Running setup.py install for mozlog 18:05:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Running setup.py install for moznetwork 18:05:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Running setup.py install for mozprocess 18:05:09 INFO - Running setup.py install for mozprofile 18:05:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Running setup.py install for mozrunner 18:05:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:05:09 INFO - Running setup.py install for mozscreenshot 18:05:10 INFO - Running setup.py install for moztest 18:05:10 INFO - Running setup.py install for mozversion 18:05:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:05:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:05:10 INFO - Cleaning up... 18:05:10 INFO - Return code: 0 18:05:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:10 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 0x7ff0f0239f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', '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 18:05:10 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 18:05:10 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 18:05:10 INFO - Using env: {'DISPLAY': ':0', 18:05:10 INFO - 'HOME': '/home/cltbld', 18:05:10 INFO - 'LANG': 'en_US.UTF-8', 18:05:10 INFO - 'LANGUAGE': 'en_US:en', 18:05:10 INFO - 'LOGNAME': 'cltbld', 18:05:10 INFO - 'MAIL': '/var/mail/cltbld', 18:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:10 INFO - 'MOZ_NO_REMOTE': '1', 18:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:10 INFO - 'NO_EM_RESTART': '1', 18:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:10 INFO - 'PWD': '/builds/slave/test', 18:05:10 INFO - 'SHELL': '/bin/bash', 18:05:10 INFO - 'SHLVL': '1', 18:05:10 INFO - 'TERM': 'linux', 18:05:10 INFO - 'TMOUT': '86400', 18:05:10 INFO - 'USER': 'cltbld', 18:05:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:10 INFO - '_': '/tools/buildbot/bin/python'} 18:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:10 INFO - Running setup.py (path:/tmp/pip-6hLXZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:10 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)) 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:10 INFO - Running setup.py (path:/tmp/pip-Uwyr6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:10 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)) 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:10 INFO - Running setup.py (path:/tmp/pip-_UUrNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:10 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)) 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:10 INFO - Running setup.py (path:/tmp/pip-AoiSOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:10 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)) 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:10 INFO - Running setup.py (path:/tmp/pip-JZZ9er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:10 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)) 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:10 INFO - Running setup.py (path:/tmp/pip-LdMeNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:10 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)) 18:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:10 INFO - Running setup.py (path:/tmp/pip-JljitS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:11 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)) 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:11 INFO - Running setup.py (path:/tmp/pip-UBP1Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:11 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)) 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:11 INFO - Running setup.py (path:/tmp/pip-d1dk1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:11 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)) 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:11 INFO - Running setup.py (path:/tmp/pip-ULeWDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:11 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)) 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:11 INFO - Running setup.py (path:/tmp/pip-IL0aLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:11 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)) 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:11 INFO - Running setup.py (path:/tmp/pip-o3BoTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:11 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)) 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:11 INFO - Running setup.py (path:/tmp/pip-TWAFxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:11 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)) 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:11 INFO - Running setup.py (path:/tmp/pip-vr6osZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:11 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)) 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:11 INFO - Running setup.py (path:/tmp/pip-K8IJEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:11 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)) 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:11 INFO - Running setup.py (path:/tmp/pip-61t3Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:11 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)) 18:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:11 INFO - Running setup.py (path:/tmp/pip-PWDm9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:11 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)) 18:05:11 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)) 18:05:11 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)) 18:05:11 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)) 18:05:11 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)) 18:05:11 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)) 18:05:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:05:11 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 18:05:11 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 18:05:11 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 18:05:11 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 18:05:11 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 18:05:11 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 18:05:13 INFO - Downloading blessings-1.6.tar.gz 18:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:05:13 INFO - Installing collected packages: blessings 18:05:13 INFO - Running setup.py install for blessings 18:05:13 INFO - Successfully installed blessings 18:05:13 INFO - Cleaning up... 18:05:13 INFO - Return code: 0 18:05:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:05:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:14 INFO - Reading from file tmpfile_stdout 18:05:14 INFO - Current package versions: 18:05:14 INFO - argparse == 1.2.1 18:05:14 INFO - blessings == 1.6 18:05:14 INFO - blobuploader == 1.2.4 18:05:14 INFO - docopt == 0.6.1 18:05:14 INFO - functools32 == 3.2.3-2 18:05:14 INFO - jsonschema == 2.5.1 18:05:14 INFO - manifestparser == 1.1 18:05:14 INFO - mozInstall == 1.12 18:05:14 INFO - mozcrash == 0.17 18:05:14 INFO - mozdebug == 0.1 18:05:14 INFO - mozdevice == 0.48 18:05:14 INFO - mozfile == 1.2 18:05:14 INFO - mozhttpd == 0.7 18:05:14 INFO - mozinfo == 0.9 18:05:14 INFO - mozleak == 0.1 18:05:14 INFO - mozlog == 3.3 18:05:14 INFO - moznetwork == 0.27 18:05:14 INFO - mozprocess == 0.23 18:05:14 INFO - mozprofile == 0.28 18:05:14 INFO - mozrunner == 6.12 18:05:14 INFO - mozscreenshot == 0.1 18:05:14 INFO - mozsystemmonitor == 0.3 18:05:14 INFO - moztest == 0.7 18:05:14 INFO - mozversion == 1.4 18:05:14 INFO - psutil == 3.1.1 18:05:14 INFO - requests == 1.2.3 18:05:14 INFO - wsgiref == 0.1.2 18:05:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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')]} 18:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:14 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 0x7ff0f0239f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', '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 18:05:14 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 18:05:14 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 18:05:14 INFO - Using env: {'DISPLAY': ':0', 18:05:14 INFO - 'HOME': '/home/cltbld', 18:05:14 INFO - 'LANG': 'en_US.UTF-8', 18:05:14 INFO - 'LANGUAGE': 'en_US:en', 18:05:14 INFO - 'LOGNAME': 'cltbld', 18:05:14 INFO - 'MAIL': '/var/mail/cltbld', 18:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:14 INFO - 'MOZ_NO_REMOTE': '1', 18:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:14 INFO - 'NO_EM_RESTART': '1', 18:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:14 INFO - 'PWD': '/builds/slave/test', 18:05:14 INFO - 'SHELL': '/bin/bash', 18:05:14 INFO - 'SHLVL': '1', 18:05:14 INFO - 'TERM': 'linux', 18:05:14 INFO - 'TMOUT': '86400', 18:05:14 INFO - 'USER': 'cltbld', 18:05:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:14 INFO - '_': '/tools/buildbot/bin/python'} 18:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:14 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)) 18:05:14 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)) 18:05:14 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)) 18:05:14 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)) 18:05:14 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)) 18:05:14 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)) 18:05:14 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)) 18:05:14 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)) 18:05:14 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)) 18:05:14 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)) 18:05:14 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)) 18:05:14 INFO - Cleaning up... 18:05:14 INFO - Return code: 0 18:05:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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')]} 18:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0f0239f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', '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 18:05: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', 'jsonschema'] in /builds/slave/test/build 18:05: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 jsonschema 18:05:14 INFO - Using env: {'DISPLAY': ':0', 18:05:14 INFO - 'HOME': '/home/cltbld', 18:05:14 INFO - 'LANG': 'en_US.UTF-8', 18:05:14 INFO - 'LANGUAGE': 'en_US:en', 18:05:14 INFO - 'LOGNAME': 'cltbld', 18:05:14 INFO - 'MAIL': '/var/mail/cltbld', 18:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:14 INFO - 'MOZ_NO_REMOTE': '1', 18:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:14 INFO - 'NO_EM_RESTART': '1', 18:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:14 INFO - 'PWD': '/builds/slave/test', 18:05:14 INFO - 'SHELL': '/bin/bash', 18:05:14 INFO - 'SHLVL': '1', 18:05:14 INFO - 'TERM': 'linux', 18:05:14 INFO - 'TMOUT': '86400', 18:05:14 INFO - 'USER': 'cltbld', 18:05:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:14 INFO - '_': '/tools/buildbot/bin/python'} 18:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:05:14 INFO - Cleaning up... 18:05:14 INFO - Return code: 0 18:05:14 INFO - Running post-action listener: _resource_record_post_action 18:05:14 INFO - Running post-action listener: _start_resource_monitoring 18:05:14 INFO - Starting resource monitoring. 18:05:14 INFO - [mozharness: 2016-08-16 01:05:14.640237Z] Finished create-virtualenv step (success) 18:05:14 INFO - [mozharness: 2016-08-16 01:05:14.641224Z] Running install step. 18:05:14 INFO - Running pre-action listener: _resource_record_pre_action 18:05:14 INFO - Running main action method: install 18:05:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:14 INFO - Reading from file tmpfile_stdout 18:05:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:05:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:05:14 INFO - Reading from file tmpfile_stdout 18:05:14 INFO - Output received: 18:05:14 INFO - Usage: mozinstall [options] installer 18:05:14 INFO - Options: 18:05:14 INFO - -h, --help show this help message and exit 18:05:14 INFO - -d DEST, --destination=DEST 18:05:14 INFO - Directory to install application into. [default: 18:05:14 INFO - "/builds/slave/test"] 18:05:14 INFO - --app=APP Application being installed. [default: firefox] 18:05:14 INFO - mkdir: /builds/slave/test/build/application 18:05:14 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'] 18:05:14 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 18:05:31 INFO - Reading from file tmpfile_stdout 18:05:31 INFO - Output received: 18:05:31 INFO - /builds/slave/test/build/application/firefox/firefox 18:05:31 INFO - Running post-action listener: _resource_record_post_action 18:05:31 INFO - [mozharness: 2016-08-16 01:05:31.831638Z] Finished install step (success) 18:05:31 INFO - [mozharness: 2016-08-16 01:05:31.831878Z] Running run-tests step. 18:05:31 INFO - Running pre-action listener: _resource_record_pre_action 18:05:31 INFO - Running main action method: run_tests 18:05:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:05:31 INFO - Python 2.7.3 18:05:31 INFO - Return code: 0 18:05:31 INFO - grabbing minidump binary from tooltool 18:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:31 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 0xce1370>, '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 0xce48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce4d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:05:31 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 18:05:31 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 18:05:31 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 18:05:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:05:32 INFO - Return code: 0 18:05:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:05:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:05:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:05:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:05:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:05:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:05:32 INFO - Using env: {'DISPLAY': ':0', 18:05:32 INFO - 'HOME': '/home/cltbld', 18:05:32 INFO - 'LANG': 'en_US.UTF-8', 18:05:32 INFO - 'LANGUAGE': 'en_US:en', 18:05:32 INFO - 'LOGNAME': 'cltbld', 18:05:32 INFO - 'MAIL': '/var/mail/cltbld', 18:05:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:05:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:32 INFO - 'MOZ_NO_REMOTE': '1', 18:05:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:32 INFO - 'NO_EM_RESTART': '1', 18:05:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:32 INFO - 'PWD': '/builds/slave/test', 18:05:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:05:32 INFO - 'SHELL': '/bin/bash', 18:05:32 INFO - 'SHLVL': '1', 18:05:32 INFO - 'TERM': 'linux', 18:05:32 INFO - 'TMOUT': '86400', 18:05:32 INFO - 'USER': 'cltbld', 18:05:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214', 18:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:32 INFO - '_': '/tools/buildbot/bin/python'} 18:05:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:05:32 INFO - mozversion application_buildid: 20160815163002 18:05:32 INFO - mozversion application_changeset: 054d4856cea6150a6638e5daf7913713281af97d 18:05:32 INFO - mozversion application_display_name: Nightly 18:05:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:05:32 INFO - mozversion application_name: Firefox 18:05:32 INFO - mozversion application_remotingname: firefox 18:05:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:05:32 INFO - mozversion application_vendor: Mozilla 18:05:32 INFO - mozversion application_version: 51.0a1 18:05:32 INFO - mozversion platform_buildid: 20160815163002 18:05:32 INFO - mozversion platform_changeset: 054d4856cea6150a6638e5daf7913713281af97d 18:05:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:05:32 INFO - mozversion platform_version: 51.0a1 18:05:32 INFO - using testdate: 1471309532 18:05:32 INFO - actual date: 1471309532 18:05:32 INFO - starting webserver on 'localhost:50403' 18:05:32 INFO - SUITE-START | Running 2 tests 18:05:32 INFO - TEST-START | dromaeo_css 18:05:32 INFO - operating with platform_type : linux_ 18:05:32 INFO - Initialising browser for dromaeo_css test... 18:05:32 INFO - TEST-INFO | started process 3295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPoKXuJ/profile http://localhost:50403/getInfo.html) 18:05:38 INFO - PROCESS | 3295 | __metrics Screen width/height:1600/1200 18:05:38 INFO - PROCESS | 3295 | colorDepth:24 18:05:38 INFO - PROCESS | 3295 | Browser inner width/height: 1024/697 18:05:38 INFO - PROCESS | 3295 | __metrics 18:05:39 ERROR - PROCESS | 3295 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 18:05:39 INFO - TEST-INFO | 3295: exit 0 18:05:39 INFO - Browser initialized. 18:05:39 INFO - Running cycle 1/1 for dromaeo_css test... 18:05:39 INFO - TEST-INFO | started process 3414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPoKXuJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:05:51 INFO - PROCESS | 3414 | RSS: Main: 163377152 18:05:51 INFO - PROCESS | 3414 | 18:06:41 INFO - PROCESS | 3414 | 1471309601257 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] 18:08:50 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50403/tests/dromaeo/cssquery-ext.html) 18:08:51 INFO - PROCESS | 3414 | RSS: Main: 164519936 18:08:51 INFO - PROCESS | 3414 | 18:11:54 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-ext.html (next: http://localhost:50403/tests/dromaeo/cssquery-jquery.html) 18:11:54 INFO - PROCESS | 3414 | RSS: Main: 166154240 18:11:54 INFO - PROCESS | 3414 | 18:14:56 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50403/tests/dromaeo/cssquery-mootools.html) 18:14:57 INFO - PROCESS | 3414 | RSS: Main: 166379520 18:14:57 INFO - PROCESS | 3414 | 18:17:59 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50403/tests/dromaeo/cssquery-prototype.html) 18:17:59 INFO - PROCESS | 3414 | RSS: Main: 164511744 18:17:59 INFO - PROCESS | 3414 | 18:21:02 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50403/tests/dromaeo/cssquery-yui.html) 18:21:03 INFO - PROCESS | 3414 | RSS: Main: 165928960 18:21:03 INFO - PROCESS | 3414 | 18:24:05 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-yui.html (next: http://localhost:50403/tests/dromaeo/cssquery-dojo.html) 18:24:06 INFO - PROCESS | 3414 | RSS: Main: 166637568 18:24:06 INFO - PROCESS | 3414 | 18:24:06 INFO - PROCESS | 3414 | __start_tp_report 18:24:06 INFO - PROCESS | 3414 | _x_x_mozilla_page_load 18:24:06 INFO - PROCESS | 3414 | _x_x_mozilla_page_load_details 18:24:06 INFO - PROCESS | 3414 | |i|pagename|runs| 18:24:06 INFO - PROCESS | 3414 | |0;dojo.html;3082.953755693665;3117.6258848938132;3126.4997600383945;3140.38762441324;3151.1019359482552;5355.678659280446;5423.29497165369;5452.809151679687;5458.099413596757;5526.944730552704;5267.367915850094;5333.893322133555;5352.116900711388;5382.838514844551;5398.973005134969;4776.498467660897;4796.999999999991;4883.9511604883855;4934.580560652349;5002.77487513061;4860.8055677772845;4924.236743304776;4937.753112344369;4983.277424773424;5016.573591244731;4827.493113223114;4849.224124140138;4897.583705385046;4898.044881248158;4953.306537084811;4919.72941488218;4927.014597080562;4936;4940.975295123501;4971.776270067856;4801.159797035505;4822.590079843218;4825.517448255181;4850.53919877611;4886.975565122188;5290.444503327134;5328.4671532846405;5381.192821076831;5410.08028635133;5416.647917885325;5733.140028995643;5782.045962416196;5782.190493330937;5784.537237021028;5784.88430231393;5657.60396772222;5804.419558044204;5806.767729290823;5815.185873977646;5817.301923769175;5390.6226564140525;5404.243405923174;5429;5477.04151773438;5519.834404967857;6000.279966403972;6001.369856165127;6011.428914253139;6013.398660133952;6015.0676645120075;5427.701476418756;5728.684922329228;5757.827265182052;5759.164921086419;5760.193572899798;5602.719864006784;5626.859328516738;5672.688002159838;5675.801346952837;5737.741801618937;5671.943280567141;5699.230603868425;5760.94239057604;5788.363280039192;5797.130430435468;5722.284714410699;5738.454846789548;5780.421957804186;5791.82624521265;5803.9419605803405;4301.09676967834;4347.413099231627;4349.064951035542;4351.804168812348;4470.105978804252;3879.553851307136;3892.2215556888737;3897.902552436155;3908.1988192421054;3934.9803250983564;5416.0792665247;5456.563474921997;5459.317585301837;5461.208124821958;5513.641613295123;5679.971600142056;5771.192033115367;5800.216970708984;5869.266341707286;5879.647221166743;5654.547636189095;5662.68855212959;5664.631798933138;5670.829875103754;5672.177534257509;5095.515925987025;5103.5406813386235;5107.259447380184;5110.182370820725;5137.486251374908;5779.306483221956;5965.463108320272;6015.699215039318;6050.21347224858;6129.3870612939245;5832.62087964281;5855.121731740273;5869.970650146722;5877.794277200277;5880.323762767336;6048.818535443767;6099.054646529795;6110.877782444238;6112.2970858351855;6126.111713801385;5488.341399032141;5549.417311182267;5550;5581.804636837854;5746.224259724883;5628.296462942132;5700.629459085146;5703.543716502752;5722.313322401172;5733.254676892144;5530.806421775219;5569.693666848362;5571.749271282721;5575.163725441216;5588.720563971704;5463.863403414946;5543.1685247213245;5599.776008959759;5660.179274005164;5680.772769089355;5632.239647647515;5641.210230567642;5643.548516118619;5644.153376993319;5658.20785090096;5606.215129881738;5623.831285061455;5658.03813351723;5674.319081710221;5680.886382272249;5380.219868119179;5395.70323632204;5400.486953739389;5432.782688692408;5465.617406781487 18:24:06 INFO - PROCESS | 3414 | |1;ext.html;538.7961538824462;590.5482306035882;599.5892813422805;605.4913872347229;616.7255571270781;38954;43405.34891976623;43441.78279108604;43609.56390436095;43619.78190109053;43767.56232437675;43844.78077609615;44179.337309940376;44284;44349.899761527435;8769.912300877006;8895.288376929862;8925.509096999662;8929.642814287421;8944.329175311845;8795.340349473816;8816.382853200279;8880.200781929625;8905.243054340357;8909.1536304051;8945.776355591097;8953.283737301033;8962;8966.86549701755;8994.955025224897;8804.603792829274;8867.645294188193;8894.955525222365;8934.944962658625;8939.374243802937;8817.823643527094;8838.955805220932;8857.247133993618;8863.069377715312;8875.378723489293;41677.583224167676;42002.78998605018;42091;42184.36723449151;42273.15453690909;3414.8110971422266;4061.3298805697023;4260.382244574519;4312.417823593806;4426.75652839097;33022.50466243008;33135.502967455504;33229.16927076818;33392.16519587005;35278.47082293768;3966.147278335143;4044.4539987101657;4083.448734420845;4123.330051329216;4270.274053410928;343908;344605;344678.27660861786;345464;345731;59849.700751496835;61199.38800612026;61459.69270153621;61465.69267153636;61637;62983.16575754102;63021.68489157525;63353.68323158355;63472.68263658652;63496.68251658712;14843.628909277355;15739.370425182864;16010.279537420844;16020.839791601935;16746.162691865356;11268.38023908693;11278.774424511465;11342.546298148147;11344.943275283571;11397;19519.92323569547;19623.70564441506;19662.213511459668;19698.31055913036;19770.703439448418;7049.766290899175;7237.276272372826;7239;7385.29839665231;7600.821872609754;954.6849539651898;1025.2413214221422;1042.3485321673954;1054.9578016879393;1166.055495049013;33219;33291.500627490605;33556.66443335584;33588.49617255743;33750.15624609355;1106.0985296982933;1117.1844553475846;1118.6084870295495;1129.0910816792398;1181.3797756178076;18002.140741293955;19249.51876203106;19438.514037149183;19455.416337509898;19644.607107857762;572907;574508;578996;581496;581713;60443.09335359973;60485.09272360918;60678.39321606816;61131.69434152801;61474;1333.3533236380347;1377.2149874571599;1387.840398354202;1403.3264033263886;1410.2737090398452;32478.35043299168;33890.830545847115;34899;34979;34987.7754278599;51434.74282628563;52097.479025209264;52338;52367;52489.47510524846;413137;416869;417888;418694;419992;30463.238419039702;30586.694133059274;30735.2316192097;30994.535081974238;31070;50152;50434.49565504445;50916;50996.49003510066;51243.23135152901;40754.60428073668;43792.562074378846;43928.56071439245;44464;44701.776491117336;42290.36564451597;42845.143097138505;43266.56733432751;44076;44882.326765097896;41781.58218417777;42321.576784232995;43395;43450.130997379245;43503.56496434995;34795;37245.78849203631;38634.42048369221;39328;40595.7970210147;29112.708872911848;29214.56178157287;29246;29375.85312073426;29709.58339790952 18:24:06 INFO - PROCESS | 3414 | |2;jquery.html;392.77493002142864;400.111751910758;413.47488689364496;413.99172016559663;430.76523294804326;19114.522136946565;19843.10706018229;19907.701384479227;20537.28119515817;21047;18556.35052773153;18922.432327030212;19151.904240478812;19256.326028589003;19310.806891931075;5547.639403438784;5555.472230138131;5855.355910849825;5891.145783861359;5963.880722385549;5769.134629805541;5876.08920617305;5910.34986151523;5936.64380137191;5958.165856780054;5892.646441213541;5933.288005439332;5933.406659334075;5936.079907614327;5950.285965684124;5729.942700572982;5848.7075646217945;5932.88134237315;5939.703014849262;5961.344252132262;5732.369439361667;5740.655560666331;5741;5744;5748.42515748426;13552.186868787805;19427.4171774847;23687.407814804596;23701.170459033852;23857.284281471584;2207.249535158054;2276.590213761522;2462.1259452894324;2641.1152263991585;2756;10032.398056116583;10033.548490317953;10058.245631577662;10586.788264234672;10597.788044239072;1924.6920492721238;1953.1210955070133;1958.5397431603562;1962.7154062660834;1988.8508361872916;80819.19180808176;87327;88616.556917215;89344.5532772332;91983;8896.59965301563;9448.480333581581;9452.243820494345;9656.71029869105;9822.803543929082;12522.436490357955;12550.623481295575;12581.245125292511;12589.811152832715;12645.620631381073;7034.155901291878;7430;7438.256174382626;7448.4041276697735;7603.2776886195725;7326.597037162901;7356.632168391559;7422.406207503387;7423.078828717173;7567.848643027109;3897.18159186574;3905.4727611772614;3908.257431088084;3981.0843505993785;3983.083890705096;1820.7724034495689;1871.6350311689362;1879.248300679739;1897.24110355856;1902.6099649571804;432.1810169728347;478.64580210643874;482.14178761804044;483.94434640016146;1018.2821111116644;11288.20982531215;11846.822297665542;12091.093168012258;12126.333051682066;12474.376281185905;456.940597722294;468.8687167593079;470.1654563150435;471.79712723528525;486.37743688079314;6250.781222657185;6268.122462855204;6452.161219041494;6453.9354606453335;6588.176477940257;446562.767186162;463282;474983;475692;498895;62672.68663656653;91608;93012.53493732623;94589;95443.52278238564;479.7553247843625;490.70802872290216;490.76443307212026;491.0424671889829;492.2124600638949;11419.885801141882;11590.145576708024;11820.813149567357;12089.637310880687;12101.576444824388;39747.40378894377;40511.80590945015;41060.38409423801;42611.147777044906;43008.35487467628;60522.394776051675;61044.69477652583;61167.38832611617;61670.38329616647;63331;5492;5973.074173503114;7415.110186777405;7465.850682986418;7668.1181664109345;9467.242620590474;13065.804012939623;13735.381907814372;13854.16874987504;13859.722805543632;11422.25755325901;11687.298762074302;12106.818397724217;12213.328266945404;12372.381380931098;11461.770764584828;11555.942220288845;11741.119416044;11933.82099268529;12159.209651372632;12272.631821045383;12287.385630718249;12335.75328493443;12477.93761031189;12603.97504598908;7647.885281720667;7677.078750549969;7747.845043098993;7754.263344982218;7879.251471110236;11193.328400296008;12274.877251227374;12370.876291237333;12436.19164754288;12701.491940322283 18:24:06 INFO - PROCESS | 3414 | |3;mootools.html;1499.1754535005748;1510.486434612232;1647.5716313758426;1757.3058641836483;1772.48597906607;8023.077346105185;8539.573021348939;8691.130886911305;9304;9315.953420232898;9017.188453039225;9037.593308301126;9094.86357704635;9098.454092754422;9102.408343457671;2371.347879333184;2431.3435372449426;2434.75652434756;2434.8904299306573;2441.2432146034785;2349.5888219561593;2395.0659242895285;2422.588160012802;2423.7939775119135;2426.4176597616533;2402.987985060081;2413.78275955164;2428.9878550607223;2449.497852940152;2453.288546321565;2370.3007612754277;2373.027058905849;2373.4303767095944;2383.02296058616;2419.588669926099;2337.368910394201;2361.53949979754;2383.4041489627593;2383.4398916254668;2387.0809738250723;8888.600012999366;8983.236424903891;9010.909890901072;9026.187643112085;9050.185483306468;5236.6857988520815;5293.814716484904;5350.063738845686;5353.839384818461;5357.276767636358;3544.397452433067;3682.6317368263226;3694.4273637586216;3726.6087060858763;3776.527934008249;1200.6398080575793;1206.5354838387284;1249.9437525311291;1258.1444617659988;1260.6785269756244;12400.937995309965;12502.187357821804;12515.123941324111;12633.557825476064;12649.557265495663;4396.340548917624;4636.281376386598;4683.531646835289;4815;4841.2496063110275;9591.42451452915;9593.088656577615;9593.088656577753;9593.13661770444;9612.903870961341;5345.54562862161;5377.973110134424;5404.567634589223;5409.513143817076;5413.810516631899;4492.685512014193;4903.8528844134735;5016.19740841471;5043.2687260347775;5059.114654935372;3842.731008829411;3843.26977874203;3912.726109172331;3916.6096035907412;4009.979950100231;1195.2469943935266;1197.6107764976243;1204.903607711381;1212.4240985531978;1212.7574485103014;868.6568805321863;885.5262434597588;890.519119675381;1008.2186305613209;1034.2036631793476;6076.574639775262;6122.66325352101;6199.194104766351;6263.530235232376;6328.905066424008;464.69562436604076;464.74671304139326;469.3335463641637;472.1359911362199;481.7711586996219;3897.7466464680274;4066.959330406717;4068.0846809468226;4104.856330028494;4116.423700681907;10914.181436392144;11369.31784092957;11373.147013973985;11438.256513326607;11438.542458301741;11078.446077696082;11085.390303533382;11321.773564528663;11329.830052549218;11389.715257118638;8367.414281000394;8469.534175620276;8517.48895066298;8541.14588541141;8589.957050214834;6018.307894592178;6025.6083354581815;6033;6207.441330280297;6297.622142671271;10332.741681458023;10347.223958203014;10528.157747380345;10545.420001899969;10645.0951669109;10339.534720937425;10341.224408169266;10493;10517.263791534826;10711.08955738771;6865.862682746417;7346.081739782528;7476.5514069156025;7549.1695913448375;7640.968469256579;8752.431091979;8829.955850220707;8864.955675221583;8872.024077351616;8874.156955089256;7712.305892469704;7896.763097107096;7920.287174154354;7998.48009879356;8014.398920080901;7723.150453450004;7871.960640196762;7916.762497125095;7932.36541076724;7946.92053079485;7306.232845551353;7411.5553066816165;7415.888761668687;7424.331810136898;7425.108986921604;5275.314209152785;5290.312259406252;5413.24214609947;5449.100898351728;5460.91808622863;5327.493888080626;5334.46655334479;5342.412334643109;5381.5694744421135;5503.174523821459 18:24:06 INFO - PROCESS | 3414 | |4;prototype.html;332.42100024881813;340.36861621691776;340.6236109099445;343.00186457408944;350.259201788218;5396.91904621431;5441.483059109383;5458.590605704569;5538.9723051384735;5587.8603034924145;5455.1544510600825;5489.64317319374;5505.642133261335;5512;5522.420145884685;4213.136307057046;4236.364545318196;4248.405223268729;4261.87214383569;4266.887890494209;4104.839273759204;4234.30134027885;4240.091958618634;4247.723897946639;4268.335349213794;4223.176480586287;4225.091605304859;4228.788560571975;4231.619154276114;4238.978805105986;4218.894527636803;4243.236217480852;4249.978750106261;4255.17024180285;4263.339182426729;3534.805585692786;3650.7809531428197;3675.9264814703824;3689.465027571014;3762.698984081267;5393.379761327419;5409.864753381157;5411.161270003156;5413.458654134594;5414.620976531644;4884.535969082967;4885.8778530536665;4888.340074089988;4889.33993910821;4891.706497610119;5427.538659213971;5700.629459085146;5706.800261990852;5748.137779333092;5800.187973683687;4033.9394909076386;4038.717289789716;4043.878683639466;4048.4939382577177;4052.797360132011;6007.609505382136;6023.849403764897;6037.154798328237;6047.341358478146;6073.423024812591;3927.9214415711526;4117.876463706094;4148.585141485827;4161.146964872194;4164.646005089541;4202.159568086334;4203.285441474956;4212.157568486315;4220.261454245556;4221.704480686322;4821.614270858323;4837.080954618682;4843.660943733905;4849.9687695190505;4855.975720121447;5621;5795.304563452329;5835.183074369592;5842.474177324061;5847.8245652630485;1459.4016453254114;1486.5837565481681;1494.1334026264958;1494.1483354488055;1503.2033022498094;1008.5007921079113;1039.7608550033383;1049.9370037797758;1067.957281708723;1082.0910435234284;4869.878253043631;4896.510348965075;4947.6536642434685;5004.199328107558;5035.84892453227;5151.5363617274625;5159.2003239497935;5199.740012999335;5208.739563021833;5248.606354523426;4714.622830173578;4947.476786838666;4954.504549545017;4958.900821983612;4976.029674213493;2725.8687644627653;2761.8895244190007;2762.875670594828;2771.542695455227;2778.610694652674;5336.252924590561;5386.676799392049;5408.9729551352775;5434.402215756264;5439.456054394608;5117.641765076483;5195.155719719445;5242;5256.92114618281;5279.868003299872;5289.312389389354;5340.572754179656;5350.8127215547265;5377.569794416438;5395.89384176235;5181.031208140882;5200.375954885438;5210.817621383233;5219.81730639441;5226.372835259641;4930.531599498042;5073.644844860824;5111.539961403343;5140.17523779068;5160.509751573594;5339.196921616182;5372.247885296139;5384.1424708475515;5398.2712333836;5408.864778380572;3872.302985462644;3887.688984881146;3899.245339597136;3904.5900180481776;3923.2545816294814;4973.975130124326;5191.183085920049;5219.556337711185;5685.175649530877;5815.680137592473;5809.24479817621;5812.505936995402;5820.370296317038;5842.970785146047;5854.443827836349;5813.941860581509;5814.5348372130975;5832.766689332549;5863.1791549184;5873.970630146822;5528;5666.716664166857;5684.602077854676;5720.599558030898;5729.166666666627;5846.327672317738;5862.3844496328975;5863.765449381977;5870.5010074142465;5914.137046830235;5545.059229269723;5596.664200148004;5671.206031155724;5745.735938093612;5768.596198266081 18:24:06 INFO - PROCESS | 3414 | |5;yui.html;714.8034290570093;742.8142964258939;765.6860687118283;796.1878883538794;812.7155495576548;15325.69348613027;16422.917885410556;16535.090570018674;16547.58631034223;16623.41818036369;14666.413343466249;15315.540533784004;15492.767608485881;15510.767338489932;15537.22313884307;797.0554892452448;813.9470934389275;815.1074573342181;816.5998660656265;817.235884448043;805.9435839491238;828.0891019878146;831.6714897615439;832.9167083291653;833.0919297965216;868.04515033463;868.9217970382664;870.0559892516627;870.2646263906988;870.5386145342978;858.4849090545686;860.5224100624151;862.4264863865553;863.4387648028769;864.7621903976394;632.1971096707202;632.6931438252444;633.262249479356;634.6794868591331;635.0727937211676;15588.844111558967;15682.921585392114;15691.529254122395;15732.606684832856;15772.211389430597;15136;15241.771373429407;15415.768763468557;15477.535673929688;15665.921670391688;11987.460564274628;12317.753644927052;12331.075169362244;12501.437435315433;12630.621081367573;3923.784191869446;3946.8223929923224;3957.2481228566767;4130;4132.028973191298;90243;92417.99999999933;92780.53609731975;93046;94256.52871735666;11189.041917664375;11221.60724374643;11315.773684526428;11404.657860264206;11451.19841611096;22275.665865011713;22325.99533021018;22461.55076898453;22477.887610561844;22487.32538023862;8275.337972962268;8334.916650833535;8397.244248017707;8491.448055876348;8492.02341730709;4617.815287388534;4738.810447582127;4781.737004464788;4803.879903002453;4864;3494.633063528344;3662.7069834413182;3713.405855063177;3714.4428335749853;3722.8324725387424;616.2235583165244;620.7920346683821;623.7442648514087;630.1115427247559;654.3391174913372;719.0113593808513;725.2928394815013;729.3071581997124;737.959926599704;758.6017340896074;10557.419341936115;10644.520996555173;10699.304545204537;10911.781764364669;10927.344359338465;747.6822350501124;755.920628334028;761.9161892191854;767.2902565127235;773.1765669561898;4812.422509298836;4937.925931111036;5001.299818025479;5001.774920128603;5109.744512774347;128544.14367568988;129938.35030824975;132670;133698;134632.32683836517;88913.55543222371;91789;112367.4381628103;113005;114019.42990284995;78935;90982;91054.52805645722;91728.54135729412;93633.53183234313;9789.565001858966;9922.043937055687;10077.798444031225;10079.748006299902;10513.632022879163;50964.74517627388;51665;51703;52124.47875521196;52405.73797131143;71658.64170679114;80587;80612;81124.59437702774;81968.59015704883;11161.72095697614;11874.406279685809;12233.938830305791;12234.388280586114;12290.078244131548;14049.929750351183;15084.24578771079;16154.434594789125;16219;16458;13313.457540420623;13534.729305414034;14352.928235358757;14790.63023424423;15608.765868512208;13758.518451854137;14030.579082627537;14289.28553572338;14616.853831461549;14669.853301466848;14238.338481033068;14339.35472903701;14459.204743739196;14800.925995369955;15139.772903406678;11666.941665291619;11975.76048479043;12148.939255303667;12182.208156469802;12305.93847030759;10676.572937082741;11826.210384794173;12027.398630068637;12341.62975110748;12707.237565746085 18:24:06 INFO - PROCESS | 3414 | __end_tp_report 18:24:06 INFO - PROCESS | 3414 | __start_cc_report 18:24:06 INFO - PROCESS | 3414 | _x_x_mozilla_cycle_collect,350 18:24:06 INFO - PROCESS | 3414 | __end_cc_report 18:24:06 INFO - PROCESS | 3414 | __startTimestamp1471310646224__endTimestamp 18:24:06 INFO - PROCESS | 3414 | 18:24:06 INFO - PROCESS | 3414 | ------- Summary: start ------- 18:24:06 INFO - PROCESS | 3414 | Number of tests: 6 18:24:06 INFO - PROCESS | 3414 | 18:24:06 INFO - PROCESS | 3414 | [#0] dojo.html Cycles:165 Average:5364.57 Median:5569.69 stddev:618.87 (11.1%) stddev-sans-first:594.32 18:24:06 INFO - PROCESS | 3414 | Values: 3083.0 3117.6 3126.5 3140.4 3151.1 5355.7 5423.3 5452.8 5458.1 5526.9 5267.4 5333.9 5352.1 5382.8 5399.0 4776.5 4797.0 4884.0 4934.6 5002.8 4860.8 4924.2 4937.8 4983.3 5016.6 4827.5 4849.2 4897.6 4898.0 4953.3 4919.7 4927.0 4936.0 4941.0 4971.8 4801.2 4822.6 4825.5 4850.5 4887.0 5290.4 5328.5 5381.2 5410.1 5416.6 5733.1 5782.0 5782.2 5784.5 5784.9 5657.6 5804.4 5806.8 5815.2 5817.3 5390.6 5404.2 5429.0 5477.0 5519.8 6000.3 6001.4 6011.4 6013.4 6015.1 5427.7 5728.7 5757.8 5759.2 5760.2 5602.7 5626.9 5672.7 5675.8 5737.7 5671.9 5699.2 5760.9 5788.4 5797.1 5722.3 5738.5 5780.4 5791.8 5803.9 4301.1 4347.4 4349.1 4351.8 4470.1 3879.6 3892.2 3897.9 3908.2 3935.0 5416.1 5456.6 5459.3 5461.2 5513.6 5680.0 5771.2 5800.2 5869.3 5879.6 5654.5 5662.7 5664.6 5670.8 5672.2 5095.5 5103.5 5107.3 5110.2 5137.5 5779.3 5965.5 6015.7 6050.2 6129.4 5832.6 5855.1 5870.0 5877.8 5880.3 6048.8 6099.1 6110.9 6112.3 6126.1 5488.3 5549.4 5550.0 5581.8 5746.2 5628.3 5700.6 5703.5 5722.3 5733.3 5530.8 5569.7 5571.7 5575.2 5588.7 5463.9 5543.2 5599.8 5660.2 5680.8 5632.2 5641.2 5643.5 5644.2 5658.2 5606.2 5623.8 5658.0 5674.3 5680.9 5380.2 5395.7 5400.5 5432.8 5465.6 18:24:06 INFO - PROCESS | 3414 | 18:24:06 INFO - PROCESS | 3414 | [#1] ext.html Cycles:180 Average:61570.73 Median:4265.33 stddev:121310.10 (2844.1%) stddev-sans-first:121563.86 18:24:06 INFO - PROCESS | 3414 | Values: 538.8 590.5 599.6 605.5 616.7 38954.0 43405.3 43441.8 43609.6 43619.8 43767.6 43844.8 44179.3 44284.0 44349.9 8769.9 8895.3 8925.5 8929.6 8944.3 8795.3 8816.4 8880.2 8905.2 8909.2 8945.8 8953.3 8962.0 8966.9 8995.0 8804.6 8867.6 8895.0 8934.9 8939.4 8817.8 8839.0 8857.2 8863.1 8875.4 41677.6 42002.8 42091.0 42184.4 42273.2 3414.8 4061.3 4260.4 4312.4 4426.8 33022.5 33135.5 33229.2 33392.2 35278.5 3966.1 4044.5 4083.4 4123.3 4270.3 343908.0 344605.0 344678.3 345464.0 345731.0 59849.7 61199.4 61459.7 61465.7 61637.0 62983.2 63021.7 63353.7 63472.7 63496.7 14843.6 15739.4 16010.3 16020.8 16746.2 11268.4 11278.8 11342.5 11344.9 11397.0 19519.9 19623.7 19662.2 19698.3 19770.7 7049.8 7237.3 7239.0 7385.3 7600.8 954.7 1025.2 1042.3 1055.0 1166.1 33219.0 33291.5 33556.7 33588.5 33750.2 1106.1 1117.2 1118.6 1129.1 1181.4 18002.1 19249.5 19438.5 19455.4 19644.6 572907.0 574508.0 578996.0 581496.0 581713.0 60443.1 60485.1 60678.4 61131.7 61474.0 1333.4 1377.2 1387.8 1403.3 1410.3 32478.4 33890.8 34899.0 34979.0 34987.8 51434.7 52097.5 52338.0 52367.0 52489.5 413137.0 416869.0 417888.0 418694.0 419992.0 30463.2 30586.7 30735.2 30994.5 31070.0 50152.0 50434.5 50916.0 50996.5 51243.2 40754.6 43792.6 43928.6 44464.0 44701.8 42290.4 42845.1 43266.6 44076.0 44882.3 41781.6 42321.6 43395.0 43450.1 43503.6 34795.0 37245.8 38634.4 39328.0 40595.8 29112.7 29214.6 29246.0 29375.9 29709.6 18:24:06 INFO - PROCESS | 3414 | 18:24:06 INFO - PROCESS | 3414 | [#2] jquery.html Cycles:180 Average:27894.61 Median:223497.47 stddev:78216.44 (35.0%) stddev-sans-first:78408.60 18:24:06 INFO - PROCESS | 3414 | Values: 392.8 400.1 413.5 414.0 430.8 19114.5 19843.1 19907.7 20537.3 21047.0 18556.4 18922.4 19151.9 19256.3 19310.8 5547.6 5555.5 5855.4 5891.1 5963.9 5769.1 5876.1 5910.3 5936.6 5958.2 5892.6 5933.3 5933.4 5936.1 5950.3 5729.9 5848.7 5932.9 5939.7 5961.3 5732.4 5740.7 5741.0 5744.0 5748.4 13552.2 19427.4 23687.4 23701.2 23857.3 2207.2 2276.6 2462.1 2641.1 2756.0 10032.4 10033.5 10058.2 10586.8 10597.8 1924.7 1953.1 1958.5 1962.7 1988.9 80819.2 87327.0 88616.6 89344.6 91983.0 8896.6 9448.5 9452.2 9656.7 9822.8 12522.4 12550.6 12581.2 12589.8 12645.6 7034.2 7430.0 7438.3 7448.4 7603.3 7326.6 7356.6 7422.4 7423.1 7567.8 3897.2 3905.5 3908.3 3981.1 3983.1 1820.8 1871.6 1879.2 1897.2 1902.6 432.2 478.6 482.1 483.9 1018.3 11288.2 11846.8 12091.1 12126.3 12474.4 456.9 468.9 470.2 471.8 486.4 6250.8 6268.1 6452.2 6453.9 6588.2 446562.8 463282.0 474983.0 475692.0 498895.0 62672.7 91608.0 93012.5 94589.0 95443.5 479.8 490.7 490.8 491.0 492.2 11419.9 11590.1 11820.8 12089.6 12101.6 39747.4 40511.8 41060.4 42611.1 43008.4 60522.4 61044.7 61167.4 61670.4 63331.0 5492.0 5973.1 7415.1 7465.9 7668.1 9467.2 13065.8 13735.4 13854.2 13859.7 11422.3 11687.3 12106.8 12213.3 12372.4 11461.8 11555.9 11741.1 11933.8 12159.2 12272.6 12287.4 12335.8 12477.9 12604.0 7647.9 7677.1 7747.8 7754.3 7879.3 11193.3 12274.9 12370.9 12436.2 12701.5 18:24:06 INFO - PROCESS | 3414 | 18:24:06 INFO - PROCESS | 3414 | [#3] mootools.html Cycles:180 Average:5913.03 Median:2648.39 stddev:3371.83 (127.3%) stddev-sans-first:3364.97 18:24:06 INFO - PROCESS | 3414 | Values: 1499.2 1510.5 1647.6 1757.3 1772.5 8023.1 8539.6 8691.1 9304.0 9316.0 9017.2 9037.6 9094.9 9098.5 9102.4 2371.3 2431.3 2434.8 2434.9 2441.2 2349.6 2395.1 2422.6 2423.8 2426.4 2403.0 2413.8 2429.0 2449.5 2453.3 2370.3 2373.0 2373.4 2383.0 2419.6 2337.4 2361.5 2383.4 2383.4 2387.1 8888.6 8983.2 9010.9 9026.2 9050.2 5236.7 5293.8 5350.1 5353.8 5357.3 3544.4 3682.6 3694.4 3726.6 3776.5 1200.6 1206.5 1249.9 1258.1 1260.7 12400.9 12502.2 12515.1 12633.6 12649.6 4396.3 4636.3 4683.5 4815.0 4841.2 9591.4 9593.1 9593.1 9593.1 9612.9 5345.5 5378.0 5404.6 5409.5 5413.8 4492.7 4903.9 5016.2 5043.3 5059.1 3842.7 3843.3 3912.7 3916.6 4010.0 1195.2 1197.6 1204.9 1212.4 1212.8 868.7 885.5 890.5 1008.2 1034.2 6076.6 6122.7 6199.2 6263.5 6328.9 464.7 464.7 469.3 472.1 481.8 3897.7 4067.0 4068.1 4104.9 4116.4 10914.2 11369.3 11373.1 11438.3 11438.5 11078.4 11085.4 11321.8 11329.8 11389.7 8367.4 8469.5 8517.5 8541.1 8590.0 6018.3 6025.6 6033.0 6207.4 6297.6 10332.7 10347.2 10528.2 10545.4 10645.1 10339.5 10341.2 10493.0 10517.3 10711.1 6865.9 7346.1 7476.6 7549.2 7641.0 8752.4 8830.0 8865.0 8872.0 8874.2 7712.3 7896.8 7920.3 7998.5 8014.4 7723.2 7872.0 7916.8 7932.4 7946.9 7306.2 7411.6 7415.9 7424.3 7425.1 5275.3 5290.3 5413.2 5449.1 5460.9 5327.5 5334.5 5342.4 5381.6 5503.2 18:24:06 INFO - PROCESS | 3414 | 18:24:06 INFO - PROCESS | 3414 | [#4] prototype.html Cycles:180 Average:4640.69 Median:5145.86 stddev:1342.15 (26.1%) stddev-sans-first:1306.38 18:24:06 INFO - PROCESS | 3414 | Values: 332.4 340.4 340.6 343.0 350.3 5396.9 5441.5 5458.6 5539.0 5587.9 5455.2 5489.6 5505.6 5512.0 5522.4 4213.1 4236.4 4248.4 4261.9 4266.9 4104.8 4234.3 4240.1 4247.7 4268.3 4223.2 4225.1 4228.8 4231.6 4239.0 4218.9 4243.2 4250.0 4255.2 4263.3 3534.8 3650.8 3675.9 3689.5 3762.7 5393.4 5409.9 5411.2 5413.5 5414.6 4884.5 4885.9 4888.3 4889.3 4891.7 5427.5 5700.6 5706.8 5748.1 5800.2 4033.9 4038.7 4043.9 4048.5 4052.8 6007.6 6023.8 6037.2 6047.3 6073.4 3927.9 4117.9 4148.6 4161.1 4164.6 4202.2 4203.3 4212.2 4220.3 4221.7 4821.6 4837.1 4843.7 4850.0 4856.0 5621.0 5795.3 5835.2 5842.5 5847.8 1459.4 1486.6 1494.1 1494.1 1503.2 1008.5 1039.8 1049.9 1068.0 1082.1 4869.9 4896.5 4947.7 5004.2 5035.8 5151.5 5159.2 5199.7 5208.7 5248.6 4714.6 4947.5 4954.5 4958.9 4976.0 2725.9 2761.9 2762.9 2771.5 2778.6 5336.3 5386.7 5409.0 5434.4 5439.5 5117.6 5195.2 5242.0 5256.9 5279.9 5289.3 5340.6 5350.8 5377.6 5395.9 5181.0 5200.4 5210.8 5219.8 5226.4 4930.5 5073.6 5111.5 5140.2 5160.5 5339.2 5372.2 5384.1 5398.3 5408.9 3872.3 3887.7 3899.2 3904.6 3923.3 4974.0 5191.2 5219.6 5685.2 5815.7 5809.2 5812.5 5820.4 5843.0 5854.4 5813.9 5814.5 5832.8 5863.2 5874.0 5528.0 5666.7 5684.6 5720.6 5729.2 5846.3 5862.4 5863.8 5870.5 5914.1 5545.1 5596.7 5671.2 5745.7 5768.6 18:24:06 INFO - PROCESS | 3414 | 18:24:06 INFO - PROCESS | 3414 | [#5] yui.html Cycles:180 Average:22380.25 Median:3823.31 stddev:33123.65 (866.4%) stddev-sans-first:33176.63 18:24:06 INFO - PROCESS | 3414 | Values: 714.8 742.8 765.7 796.2 812.7 15325.7 16422.9 16535.1 16547.6 16623.4 14666.4 15315.5 15492.8 15510.8 15537.2 797.1 813.9 815.1 816.6 817.2 805.9 828.1 831.7 832.9 833.1 868.0 868.9 870.1 870.3 870.5 858.5 860.5 862.4 863.4 864.8 632.2 632.7 633.3 634.7 635.1 15588.8 15682.9 15691.5 15732.6 15772.2 15136.0 15241.8 15415.8 15477.5 15665.9 11987.5 12317.8 12331.1 12501.4 12630.6 3923.8 3946.8 3957.2 4130.0 4132.0 90243.0 92418.0 92780.5 93046.0 94256.5 11189.0 11221.6 11315.8 11404.7 11451.2 22275.7 22326.0 22461.6 22477.9 22487.3 8275.3 8334.9 8397.2 8491.4 8492.0 4617.8 4738.8 4781.7 4803.9 4864.0 3494.6 3662.7 3713.4 3714.4 3722.8 616.2 620.8 623.7 630.1 654.3 719.0 725.3 729.3 738.0 758.6 10557.4 10644.5 10699.3 10911.8 10927.3 747.7 755.9 761.9 767.3 773.2 4812.4 4937.9 5001.3 5001.8 5109.7 128544.1 129938.4 132670.0 133698.0 134632.3 88913.6 91789.0 112367.4 113005.0 114019.4 78935.0 90982.0 91054.5 91728.5 93633.5 9789.6 9922.0 10077.8 10079.7 10513.6 50964.7 51665.0 51703.0 52124.5 52405.7 71658.6 80587.0 80612.0 81124.6 81968.6 11161.7 11874.4 12233.9 12234.4 12290.1 14049.9 15084.2 16154.4 16219.0 16458.0 13313.5 13534.7 14352.9 14790.6 15608.8 13758.5 14030.6 14289.3 14616.9 14669.9 14238.3 14339.4 14459.2 14800.9 15139.8 11666.9 11975.8 12148.9 12182.2 12305.9 10676.6 11826.2 12027.4 12341.6 12707.2 18:24:06 INFO - PROCESS | 3414 | -------- Summary: end -------- 18:24:06 INFO - PROCESS | 3414 | 18:24:06 INFO - TEST-INFO | 3414: exit 0 18:24:06 INFO - TEST-OK | dromaeo_css | took 1114655ms 18:24:06 INFO - TEST-START | kraken 18:24:06 INFO - operating with platform_type : linux_ 18:24:06 INFO - Initialising browser for kraken test... 18:24:06 INFO - TEST-INFO | started process 3777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTNABRt/profile http://localhost:50403/getInfo.html) 18:24:11 INFO - PROCESS | 3777 | __metrics Screen width/height:1600/1200 18:24:11 INFO - PROCESS | 3777 | colorDepth:24 18:24:11 INFO - PROCESS | 3777 | Browser inner width/height: 1024/697 18:24:11 INFO - PROCESS | 3777 | __metrics 18:24:12 ERROR - PROCESS | 3777 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 18:24:13 INFO - TEST-INFO | 3777: exit 0 18:24:13 INFO - Browser initialized. 18:24:13 INFO - Running cycle 1/1 for kraken test... 18:24:13 INFO - TEST-INFO | started process 3898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTNABRt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:25 INFO - PROCESS | 3898 | RSS: Main: 163381248 18:24:25 INFO - PROCESS | 3898 | 18:24:27 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50403/tests/kraken/driver.html?testName=audio-beat-detection) 18:24:28 INFO - PROCESS | 3898 | RSS: Main: 168779776 18:24:28 INFO - PROCESS | 3898 | 18:24:31 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50403/tests/kraken/driver.html?testName=audio-dft) 18:24:31 INFO - PROCESS | 3898 | RSS: Main: 167780352 18:24:31 INFO - PROCESS | 3898 | 18:24:34 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50403/tests/kraken/driver.html?testName=audio-fft) 18:24:35 INFO - PROCESS | 3898 | RSS: Main: 163471360 18:24:35 INFO - PROCESS | 3898 | 18:24:37 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50403/tests/kraken/driver.html?testName=audio-oscillator) 18:24:38 INFO - PROCESS | 3898 | RSS: Main: 164954112 18:24:38 INFO - PROCESS | 3898 | 18:24:40 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:24:40 INFO - PROCESS | 3898 | RSS: Main: 165093376 18:24:40 INFO - PROCESS | 3898 | 18:24:44 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50403/tests/kraken/driver.html?testName=imaging-darkroom) 18:24:44 INFO - PROCESS | 3898 | RSS: Main: 165429248 18:24:44 INFO - PROCESS | 3898 | 18:24:48 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50403/tests/kraken/driver.html?testName=imaging-desaturate) 18:24:48 INFO - PROCESS | 3898 | RSS: Main: 163246080 18:24:48 INFO - PROCESS | 3898 | 18:24:51 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50403/tests/kraken/driver.html?testName=json-parse-financial) 18:24:52 INFO - PROCESS | 3898 | RSS: Main: 164245504 18:24:52 INFO - PROCESS | 3898 | 18:24:53 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:24:54 INFO - PROCESS | 3898 | RSS: Main: 164618240 18:24:54 INFO - PROCESS | 3898 | 18:24:56 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:24:56 INFO - PROCESS | 3898 | RSS: Main: 164675584 18:24:56 INFO - PROCESS | 3898 | 18:24:58 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:24:59 INFO - PROCESS | 3898 | RSS: Main: 165146624 18:24:59 INFO - PROCESS | 3898 | 18:25:02 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:25:03 INFO - PROCESS | 3898 | RSS: Main: 165437440 18:25:03 INFO - PROCESS | 3898 | 18:25:05 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:25:06 INFO - PROCESS | 3898 | RSS: Main: 165875712 18:25:06 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50403/tests/kraken/driver.html?testName=ai-astar) 18:25:08 INFO - PROCESS | 3898 | RSS: Main: 166486016 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | __start_tp_report 18:25:08 INFO - PROCESS | 3898 | _x_x_mozilla_page_load 18:25:08 INFO - PROCESS | 3898 | _x_x_mozilla_page_load_details 18:25:08 INFO - PROCESS | 3898 | |i|pagename|runs| 18:25:08 INFO - PROCESS | 3898 | |0;ai-astar;103;114;108;113;112;113;117;113;113;113 18:25:08 INFO - PROCESS | 3898 | |1;audio-beat-detection;149;118;145;194;127;151;153;121;179;119 18:25:08 INFO - PROCESS | 3898 | |2;audio-dft;163;163;163;162;164;170;166;160;164;162 18:25:08 INFO - PROCESS | 3898 | |3;audio-fft;76;74;77;185;78;75;76;76;182;76 18:25:08 INFO - PROCESS | 3898 | |4;audio-oscillator;85;85;155;84;84;85;141;84;86;153 18:25:08 INFO - PROCESS | 3898 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;118;117;118 18:25:08 INFO - PROCESS | 3898 | |6;imaging-darkroom;148;147;146;147;146;155;146;147;147;147 18:25:08 INFO - PROCESS | 3898 | |7;imaging-desaturate;96;96;95;100;95;96;96;96;96;96 18:25:08 INFO - PROCESS | 3898 | |8;json-parse-financial;51;51;60;50;51;56;51;50;51;54 18:25:08 INFO - PROCESS | 3898 | |9;json-stringify-tinderbox;62;62;61;61;61;62;61;63;61;61 18:25:08 INFO - PROCESS | 3898 | |10;stanford-crypto-aes;87;90;81;86;79;77;85;81;84;79 18:25:08 INFO - PROCESS | 3898 | |11;stanford-crypto-ccm;139;127;126;133;129;134;129;136;153;132 18:25:08 INFO - PROCESS | 3898 | |12;stanford-crypto-pbkdf2;166;171;166;168;170;164;163;164;169;162 18:25:08 INFO - PROCESS | 3898 | |13;stanford-crypto-sha256-iterative;68;68;66;64;65;67;65;70;66;65 18:25:08 INFO - PROCESS | 3898 | __end_tp_report 18:25:08 INFO - PROCESS | 3898 | __start_cc_report 18:25:08 INFO - PROCESS | 3898 | _x_x_mozilla_cycle_collect,850 18:25:08 INFO - PROCESS | 3898 | __end_cc_report 18:25:08 INFO - PROCESS | 3898 | __startTimestamp1471310708397__endTimestamp 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | ------- Summary: start ------- 18:25:08 INFO - PROCESS | 3898 | Number of tests: 14 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.81 (3.4%) stddev-sans-first:2.32 18:25:08 INFO - PROCESS | 3898 | Values: 103.0 114.0 108.0 113.0 112.0 113.0 117.0 113.0 113.0 113.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:150.00 stddev:25.76 (17.2%) stddev-sans-first:27.30 18:25:08 INFO - PROCESS | 3898 | Values: 149.0 118.0 145.0 194.0 127.0 151.0 153.0 121.0 179.0 119.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.71 (1.7%) stddev-sans-first:2.86 18:25:08 INFO - PROCESS | 3898 | Values: 163.0 163.0 163.0 162.0 164.0 170.0 166.0 160.0 164.0 162.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#3] audio-fft Cycles:10 Average:97.50 Median:76.00 stddev:45.34 (59.7%) stddev-sans-first:47.42 18:25:08 INFO - PROCESS | 3898 | Values: 76.0 74.0 77.0 185.0 78.0 75.0 76.0 76.0 182.0 76.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:84.50 stddev:31.58 (37.4%) stddev-sans-first:32.73 18:25:08 INFO - PROCESS | 3898 | Values: 85.0 85.0 155.0 84.0 84.0 85.0 141.0 84.0 86.0 153.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:25:08 INFO - PROCESS | 3898 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.00 stddev:2.67 (1.8%) stddev-sans-first:2.83 18:25:08 INFO - PROCESS | 3898 | Values: 148.0 147.0 146.0 147.0 146.0 155.0 146.0 147.0 147.0 147.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.40 (1.5%) stddev-sans-first:1.48 18:25:08 INFO - PROCESS | 3898 | Values: 96.0 96.0 95.0 100.0 95.0 96.0 96.0 96.0 96.0 96.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:51.00 stddev:3.24 (6.4%) stddev-sans-first:3.39 18:25:08 INFO - PROCESS | 3898 | Values: 51.0 51.0 60.0 50.0 51.0 56.0 51.0 50.0 51.0 54.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 18:25:08 INFO - PROCESS | 3898 | Values: 62.0 62.0 61.0 61.0 61.0 62.0 61.0 63.0 61.0 61.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:84.50 stddev:4.15 (4.9%) stddev-sans-first:4.13 18:25:08 INFO - PROCESS | 3898 | Values: 87.0 90.0 81.0 86.0 79.0 77.0 85.0 81.0 84.0 79.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:133.50 stddev:7.87 (5.9%) stddev-sans-first:8.12 18:25:08 INFO - PROCESS | 3898 | Values: 139.0 127.0 126.0 133.0 129.0 134.0 129.0 136.0 153.0 132.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:167.00 stddev:3.09 (1.9%) stddev-sans-first:3.28 18:25:08 INFO - PROCESS | 3898 | Values: 166.0 171.0 166.0 168.0 170.0 164.0 163.0 164.0 169.0 162.0 18:25:08 INFO - PROCESS | 3898 | 18:25:08 INFO - PROCESS | 3898 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.84 (2.8%) stddev-sans-first:1.86 18:25:08 INFO - PROCESS | 3898 | Values: 68.0 68.0 66.0 64.0 65.0 67.0 65.0 70.0 66.0 65.0 18:25:08 INFO - PROCESS | 3898 | -------- Summary: end -------- 18:25:08 INFO - PROCESS | 3898 | 18:25:09 INFO - TEST-INFO | 3898: exit 0 18:25:09 INFO - TEST-OK | kraken | took 62410ms 18:25:09 INFO - SUITE-END | took 1177s 18:25:09 INFO - Completed test suite (00:19:37) 18:25:09 INFO - javascript benchmark 18:25:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7203.232355383624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.953755693665, 3117.6258848938132, 3126.4997600383945, 3140.38762441324, 3151.1019359482552, 5355.678659280446, 5423.29497165369, 5452.809151679687, 5458.099413596757, 5526.944730552704, 5267.367915850094, 5333.893322133555, 5352.116900711388, 5382.838514844551, 5398.973005134969, 4776.498467660897, 4796.999999999991, 4883.9511604883855, 4934.580560652349, 5002.77487513061, 4860.8055677772845, 4924.236743304776, 4937.753112344369, 4983.277424773424, 5016.573591244731, 4827.493113223114, 4849.224124140138, 4897.583705385046, 4898.044881248158, 4953.306537084811, 4919.72941488218, 4927.014597080562, 4936.0, 4940.975295123501, 4971.776270067856, 4801.159797035505, 4822.590079843218, 4825.517448255181, 4850.53919877611, 4886.975565122188, 5290.444503327134, 5328.4671532846405, 5381.192821076831, 5410.08028635133, 5416.647917885325, 5733.140028995643, 5782.045962416196, 5782.190493330937, 5784.537237021028, 5784.88430231393, 5657.60396772222, 5804.419558044204, 5806.767729290823, 5815.185873977646, 5817.301923769175, 5390.6226564140525, 5404.243405923174, 5429.0, 5477.04151773438, 5519.834404967857, 6000.279966403972, 6001.369856165127, 6011.428914253139, 6013.398660133952, 6015.0676645120075, 5427.701476418756, 5728.684922329228, 5757.827265182052, 5759.164921086419, 5760.193572899798, 5602.719864006784, 5626.859328516738, 5672.688002159838, 5675.801346952837, 5737.741801618937, 5671.943280567141, 5699.230603868425, 5760.94239057604, 5788.363280039192, 5797.130430435468, 5722.284714410699, 5738.454846789548, 5780.421957804186, 5791.82624521265, 5803.9419605803405, 4301.09676967834, 4347.413099231627, 4349.064951035542, 4351.804168812348, 4470.105978804252, 3879.553851307136, 3892.2215556888737, 3897.902552436155, 3908.1988192421054, 3934.9803250983564, 5416.0792665247, 5456.563474921997, 5459.317585301837, 5461.208124821958, 5513.641613295123, 5679.971600142056, 5771.192033115367, 5800.216970708984, 5869.266341707286, 5879.647221166743, 5654.547636189095, 5662.68855212959, 5664.631798933138, 5670.829875103754, 5672.177534257509, 5095.515925987025, 5103.5406813386235, 5107.259447380184, 5110.182370820725, 5137.486251374908, 5779.306483221956, 5965.463108320272, 6015.699215039318, 6050.21347224858, 6129.3870612939245, 5832.62087964281, 5855.121731740273, 5869.970650146722, 5877.794277200277, 5880.323762767336, 6048.818535443767, 6099.054646529795, 6110.877782444238, 6112.2970858351855, 6126.111713801385, 5488.341399032141, 5549.417311182267, 5550.0, 5581.804636837854, 5746.224259724883, 5628.296462942132, 5700.629459085146, 5703.543716502752, 5722.313322401172, 5733.254676892144, 5530.806421775219, 5569.693666848362, 5571.749271282721, 5575.163725441216, 5588.720563971704, 5463.863403414946, 5543.1685247213245, 5599.776008959759, 5660.179274005164, 5680.772769089355, 5632.239647647515, 5641.210230567642, 5643.548516118619, 5644.153376993319, 5658.20785090096, 5606.215129881738, 5623.831285061455, 5658.03813351723, 5674.319081710221, 5680.886382272249, 5380.219868119179, 5395.70323632204, 5400.486953739389, 5432.782688692408, 5465.617406781487], "value": 5322.216450732159, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.7961538824462, 590.5482306035882, 599.5892813422805, 605.4913872347229, 616.7255571270781, 38954.0, 43405.34891976623, 43441.78279108604, 43609.56390436095, 43619.78190109053, 43767.56232437675, 43844.78077609615, 44179.337309940376, 44284.0, 44349.899761527435, 8769.912300877006, 8895.288376929862, 8925.509096999662, 8929.642814287421, 8944.329175311845, 8795.340349473816, 8816.382853200279, 8880.200781929625, 8905.243054340357, 8909.1536304051, 8945.776355591097, 8953.283737301033, 8962.0, 8966.86549701755, 8994.955025224897, 8804.603792829274, 8867.645294188193, 8894.955525222365, 8934.944962658625, 8939.374243802937, 8817.823643527094, 8838.955805220932, 8857.247133993618, 8863.069377715312, 8875.378723489293, 41677.583224167676, 42002.78998605018, 42091.0, 42184.36723449151, 42273.15453690909, 3414.8110971422266, 4061.3298805697023, 4260.382244574519, 4312.417823593806, 4426.75652839097, 33022.50466243008, 33135.502967455504, 33229.16927076818, 33392.16519587005, 35278.47082293768, 3966.147278335143, 4044.4539987101657, 4083.448734420845, 4123.330051329216, 4270.274053410928, 343908.0, 344605.0, 344678.27660861786, 345464.0, 345731.0, 59849.700751496835, 61199.38800612026, 61459.69270153621, 61465.69267153636, 61637.0, 62983.16575754102, 63021.68489157525, 63353.68323158355, 63472.68263658652, 63496.68251658712, 14843.628909277355, 15739.370425182864, 16010.279537420844, 16020.839791601935, 16746.162691865356, 11268.38023908693, 11278.774424511465, 11342.546298148147, 11344.943275283571, 11397.0, 19519.92323569547, 19623.70564441506, 19662.213511459668, 19698.31055913036, 19770.703439448418, 7049.766290899175, 7237.276272372826, 7239.0, 7385.29839665231, 7600.821872609754, 954.6849539651898, 1025.2413214221422, 1042.3485321673954, 1054.9578016879393, 1166.055495049013, 33219.0, 33291.500627490605, 33556.66443335584, 33588.49617255743, 33750.15624609355, 1106.0985296982933, 1117.1844553475846, 1118.6084870295495, 1129.0910816792398, 1181.3797756178076, 18002.140741293955, 19249.51876203106, 19438.514037149183, 19455.416337509898, 19644.607107857762, 572907.0, 574508.0, 578996.0, 581496.0, 581713.0, 60443.09335359973, 60485.09272360918, 60678.39321606816, 61131.69434152801, 61474.0, 1333.3533236380347, 1377.2149874571599, 1387.840398354202, 1403.3264033263886, 1410.2737090398452, 32478.35043299168, 33890.830545847115, 34899.0, 34979.0, 34987.7754278599, 51434.74282628563, 52097.479025209264, 52338.0, 52367.0, 52489.47510524846, 413137.0, 416869.0, 417888.0, 418694.0, 419992.0, 30463.238419039702, 30586.694133059274, 30735.2316192097, 30994.535081974238, 31070.0, 50152.0, 50434.49565504445, 50916.0, 50996.49003510066, 51243.23135152901, 40754.60428073668, 43792.562074378846, 43928.56071439245, 44464.0, 44701.776491117336, 42290.36564451597, 42845.143097138505, 43266.56733432751, 44076.0, 44882.326765097896, 41781.58218417777, 42321.576784232995, 43395.0, 43450.130997379245, 43503.56496434995, 34795.0, 37245.78849203631, 38634.42048369221, 39328.0, 40595.7970210147, 29112.708872911848, 29214.56178157287, 29246.0, 29375.85312073426, 29709.58339790952], "value": 20594.009407068956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.77493002142864, 400.111751910758, 413.47488689364496, 413.99172016559663, 430.76523294804326, 19114.522136946565, 19843.10706018229, 19907.701384479227, 20537.28119515817, 21047.0, 18556.35052773153, 18922.432327030212, 19151.904240478812, 19256.326028589003, 19310.806891931075, 5547.639403438784, 5555.472230138131, 5855.355910849825, 5891.145783861359, 5963.880722385549, 5769.134629805541, 5876.08920617305, 5910.34986151523, 5936.64380137191, 5958.165856780054, 5892.646441213541, 5933.288005439332, 5933.406659334075, 5936.079907614327, 5950.285965684124, 5729.942700572982, 5848.7075646217945, 5932.88134237315, 5939.703014849262, 5961.344252132262, 5732.369439361667, 5740.655560666331, 5741.0, 5744.0, 5748.42515748426, 13552.186868787805, 19427.4171774847, 23687.407814804596, 23701.170459033852, 23857.284281471584, 2207.249535158054, 2276.590213761522, 2462.1259452894324, 2641.1152263991585, 2756.0, 10032.398056116583, 10033.548490317953, 10058.245631577662, 10586.788264234672, 10597.788044239072, 1924.6920492721238, 1953.1210955070133, 1958.5397431603562, 1962.7154062660834, 1988.8508361872916, 80819.19180808176, 87327.0, 88616.556917215, 89344.5532772332, 91983.0, 8896.59965301563, 9448.480333581581, 9452.243820494345, 9656.71029869105, 9822.803543929082, 12522.436490357955, 12550.623481295575, 12581.245125292511, 12589.811152832715, 12645.620631381073, 7034.155901291878, 7430.0, 7438.256174382626, 7448.4041276697735, 7603.2776886195725, 7326.597037162901, 7356.632168391559, 7422.406207503387, 7423.078828717173, 7567.848643027109, 3897.18159186574, 3905.4727611772614, 3908.257431088084, 3981.0843505993785, 3983.083890705096, 1820.7724034495689, 1871.6350311689362, 1879.248300679739, 1897.24110355856, 1902.6099649571804, 432.1810169728347, 478.64580210643874, 482.14178761804044, 483.94434640016146, 1018.2821111116644, 11288.20982531215, 11846.822297665542, 12091.093168012258, 12126.333051682066, 12474.376281185905, 456.940597722294, 468.8687167593079, 470.1654563150435, 471.79712723528525, 486.37743688079314, 6250.781222657185, 6268.122462855204, 6452.161219041494, 6453.9354606453335, 6588.176477940257, 446562.767186162, 463282.0, 474983.0, 475692.0, 498895.0, 62672.68663656653, 91608.0, 93012.53493732623, 94589.0, 95443.52278238564, 479.7553247843625, 490.70802872290216, 490.76443307212026, 491.0424671889829, 492.2124600638949, 11419.885801141882, 11590.145576708024, 11820.813149567357, 12089.637310880687, 12101.576444824388, 39747.40378894377, 40511.80590945015, 41060.38409423801, 42611.147777044906, 43008.35487467628, 60522.394776051675, 61044.69477652583, 61167.38832611617, 61670.38329616647, 63331.0, 5492.0, 5973.074173503114, 7415.110186777405, 7465.850682986418, 7668.1181664109345, 9467.242620590474, 13065.804012939623, 13735.381907814372, 13854.16874987504, 13859.722805543632, 11422.25755325901, 11687.298762074302, 12106.818397724217, 12213.328266945404, 12372.381380931098, 11461.770764584828, 11555.942220288845, 11741.119416044, 11933.82099268529, 12159.209651372632, 12272.631821045383, 12287.385630718249, 12335.75328493443, 12477.93761031189, 12603.97504598908, 7647.885281720667, 7677.078750549969, 7747.845043098993, 7754.263344982218, 7879.251471110236, 11193.328400296008, 12274.877251227374, 12370.876291237333, 12436.19164754288, 12701.491940322283], "value": 8217.24432330945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.1754535005748, 1510.486434612232, 1647.5716313758426, 1757.3058641836483, 1772.48597906607, 8023.077346105185, 8539.573021348939, 8691.130886911305, 9304.0, 9315.953420232898, 9017.188453039225, 9037.593308301126, 9094.86357704635, 9098.454092754422, 9102.408343457671, 2371.347879333184, 2431.3435372449426, 2434.75652434756, 2434.8904299306573, 2441.2432146034785, 2349.5888219561593, 2395.0659242895285, 2422.588160012802, 2423.7939775119135, 2426.4176597616533, 2402.987985060081, 2413.78275955164, 2428.9878550607223, 2449.497852940152, 2453.288546321565, 2370.3007612754277, 2373.027058905849, 2373.4303767095944, 2383.02296058616, 2419.588669926099, 2337.368910394201, 2361.53949979754, 2383.4041489627593, 2383.4398916254668, 2387.0809738250723, 8888.600012999366, 8983.236424903891, 9010.909890901072, 9026.187643112085, 9050.185483306468, 5236.6857988520815, 5293.814716484904, 5350.063738845686, 5353.839384818461, 5357.276767636358, 3544.397452433067, 3682.6317368263226, 3694.4273637586216, 3726.6087060858763, 3776.527934008249, 1200.6398080575793, 1206.5354838387284, 1249.9437525311291, 1258.1444617659988, 1260.6785269756244, 12400.937995309965, 12502.187357821804, 12515.123941324111, 12633.557825476064, 12649.557265495663, 4396.340548917624, 4636.281376386598, 4683.531646835289, 4815.0, 4841.2496063110275, 9591.42451452915, 9593.088656577615, 9593.088656577753, 9593.13661770444, 9612.903870961341, 5345.54562862161, 5377.973110134424, 5404.567634589223, 5409.513143817076, 5413.810516631899, 4492.685512014193, 4903.8528844134735, 5016.19740841471, 5043.2687260347775, 5059.114654935372, 3842.731008829411, 3843.26977874203, 3912.726109172331, 3916.6096035907412, 4009.979950100231, 1195.2469943935266, 1197.6107764976243, 1204.903607711381, 1212.4240985531978, 1212.7574485103014, 868.6568805321863, 885.5262434597588, 890.519119675381, 1008.2186305613209, 1034.2036631793476, 6076.574639775262, 6122.66325352101, 6199.194104766351, 6263.530235232376, 6328.905066424008, 464.69562436604076, 464.74671304139326, 469.3335463641637, 472.1359911362199, 481.7711586996219, 3897.7466464680274, 4066.959330406717, 4068.0846809468226, 4104.856330028494, 4116.423700681907, 10914.181436392144, 11369.31784092957, 11373.147013973985, 11438.256513326607, 11438.542458301741, 11078.446077696082, 11085.390303533382, 11321.773564528663, 11329.830052549218, 11389.715257118638, 8367.414281000394, 8469.534175620276, 8517.48895066298, 8541.14588541141, 8589.957050214834, 6018.307894592178, 6025.6083354581815, 6033.0, 6207.441330280297, 6297.622142671271, 10332.741681458023, 10347.223958203014, 10528.157747380345, 10545.420001899969, 10645.0951669109, 10339.534720937425, 10341.224408169266, 10493.0, 10517.263791534826, 10711.08955738771, 6865.862682746417, 7346.081739782528, 7476.5514069156025, 7549.1695913448375, 7640.968469256579, 8752.431091979, 8829.955850220707, 8864.955675221583, 8872.024077351616, 8874.156955089256, 7712.305892469704, 7896.763097107096, 7920.287174154354, 7998.48009879356, 8014.398920080901, 7723.150453450004, 7871.960640196762, 7916.762497125095, 7932.36541076724, 7946.92053079485, 7306.232845551353, 7411.5553066816165, 7415.888761668687, 7424.331810136898, 7425.108986921604, 5275.314209152785, 5290.312259406252, 5413.24214609947, 5449.100898351728, 5460.91808622863, 5327.493888080626, 5334.46655334479, 5342.412334643109, 5381.5694744421135, 5503.174523821459], "value": 4655.2240491302055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.42100024881813, 340.36861621691776, 340.6236109099445, 343.00186457408944, 350.259201788218, 5396.91904621431, 5441.483059109383, 5458.590605704569, 5538.9723051384735, 5587.8603034924145, 5455.1544510600825, 5489.64317319374, 5505.642133261335, 5512.0, 5522.420145884685, 4213.136307057046, 4236.364545318196, 4248.405223268729, 4261.87214383569, 4266.887890494209, 4104.839273759204, 4234.30134027885, 4240.091958618634, 4247.723897946639, 4268.335349213794, 4223.176480586287, 4225.091605304859, 4228.788560571975, 4231.619154276114, 4238.978805105986, 4218.894527636803, 4243.236217480852, 4249.978750106261, 4255.17024180285, 4263.339182426729, 3534.805585692786, 3650.7809531428197, 3675.9264814703824, 3689.465027571014, 3762.698984081267, 5393.379761327419, 5409.864753381157, 5411.161270003156, 5413.458654134594, 5414.620976531644, 4884.535969082967, 4885.8778530536665, 4888.340074089988, 4889.33993910821, 4891.706497610119, 5427.538659213971, 5700.629459085146, 5706.800261990852, 5748.137779333092, 5800.187973683687, 4033.9394909076386, 4038.717289789716, 4043.878683639466, 4048.4939382577177, 4052.797360132011, 6007.609505382136, 6023.849403764897, 6037.154798328237, 6047.341358478146, 6073.423024812591, 3927.9214415711526, 4117.876463706094, 4148.585141485827, 4161.146964872194, 4164.646005089541, 4202.159568086334, 4203.285441474956, 4212.157568486315, 4220.261454245556, 4221.704480686322, 4821.614270858323, 4837.080954618682, 4843.660943733905, 4849.9687695190505, 4855.975720121447, 5621.0, 5795.304563452329, 5835.183074369592, 5842.474177324061, 5847.8245652630485, 1459.4016453254114, 1486.5837565481681, 1494.1334026264958, 1494.1483354488055, 1503.2033022498094, 1008.5007921079113, 1039.7608550033383, 1049.9370037797758, 1067.957281708723, 1082.0910435234284, 4869.878253043631, 4896.510348965075, 4947.6536642434685, 5004.199328107558, 5035.84892453227, 5151.5363617274625, 5159.2003239497935, 5199.740012999335, 5208.739563021833, 5248.606354523426, 4714.622830173578, 4947.476786838666, 4954.504549545017, 4958.900821983612, 4976.029674213493, 2725.8687644627653, 2761.8895244190007, 2762.875670594828, 2771.542695455227, 2778.610694652674, 5336.252924590561, 5386.676799392049, 5408.9729551352775, 5434.402215756264, 5439.456054394608, 5117.641765076483, 5195.155719719445, 5242.0, 5256.92114618281, 5279.868003299872, 5289.312389389354, 5340.572754179656, 5350.8127215547265, 5377.569794416438, 5395.89384176235, 5181.031208140882, 5200.375954885438, 5210.817621383233, 5219.81730639441, 5226.372835259641, 4930.531599498042, 5073.644844860824, 5111.539961403343, 5140.17523779068, 5160.509751573594, 5339.196921616182, 5372.247885296139, 5384.1424708475515, 5398.2712333836, 5408.864778380572, 3872.302985462644, 3887.688984881146, 3899.245339597136, 3904.5900180481776, 3923.2545816294814, 4973.975130124326, 5191.183085920049, 5219.556337711185, 5685.175649530877, 5815.680137592473, 5809.24479817621, 5812.505936995402, 5820.370296317038, 5842.970785146047, 5854.443827836349, 5813.941860581509, 5814.5348372130975, 5832.766689332549, 5863.1791549184, 5873.970630146822, 5528.0, 5666.716664166857, 5684.602077854676, 5720.599558030898, 5729.166666666627, 5846.327672317738, 5862.3844496328975, 5863.765449381977, 5870.5010074142465, 5914.137046830235, 5545.059229269723, 5596.664200148004, 5671.206031155724, 5745.735938093612, 5768.596198266081], "value": 4225.148874164042, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.8034290570093, 742.8142964258939, 765.6860687118283, 796.1878883538794, 812.7155495576548, 15325.69348613027, 16422.917885410556, 16535.090570018674, 16547.58631034223, 16623.41818036369, 14666.413343466249, 15315.540533784004, 15492.767608485881, 15510.767338489932, 15537.22313884307, 797.0554892452448, 813.9470934389275, 815.1074573342181, 816.5998660656265, 817.235884448043, 805.9435839491238, 828.0891019878146, 831.6714897615439, 832.9167083291653, 833.0919297965216, 868.04515033463, 868.9217970382664, 870.0559892516627, 870.2646263906988, 870.5386145342978, 858.4849090545686, 860.5224100624151, 862.4264863865553, 863.4387648028769, 864.7621903976394, 632.1971096707202, 632.6931438252444, 633.262249479356, 634.6794868591331, 635.0727937211676, 15588.844111558967, 15682.921585392114, 15691.529254122395, 15732.606684832856, 15772.211389430597, 15136.0, 15241.771373429407, 15415.768763468557, 15477.535673929688, 15665.921670391688, 11987.460564274628, 12317.753644927052, 12331.075169362244, 12501.437435315433, 12630.621081367573, 3923.784191869446, 3946.8223929923224, 3957.2481228566767, 4130.0, 4132.028973191298, 90243.0, 92417.99999999933, 92780.53609731975, 93046.0, 94256.52871735666, 11189.041917664375, 11221.60724374643, 11315.773684526428, 11404.657860264206, 11451.19841611096, 22275.665865011713, 22325.99533021018, 22461.55076898453, 22477.887610561844, 22487.32538023862, 8275.337972962268, 8334.916650833535, 8397.244248017707, 8491.448055876348, 8492.02341730709, 4617.815287388534, 4738.810447582127, 4781.737004464788, 4803.879903002453, 4864.0, 3494.633063528344, 3662.7069834413182, 3713.405855063177, 3714.4428335749853, 3722.8324725387424, 616.2235583165244, 620.7920346683821, 623.7442648514087, 630.1115427247559, 654.3391174913372, 719.0113593808513, 725.2928394815013, 729.3071581997124, 737.959926599704, 758.6017340896074, 10557.419341936115, 10644.520996555173, 10699.304545204537, 10911.781764364669, 10927.344359338465, 747.6822350501124, 755.920628334028, 761.9161892191854, 767.2902565127235, 773.1765669561898, 4812.422509298836, 4937.925931111036, 5001.299818025479, 5001.774920128603, 5109.744512774347, 128544.14367568988, 129938.35030824975, 132670.0, 133698.0, 134632.32683836517, 88913.55543222371, 91789.0, 112367.4381628103, 113005.0, 114019.42990284995, 78935.0, 90982.0, 91054.52805645722, 91728.54135729412, 93633.53183234313, 9789.565001858966, 9922.043937055687, 10077.798444031225, 10079.748006299902, 10513.632022879163, 50964.74517627388, 51665.0, 51703.0, 52124.47875521196, 52405.73797131143, 71658.64170679114, 80587.0, 80612.0, 81124.59437702774, 81968.59015704883, 11161.72095697614, 11874.406279685809, 12233.938830305791, 12234.388280586114, 12290.078244131548, 14049.929750351183, 15084.24578771079, 16154.434594789125, 16219.0, 16458.0, 13313.457540420623, 13534.729305414034, 14352.928235358757, 14790.63023424423, 15608.765868512208, 13758.518451854137, 14030.579082627537, 14289.28553572338, 14616.853831461549, 14669.853301466848, 14238.338481033068, 14339.35472903701, 14459.204743739196, 14800.925995369955, 15139.772903406678, 11666.941665291619, 11975.76048479043, 12148.939255303667, 12182.208156469802, 12305.93847030759, 10676.572937082741, 11826.210384794173, 12027.398630068637, 12341.62975110748, 12707.237565746085], "value": 7884.5581532533115, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 108.0, 113.0, 112.0, 113.0, 117.0, 113.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 145.0, 194.0, 127.0, 151.0, 153.0, 121.0, 179.0, 119.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 164.0, 170.0, 166.0, 160.0, 164.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 185.0, 78.0, 75.0, 76.0, 76.0, 182.0, 76.0], "value": 97.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 155.0, 84.0, 84.0, 85.0, 141.0, 84.0, 86.0, 153.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 146.0, 155.0, 146.0, 147.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 100.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 60.0, 50.0, 51.0, 56.0, 51.0, 50.0, 51.0, 54.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 63.0, 61.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 81.0, 86.0, 79.0, 77.0, 85.0, 81.0, 84.0, 79.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 127.0, 126.0, 133.0, 129.0, 134.0, 129.0, 136.0, 153.0, 132.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 166.0, 168.0, 170.0, 164.0, 163.0, 164.0, 169.0, 162.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 64.0, 65.0, 67.0, 65.0, 70.0, 66.0, 65.0], "value": 66.4, "unit": "score"}]}]} 18:25:09 INFO - Return code: 0 18:25:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:25:09 ERROR - # TBPL SUCCESS # 18:25:09 INFO - Running post-action listener: _resource_record_post_action 18:25:09 INFO - [mozharness: 2016-08-16 01:25:09.712830Z] Finished run-tests step (success) 18:25:09 INFO - Running post-run listener: _resource_record_post_run 18:25:09 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7790592; Write bytes: 443539456; Read time: 1320; Write time: 346152 18:25:09 INFO - TinderboxPrint: CPU usage
13.4% 18:25:09 INFO - TinderboxPrint: I/O read bytes / time
7,790,592 / 1,320 18:25:09 INFO - TinderboxPrint: I/O write bytes / time
443,539,456 / 346,152 18:25:09 INFO - TinderboxPrint: CPU idle
8,251.2 (86.5%) 18:25:09 INFO - TinderboxPrint: CPU user
1,219.2 (12.8%) 18:25:09 INFO - TinderboxPrint: Swap in / out
0 / 0 18:25:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105205760; Read time: 0; Write time: 72540 18:25:09 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 5562368; Write bytes: 334004224; Read time: 1020; Write time: 267304 18:25:10 INFO - Running post-run listener: _upload_blobber_files 18:25:10 INFO - Blob upload gear active. 18:25:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:25:10 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 18:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:25:10 INFO - (blobuploader) - INFO - Open directory for files ... 18:25:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:25:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:25:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:11 INFO - (blobuploader) - INFO - Done attempting. 18:25:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:25:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:25:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:15 INFO - (blobuploader) - INFO - Done attempting. 18:25:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:25:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:25:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:16 INFO - (blobuploader) - INFO - Done attempting. 18:25:16 INFO - (blobuploader) - INFO - Iteration through files over. 18:25:16 INFO - Return code: 0 18:25:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:25:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:25:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d32f6c349a43eaac48c6ae4712ca8adbee7f4e111ff3d4a1223fbb29431b7c06d7599811cef490bb2ba1cc12d2f601ae05a19079171cf3496c73fad3c01fbdba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/119ab6b508695b0c690346bd93ecaff44f148bdb94f541aa58fc74d9911b7297620557ace0105400cc484462921055151afc67d2f82b1f8258f8e5f0797ec5b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf6a85bbb7e9c838118be4794bdc2c6fe55590bcfd260908da0a67d53821a53e970304aba2737075091c53ed05efeee2e486d001fdf49f7222bd6f8dc106b8c3"} 18:25:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:25:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:25:16 INFO - Contents: 18:25:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d32f6c349a43eaac48c6ae4712ca8adbee7f4e111ff3d4a1223fbb29431b7c06d7599811cef490bb2ba1cc12d2f601ae05a19079171cf3496c73fad3c01fbdba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/119ab6b508695b0c690346bd93ecaff44f148bdb94f541aa58fc74d9911b7297620557ace0105400cc484462921055151afc67d2f82b1f8258f8e5f0797ec5b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf6a85bbb7e9c838118be4794bdc2c6fe55590bcfd260908da0a67d53821a53e970304aba2737075091c53ed05efeee2e486d001fdf49f7222bd6f8dc106b8c3"} 18:25:16 INFO - Running post-run listener: copy_logs_to_upload_dir 18:25:16 INFO - Copying logs to upload dir... 18:25:16 INFO - mkdir: /builds/slave/test/build/upload/logs 18:25:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.325617 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-15 18:25:16.506004) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 18:25:16.509571) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d32f6c349a43eaac48c6ae4712ca8adbee7f4e111ff3d4a1223fbb29431b7c06d7599811cef490bb2ba1cc12d2f601ae05a19079171cf3496c73fad3c01fbdba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/119ab6b508695b0c690346bd93ecaff44f148bdb94f541aa58fc74d9911b7297620557ace0105400cc484462921055151afc67d2f82b1f8258f8e5f0797ec5b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf6a85bbb7e9c838118be4794bdc2c6fe55590bcfd260908da0a67d53821a53e970304aba2737075091c53ed05efeee2e486d001fdf49f7222bd6f8dc106b8c3"} build_url:https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011087 build_url: 'https://queue.taskcluster.net/v1/task/SPGAF_7fRCGVuX9XpbJP7A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d32f6c349a43eaac48c6ae4712ca8adbee7f4e111ff3d4a1223fbb29431b7c06d7599811cef490bb2ba1cc12d2f601ae05a19079171cf3496c73fad3c01fbdba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/119ab6b508695b0c690346bd93ecaff44f148bdb94f541aa58fc74d9911b7297620557ace0105400cc484462921055151afc67d2f82b1f8258f8e5f0797ec5b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf6a85bbb7e9c838118be4794bdc2c6fe55590bcfd260908da0a67d53821a53e970304aba2737075091c53ed05efeee2e486d001fdf49f7222bd6f8dc106b8c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 18:25:16.534706) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:25:16.534998) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1471309363.233732-1721838214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004631 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:25:16.621953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 18:25:16.622272) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 18:25:16.622575) ========= ========= Total master_lag: 0.17 =========