builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1471039469.94 results: success (0) buildid: 20160812134617 builduid: f1bf0f41c12c4a5fbe0f641770a1593f revision: ef3a50774180e1ccc1b6d210295db8275739b92e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:29.936326) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:29.936893) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:29.937239) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:30.132108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:30.132465) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 15:04:30-- 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% 40.7M=0s 2016-08-12 15:04:30 (40.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220847 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:30.500283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:30.500634) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022634 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:30.645010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 15:04:30.645395) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ef3a50774180e1ccc1b6d210295db8275739b92e --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 ef3a50774180e1ccc1b6d210295db8275739b92e --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=17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 15:04:31,021 truncating revision to first 12 chars 2016-08-12 15:04:31,021 Setting DEBUG logging. 2016-08-12 15:04:31,021 attempt 1/10 2016-08-12 15:04:31,021 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ef3a50774180?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 15:04:31,584 unpacking tar archive at: mozilla-central-ef3a50774180/testing/mozharness/ program finished with exit code 0 elapsedTime=0.969172 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 15:04:31.646116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:31.646498) ========= script_repo_revision: ef3a50774180e1ccc1b6d210295db8275739b92e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:31.646963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:31.647288) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 15:04:31.685126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-12 15:04:31.685568) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:04:32 INFO - MultiFileLogger online at 20160812 15:04:32 in /builds/slave/test 15:04:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:04:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:04:32 INFO - {'append_to_log': False, 15:04:32 INFO - 'base_work_dir': '/builds/slave/test', 15:04:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:04:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:04:32 INFO - 'branch': 'Firefox-Non-PGO', 15:04:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:04:32 INFO - 'config_files': ('talos/linux_config.py',), 15:04:32 INFO - 'default_actions': ('clobber', 15:04:32 INFO - 'read-buildbot-config', 15:04:32 INFO - 'download-and-extract', 15:04:32 INFO - 'populate-webroot', 15:04:32 INFO - 'create-virtualenv', 15:04:32 INFO - 'install', 15:04:32 INFO - 'run-tests'), 15:04:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:04:32 INFO - 'download_minidump_stackwalk': True, 15:04:32 INFO - 'download_symbols': 'ondemand', 15:04:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:04:32 INFO - 'tooltool.py': '/tools/tooltool.py', 15:04:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:04:32 INFO - '/tools/misc-python/virtualenv.py')}, 15:04:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:04:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:04:32 INFO - 'installer_path': 'installer.exe', 15:04:32 INFO - 'log_level': 'info', 15:04:32 INFO - 'log_name': 'talos', 15:04:32 INFO - 'log_to_console': True, 15:04:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:04:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:04:32 INFO - 'opt_config_files': (), 15:04:32 INFO - 'pip_index': False, 15:04:32 INFO - 'sps_profile': False, 15:04:32 INFO - 'sps_profile_interval': 0, 15:04:32 INFO - 'suite': 'dromaeojs-e10s', 15:04:32 INFO - 'system_bits': '32', 15:04:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:04:32 INFO - 'title': 'talos-linux64-ix-009', 15:04:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:04:32 INFO - 'use_talos_json': True, 15:04:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:04:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:04:32 INFO - 'work_dir': 'build'} 15:04:32 INFO - [mozharness: 2016-08-12 22:04:32.150817Z] Running clobber step. 15:04:32 INFO - Running pre-action listener: _resource_record_pre_action 15:04:32 INFO - Running main action method: clobber 15:04:32 INFO - rmtree: /builds/slave/test/build 15:04:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:04:32 INFO - Running post-action listener: _resource_record_post_action 15:04:32 INFO - [mozharness: 2016-08-12 22:04:32.613584Z] Finished clobber step (success) 15:04:32 INFO - [mozharness: 2016-08-12 22:04:32.613687Z] Running read-buildbot-config step. 15:04:32 INFO - Running pre-action listener: _resource_record_pre_action 15:04:32 INFO - Running main action method: read_buildbot_config 15:04:32 INFO - Using buildbot properties: 15:04:32 INFO - { 15:04:32 INFO - "project": "", 15:04:32 INFO - "product": "firefox", 15:04:32 INFO - "script_repo_revision": "production", 15:04:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:04:32 INFO - "repository": "", 15:04:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:04:32 INFO - "buildid": "20160812134617", 15:04:32 INFO - "pgo_build": "False", 15:04:32 INFO - "basedir": "/builds/slave/test", 15:04:32 INFO - "buildnumber": 421, 15:04:32 INFO - "slavename": "talos-linux64-ix-009", 15:04:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:04:32 INFO - "platform": "ubuntu64_hw", 15:04:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:04:32 INFO - "branch": "mozilla-central", 15:04:32 INFO - "repo_path": "mozilla-central", 15:04:32 INFO - "revision": "ef3a50774180e1ccc1b6d210295db8275739b92e", 15:04:32 INFO - "stage_platform": "linux64", 15:04:32 INFO - "builduid": "f1bf0f41c12c4a5fbe0f641770a1593f", 15:04:32 INFO - "slavebuilddir": "test" 15:04:32 INFO - } 15:04:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:04:32 INFO - Running post-action listener: _resource_record_post_action 15:04:32 INFO - [mozharness: 2016-08-12 22:04:32.616123Z] Finished read-buildbot-config step (success) 15:04:32 INFO - [mozharness: 2016-08-12 22:04:32.616210Z] Running download-and-extract step. 15:04:32 INFO - Running pre-action listener: _resource_record_pre_action 15:04:32 INFO - Running main action method: download_and_extract 15:04:32 INFO - mkdir: /builds/slave/test/build/tests 15:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:32 INFO - trying https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:04:32 INFO - Downloading https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:04:33 INFO - Downloaded 1361 bytes. 15:04:33 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:04:33 INFO - Using the following test package requirements: 15:04:33 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:04:33 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:04:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:04:33 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:04:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:04:33 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:04:33 INFO - u'jsshell-linux-x86_64.zip'], 15:04:33 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:04:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:04:33 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:04:33 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:04:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:04:33 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:04:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:04:33 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:04:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:04:33 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:04:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:04:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:33 INFO - trying https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:04:33 INFO - Downloading https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:04:34 INFO - Downloaded 20264277 bytes. 15:04:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 15:04:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:38 INFO - trying https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:04:38 INFO - Downloading https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:04:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:04:39 INFO - Downloaded 20264277 bytes. 15:04:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 15:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:43 INFO - trying https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:04:43 INFO - Downloading https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:04:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:04:44 INFO - Downloaded 14413719 bytes. 15:04:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 15:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:45 INFO - trying https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:04:45 INFO - Downloading https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:04:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:04:46 INFO - Downloaded 55608548 bytes. 15:04:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:04:46 INFO - mkdir: /builds/slave/test/properties 15:04:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:04:46 INFO - Writing to file /builds/slave/test/properties/build_url 15:04:46 INFO - Contents: 15:04:46 INFO - build_url:https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:04:46 INFO - Running post-action listener: _resource_record_post_action 15:04:46 INFO - Running post-action listener: set_extra_try_arguments 15:04:46 INFO - [mozharness: 2016-08-12 22:04:46.940511Z] Finished download-and-extract step (success) 15:04:46 INFO - [mozharness: 2016-08-12 22:04:46.940737Z] Running populate-webroot step. 15:04:46 INFO - Running pre-action listener: _resource_record_pre_action 15:04:46 INFO - Running main action method: populate_webroot 15:04:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:04:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:04:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:04:46 INFO - '--tppagecycles', 15:04:46 INFO - '7'], 15:04:46 INFO - 'tests': ['tsvgm']}}, 15:04:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:04:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:04:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:04:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:04:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:46 INFO - 'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:04:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:04:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:46 INFO - 'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['damp', 'tps']}, 15:04:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:46 INFO - 'tests': ['damp', 'tps']}, 15:04:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['dromaeo_dom']}, 15:04:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:04:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['basic_compositor_video']}, 15:04:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:04:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['a11yr', 15:04:46 INFO - 'ts_paint', 15:04:46 INFO - 'tpaint', 15:04:46 INFO - 'sessionrestore', 15:04:46 INFO - 'sessionrestore_no_auto_restore', 15:04:46 INFO - 'tabpaint']}, 15:04:46 INFO - 'other-e10s': {'tests': ['a11yr', 15:04:46 INFO - 'ts_paint', 15:04:46 INFO - 'tpaint', 15:04:46 INFO - 'sessionrestore', 15:04:46 INFO - 'sessionrestore_no_auto_restore', 15:04:46 INFO - 'tabpaint']}, 15:04:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:04:46 INFO - 'ts_paint', 15:04:46 INFO - 'tpaint', 15:04:46 INFO - 'sessionrestore', 15:04:46 INFO - 'sessionrestore_no_auto_restore', 15:04:46 INFO - 'tabpaint']}, 15:04:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:04:46 INFO - 'ts_paint', 15:04:46 INFO - 'tpaint', 15:04:46 INFO - 'sessionrestore', 15:04:46 INFO - 'sessionrestore_no_auto_restore', 15:04:46 INFO - 'tabpaint']}, 15:04:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['a11yr', 15:04:46 INFO - 'ts_paint', 15:04:46 INFO - 'tpaint', 15:04:46 INFO - 'sessionrestore', 15:04:46 INFO - 'sessionrestore_no_auto_restore', 15:04:46 INFO - 'tabpaint']}, 15:04:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['a11yr', 15:04:46 INFO - 'ts_paint', 15:04:46 INFO - 'tpaint', 15:04:46 INFO - 'sessionrestore', 15:04:46 INFO - 'sessionrestore_no_auto_restore', 15:04:46 INFO - 'tabpaint']}, 15:04:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['tsvgx', 15:04:46 INFO - 'tsvgr_opacity', 15:04:46 INFO - 'tart', 15:04:46 INFO - 'tscrollx', 15:04:46 INFO - 'cart']}, 15:04:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:04:46 INFO - 'tsvgr_opacity', 15:04:46 INFO - 'tart', 15:04:46 INFO - 'tscrollx', 15:04:46 INFO - 'cart']}, 15:04:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:46 INFO - 'talos_options': ['--disable-e10s'], 15:04:46 INFO - 'tests': ['tp5o']}, 15:04:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:46 INFO - 'tests': ['tp5o']}, 15:04:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:46 INFO - 'talos_options': ['--disable-e10s', 15:04:46 INFO - '--xperf_path', 15:04:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:04:46 INFO - 'tests': ['tp5n']}, 15:04:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:46 INFO - 'talos_options': ['--xperf_path', 15:04:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:04:46 INFO - 'tests': ['tp5n']}}, 15:04:46 INFO - 'talos.zip': {'path': '', 15:04:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:04:46 INFO - Running post-action listener: _resource_record_post_action 15:04:46 INFO - [mozharness: 2016-08-12 22:04:46.957219Z] Finished populate-webroot step (success) 15:04:46 INFO - [mozharness: 2016-08-12 22:04:46.957308Z] Running create-virtualenv step. 15:04:46 INFO - Running pre-action listener: _resource_record_pre_action 15:04:46 INFO - Running main action method: create_virtualenv 15:04:46 INFO - Creating virtualenv /builds/slave/test/build/venv 15:04:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:04:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:04:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:04:47 INFO - Using real prefix '/usr' 15:04:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:04:47 INFO - Installing distribute.............................................................................................................................................................................................done. 15:04:49 INFO - Installing pip.................done. 15:04:49 INFO - Return code: 0 15:04:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:49 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 0x7f08f766df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:04:49 INFO - Using env: {'DISPLAY': ':0', 15:04:49 INFO - 'HOME': '/home/cltbld', 15:04:49 INFO - 'LANG': 'en_US.UTF-8', 15:04:49 INFO - 'LANGUAGE': 'en_US:en', 15:04:49 INFO - 'LOGNAME': 'cltbld', 15:04:49 INFO - 'MAIL': '/var/mail/cltbld', 15:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:49 INFO - 'MOZ_NO_REMOTE': '1', 15:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:49 INFO - 'NO_EM_RESTART': '1', 15:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:49 INFO - 'PWD': '/builds/slave/test', 15:04:49 INFO - 'SHELL': '/bin/bash', 15:04:49 INFO - 'SHLVL': '1', 15:04:49 INFO - 'TERM': 'linux', 15:04:49 INFO - 'TMOUT': '86400', 15:04:49 INFO - 'USER': 'cltbld', 15:04:49 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:49 INFO - '_': '/tools/buildbot/bin/python'} 15:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:04:49 INFO - Cleaning up... 15:04:49 INFO - Return code: 0 15:04:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:49 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 0x7f08f766df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:04:49 INFO - Using env: {'DISPLAY': ':0', 15:04:49 INFO - 'HOME': '/home/cltbld', 15:04:49 INFO - 'LANG': 'en_US.UTF-8', 15:04:49 INFO - 'LANGUAGE': 'en_US:en', 15:04:49 INFO - 'LOGNAME': 'cltbld', 15:04:49 INFO - 'MAIL': '/var/mail/cltbld', 15:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:49 INFO - 'MOZ_NO_REMOTE': '1', 15:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:49 INFO - 'NO_EM_RESTART': '1', 15:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:49 INFO - 'PWD': '/builds/slave/test', 15:04:49 INFO - 'SHELL': '/bin/bash', 15:04:49 INFO - 'SHLVL': '1', 15:04:49 INFO - 'TERM': 'linux', 15:04:49 INFO - 'TMOUT': '86400', 15:04:49 INFO - 'USER': 'cltbld', 15:04:49 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:49 INFO - '_': '/tools/buildbot/bin/python'} 15:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:49 INFO - Downloading/unpacking psutil>=3.1.1 15:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:04:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:04:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:04:51 INFO - Installing collected packages: psutil 15:04:51 INFO - Running setup.py install for psutil 15:04:52 INFO - building 'psutil._psutil_linux' extension 15:04:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:04:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:04:52 INFO - building 'psutil._psutil_posix' extension 15:04:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:04:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:04:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:04:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:04:52 INFO - Successfully installed psutil 15:04:52 INFO - Cleaning up... 15:04:52 INFO - Return code: 0 15:04:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:52 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 0x7f08f766df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:04:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:04:52 INFO - Using env: {'DISPLAY': ':0', 15:04:52 INFO - 'HOME': '/home/cltbld', 15:04:52 INFO - 'LANG': 'en_US.UTF-8', 15:04:52 INFO - 'LANGUAGE': 'en_US:en', 15:04:52 INFO - 'LOGNAME': 'cltbld', 15:04:52 INFO - 'MAIL': '/var/mail/cltbld', 15:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:52 INFO - 'MOZ_NO_REMOTE': '1', 15:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:52 INFO - 'NO_EM_RESTART': '1', 15:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:52 INFO - 'PWD': '/builds/slave/test', 15:04:52 INFO - 'SHELL': '/bin/bash', 15:04:52 INFO - 'SHLVL': '1', 15:04:52 INFO - 'TERM': 'linux', 15:04:52 INFO - 'TMOUT': '86400', 15:04:52 INFO - 'USER': 'cltbld', 15:04:52 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:52 INFO - '_': '/tools/buildbot/bin/python'} 15:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:04:54 INFO - Installing collected packages: mozsystemmonitor 15:04:54 INFO - Running setup.py install for mozsystemmonitor 15:04:54 INFO - Successfully installed mozsystemmonitor 15:04:54 INFO - Cleaning up... 15:04:54 INFO - Return code: 0 15:04:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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', '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 0x7f08f766df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15: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 jsonschema==2.5.1 15:04:54 INFO - Using env: {'DISPLAY': ':0', 15:04:54 INFO - 'HOME': '/home/cltbld', 15:04:54 INFO - 'LANG': 'en_US.UTF-8', 15:04:54 INFO - 'LANGUAGE': 'en_US:en', 15:04:54 INFO - 'LOGNAME': 'cltbld', 15:04:54 INFO - 'MAIL': '/var/mail/cltbld', 15:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:54 INFO - 'MOZ_NO_REMOTE': '1', 15:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:54 INFO - 'NO_EM_RESTART': '1', 15:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:54 INFO - 'PWD': '/builds/slave/test', 15:04:54 INFO - 'SHELL': '/bin/bash', 15:04:54 INFO - 'SHLVL': '1', 15:04:54 INFO - 'TERM': 'linux', 15:04:54 INFO - 'TMOUT': '86400', 15:04:54 INFO - 'USER': 'cltbld', 15:04:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:54 INFO - '_': '/tools/buildbot/bin/python'} 15:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:54 INFO - Downloading/unpacking jsonschema==2.5.1 15:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:04:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:04:57 INFO - warning: no files found matching '*.txt' 15:04:57 INFO - no previously-included directories found matching 'build' 15:04:57 INFO - no previously-included directories found matching 'dist' 15:04:57 INFO - no previously-included directories found matching '.git*' 15:04:57 INFO - Installing collected packages: jsonschema, functools32 15:04:57 INFO - Running setup.py install for functools32 15:04:57 INFO - warning: no files found matching '*.txt' 15:04:57 INFO - no previously-included directories found matching 'build' 15:04:57 INFO - no previously-included directories found matching 'dist' 15:04:57 INFO - no previously-included directories found matching '.git*' 15:04:57 INFO - Successfully installed jsonschema functools32 15:04:57 INFO - Cleaning up... 15:04:57 INFO - Return code: 0 15:04:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:57 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 0x7f08f766df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:04:57 INFO - Using env: {'DISPLAY': ':0', 15:04:57 INFO - 'HOME': '/home/cltbld', 15:04:57 INFO - 'LANG': 'en_US.UTF-8', 15:04:57 INFO - 'LANGUAGE': 'en_US:en', 15:04:57 INFO - 'LOGNAME': 'cltbld', 15:04:57 INFO - 'MAIL': '/var/mail/cltbld', 15:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:57 INFO - 'MOZ_NO_REMOTE': '1', 15:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:57 INFO - 'NO_EM_RESTART': '1', 15:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:57 INFO - 'PWD': '/builds/slave/test', 15:04:57 INFO - 'SHELL': '/bin/bash', 15:04:57 INFO - 'SHLVL': '1', 15:04:57 INFO - 'TERM': 'linux', 15:04:57 INFO - 'TMOUT': '86400', 15:04:57 INFO - 'USER': 'cltbld', 15:04:57 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:57 INFO - '_': '/tools/buildbot/bin/python'} 15:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:04:57 INFO - Cleaning up... 15:04:57 INFO - Return code: 0 15:04:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:57 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 0x7f08f766df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:04:57 INFO - Using env: {'DISPLAY': ':0', 15:04:57 INFO - 'HOME': '/home/cltbld', 15:04:57 INFO - 'LANG': 'en_US.UTF-8', 15:04:57 INFO - 'LANGUAGE': 'en_US:en', 15:04:57 INFO - 'LOGNAME': 'cltbld', 15:04:57 INFO - 'MAIL': '/var/mail/cltbld', 15:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:57 INFO - 'MOZ_NO_REMOTE': '1', 15:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:57 INFO - 'NO_EM_RESTART': '1', 15:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:57 INFO - 'PWD': '/builds/slave/test', 15:04:57 INFO - 'SHELL': '/bin/bash', 15:04:57 INFO - 'SHLVL': '1', 15:04:57 INFO - 'TERM': 'linux', 15:04:57 INFO - 'TMOUT': '86400', 15:04:57 INFO - 'USER': 'cltbld', 15:04:57 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:57 INFO - '_': '/tools/buildbot/bin/python'} 15:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:57 INFO - Downloading/unpacking blobuploader==1.2.4 15:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:04:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:05:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:00 INFO - Downloading docopt-0.6.1.tar.gz 15:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:05:00 INFO - Installing collected packages: blobuploader, requests, docopt 15:05:00 INFO - Running setup.py install for blobuploader 15:05:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:05:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:05:00 INFO - Running setup.py install for requests 15:05:00 INFO - Running setup.py install for docopt 15:05:00 INFO - Successfully installed blobuploader requests docopt 15:05:00 INFO - Cleaning up... 15:05:01 INFO - Return code: 0 15:05:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:01 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 0x7f08f766df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:05:01 INFO - Using env: {'DISPLAY': ':0', 15:05:01 INFO - 'HOME': '/home/cltbld', 15:05:01 INFO - 'LANG': 'en_US.UTF-8', 15:05:01 INFO - 'LANGUAGE': 'en_US:en', 15:05:01 INFO - 'LOGNAME': 'cltbld', 15:05:01 INFO - 'MAIL': '/var/mail/cltbld', 15:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:01 INFO - 'MOZ_NO_REMOTE': '1', 15:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:01 INFO - 'NO_EM_RESTART': '1', 15:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:01 INFO - 'PWD': '/builds/slave/test', 15:05:01 INFO - 'SHELL': '/bin/bash', 15:05:01 INFO - 'SHLVL': '1', 15:05:01 INFO - 'TERM': 'linux', 15:05:01 INFO - 'TMOUT': '86400', 15:05:01 INFO - 'USER': 'cltbld', 15:05:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:01 INFO - '_': '/tools/buildbot/bin/python'} 15:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:01 INFO - Running setup.py (path:/tmp/pip-V3nlZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:01 INFO - Running setup.py (path:/tmp/pip-DqqHBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:01 INFO - Running setup.py (path:/tmp/pip-Qgpzbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:01 INFO - Running setup.py (path:/tmp/pip-r0a1Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:01 INFO - Running setup.py (path:/tmp/pip-8BM4x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:01 INFO - Running setup.py (path:/tmp/pip-rzD5oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:01 INFO - Running setup.py (path:/tmp/pip-IgcYG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:01 INFO - Running setup.py (path:/tmp/pip-HPNFDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:01 INFO - Running setup.py (path:/tmp/pip-FHu1dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:01 INFO - Running setup.py (path:/tmp/pip-QPSOwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:01 INFO - Running setup.py (path:/tmp/pip-sDXH1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:02 INFO - Running setup.py (path:/tmp/pip-7RzCO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:02 INFO - Running setup.py (path:/tmp/pip-VdYIYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:02 INFO - Running setup.py (path:/tmp/pip-nc9zD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:02 INFO - Running setup.py (path:/tmp/pip-KtPtm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:02 INFO - Running setup.py (path:/tmp/pip-keYkTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:02 INFO - Running setup.py (path:/tmp/pip-QjoT7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:05:02 INFO - Running setup.py install for manifestparser 15:05:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:05:02 INFO - Running setup.py install for mozcrash 15:05:02 INFO - Running setup.py install for mozdebug 15:05:02 INFO - Running setup.py install for mozdevice 15:05:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:05:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:05:02 INFO - Running setup.py install for mozfile 15:05:02 INFO - Running setup.py install for mozhttpd 15:05:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Running setup.py install for mozinfo 15:05:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Running setup.py install for mozInstall 15:05:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Running setup.py install for mozleak 15:05:03 INFO - Running setup.py install for mozlog 15:05:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Running setup.py install for moznetwork 15:05:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Running setup.py install for mozprocess 15:05:03 INFO - Running setup.py install for mozprofile 15:05:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Running setup.py install for mozrunner 15:05:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:05:03 INFO - Running setup.py install for mozscreenshot 15:05:04 INFO - Running setup.py install for moztest 15:05:04 INFO - Running setup.py install for mozversion 15:05:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:05:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:05:04 INFO - Cleaning up... 15:05:04 INFO - Return code: 0 15:05:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:04 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 0x7f08f766df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:05:04 INFO - Using env: {'DISPLAY': ':0', 15:05:04 INFO - 'HOME': '/home/cltbld', 15:05:04 INFO - 'LANG': 'en_US.UTF-8', 15:05:04 INFO - 'LANGUAGE': 'en_US:en', 15:05:04 INFO - 'LOGNAME': 'cltbld', 15:05:04 INFO - 'MAIL': '/var/mail/cltbld', 15:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:04 INFO - 'MOZ_NO_REMOTE': '1', 15:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:04 INFO - 'NO_EM_RESTART': '1', 15:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:04 INFO - 'PWD': '/builds/slave/test', 15:05:04 INFO - 'SHELL': '/bin/bash', 15:05:04 INFO - 'SHLVL': '1', 15:05:04 INFO - 'TERM': 'linux', 15:05:04 INFO - 'TMOUT': '86400', 15:05:04 INFO - 'USER': 'cltbld', 15:05:04 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:04 INFO - '_': '/tools/buildbot/bin/python'} 15:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:04 INFO - Running setup.py (path:/tmp/pip-ZK4Jyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:04 INFO - Running setup.py (path:/tmp/pip-pVQyXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:04 INFO - Running setup.py (path:/tmp/pip-3n3DL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:04 INFO - Running setup.py (path:/tmp/pip-2wbbv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:04 INFO - Running setup.py (path:/tmp/pip-oJi9Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:04 INFO - Running setup.py (path:/tmp/pip-Fhw3BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:04 INFO - Running setup.py (path:/tmp/pip-9lqRri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:04 INFO - Running setup.py (path:/tmp/pip-GIDykr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:05 INFO - Running setup.py (path:/tmp/pip-CV_ROh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:05 INFO - Running setup.py (path:/tmp/pip-tfMRNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:05 INFO - Running setup.py (path:/tmp/pip-ZQzPZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:05 INFO - Running setup.py (path:/tmp/pip-AVRXmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:05 INFO - Running setup.py (path:/tmp/pip-wZCiEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:05 INFO - Running setup.py (path:/tmp/pip-1Drf05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:05 INFO - Running setup.py (path:/tmp/pip-8nXAwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:05 INFO - Running setup.py (path:/tmp/pip-ouVcUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:05 INFO - Running setup.py (path:/tmp/pip-bwqSyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:05:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15: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 15: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 15: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 15: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 15: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 15: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 15:05:07 INFO - Downloading blessings-1.6.tar.gz 15:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:05:07 INFO - Installing collected packages: blessings 15:05:07 INFO - Running setup.py install for blessings 15:05:07 INFO - Successfully installed blessings 15:05:07 INFO - Cleaning up... 15:05:07 INFO - Return code: 0 15:05:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:05:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:05:08 INFO - Reading from file tmpfile_stdout 15:05:08 INFO - Current package versions: 15:05:08 INFO - argparse == 1.2.1 15:05:08 INFO - blessings == 1.6 15:05:08 INFO - blobuploader == 1.2.4 15:05:08 INFO - docopt == 0.6.1 15:05:08 INFO - functools32 == 3.2.3-2 15:05:08 INFO - jsonschema == 2.5.1 15:05:08 INFO - manifestparser == 1.1 15:05:08 INFO - mozInstall == 1.12 15:05:08 INFO - mozcrash == 0.17 15:05:08 INFO - mozdebug == 0.1 15:05:08 INFO - mozdevice == 0.48 15:05:08 INFO - mozfile == 1.2 15:05:08 INFO - mozhttpd == 0.7 15:05:08 INFO - mozinfo == 0.9 15:05:08 INFO - mozleak == 0.1 15:05:08 INFO - mozlog == 3.3 15:05:08 INFO - moznetwork == 0.27 15:05:08 INFO - mozprocess == 0.23 15:05:08 INFO - mozprofile == 0.28 15:05:08 INFO - mozrunner == 6.12 15:05:08 INFO - mozscreenshot == 0.1 15:05:08 INFO - mozsystemmonitor == 0.3 15:05:08 INFO - moztest == 0.7 15:05:08 INFO - mozversion == 1.4 15:05:08 INFO - psutil == 3.1.1 15:05:08 INFO - requests == 1.2.3 15:05:08 INFO - wsgiref == 0.1.2 15:05:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:08 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 0x7f08f766df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:05:08 INFO - Using env: {'DISPLAY': ':0', 15:05:08 INFO - 'HOME': '/home/cltbld', 15:05:08 INFO - 'LANG': 'en_US.UTF-8', 15:05:08 INFO - 'LANGUAGE': 'en_US:en', 15:05:08 INFO - 'LOGNAME': 'cltbld', 15:05:08 INFO - 'MAIL': '/var/mail/cltbld', 15:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:08 INFO - 'MOZ_NO_REMOTE': '1', 15:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:08 INFO - 'NO_EM_RESTART': '1', 15:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:08 INFO - 'PWD': '/builds/slave/test', 15:05:08 INFO - 'SHELL': '/bin/bash', 15:05:08 INFO - 'SHLVL': '1', 15:05:08 INFO - 'TERM': 'linux', 15:05:08 INFO - 'TMOUT': '86400', 15:05:08 INFO - 'USER': 'cltbld', 15:05:08 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:08 INFO - '_': '/tools/buildbot/bin/python'} 15:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:05:08 INFO - Cleaning up... 15:05:08 INFO - Return code: 0 15:05:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:08 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 0x7f08f766df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:05:08 INFO - Using env: {'DISPLAY': ':0', 15:05:08 INFO - 'HOME': '/home/cltbld', 15:05:08 INFO - 'LANG': 'en_US.UTF-8', 15:05:08 INFO - 'LANGUAGE': 'en_US:en', 15:05:08 INFO - 'LOGNAME': 'cltbld', 15:05:08 INFO - 'MAIL': '/var/mail/cltbld', 15:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:08 INFO - 'MOZ_NO_REMOTE': '1', 15:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:08 INFO - 'NO_EM_RESTART': '1', 15:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:08 INFO - 'PWD': '/builds/slave/test', 15:05:08 INFO - 'SHELL': '/bin/bash', 15:05:08 INFO - 'SHLVL': '1', 15:05:08 INFO - 'TERM': 'linux', 15:05:08 INFO - 'TMOUT': '86400', 15:05:08 INFO - 'USER': 'cltbld', 15:05:08 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:08 INFO - '_': '/tools/buildbot/bin/python'} 15:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:05:08 INFO - Cleaning up... 15:05:08 INFO - Return code: 0 15:05:08 INFO - Running post-action listener: _resource_record_post_action 15:05:08 INFO - Running post-action listener: _start_resource_monitoring 15:05:08 INFO - Starting resource monitoring. 15:05:08 INFO - [mozharness: 2016-08-12 22:05:08.504937Z] Finished create-virtualenv step (success) 15:05:08 INFO - [mozharness: 2016-08-12 22:05:08.505398Z] Running install step. 15:05:08 INFO - Running pre-action listener: _resource_record_pre_action 15:05:08 INFO - Running main action method: install 15:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:05:08 INFO - Reading from file tmpfile_stdout 15:05:08 INFO - Detecting whether we're running mozinstall >=1.0... 15:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:05:08 INFO - Reading from file tmpfile_stdout 15:05:08 INFO - Output received: 15:05:08 INFO - Usage: mozinstall [options] installer 15:05:08 INFO - Options: 15:05:08 INFO - -h, --help show this help message and exit 15:05:08 INFO - -d DEST, --destination=DEST 15:05:08 INFO - Directory to install application into. [default: 15:05:08 INFO - "/builds/slave/test"] 15:05:08 INFO - --app=APP Application being installed. [default: firefox] 15:05:08 INFO - mkdir: /builds/slave/test/build/application 15:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:05:25 INFO - Reading from file tmpfile_stdout 15:05:25 INFO - Output received: 15:05:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:05:25 INFO - Running post-action listener: _resource_record_post_action 15:05:25 INFO - [mozharness: 2016-08-12 22:05:25.347117Z] Finished install step (success) 15:05:25 INFO - [mozharness: 2016-08-12 22:05:25.347365Z] Running run-tests step. 15:05:25 INFO - Running pre-action listener: _resource_record_pre_action 15:05:25 INFO - Running main action method: run_tests 15:05:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:05:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:05:25 INFO - Python 2.7.3 15:05:25 INFO - Return code: 0 15:05:25 INFO - grabbing minidump binary from tooltool 15:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:25 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 0x1ac3090>, '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 0x1ac69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:05:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:05:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:05:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:05:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:05:25 INFO - Return code: 0 15:05:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:05:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:05:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:05:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:05:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:05:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 15:05:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 15:05:25 INFO - Using env: {'DISPLAY': ':0', 15:05:25 INFO - 'HOME': '/home/cltbld', 15:05:25 INFO - 'LANG': 'en_US.UTF-8', 15:05:25 INFO - 'LANGUAGE': 'en_US:en', 15:05:25 INFO - 'LOGNAME': 'cltbld', 15:05:25 INFO - 'MAIL': '/var/mail/cltbld', 15:05:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:05:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:25 INFO - 'MOZ_NO_REMOTE': '1', 15:05:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:25 INFO - 'NO_EM_RESTART': '1', 15:05:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:25 INFO - 'PWD': '/builds/slave/test', 15:05:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:05:25 INFO - 'SHELL': '/bin/bash', 15:05:25 INFO - 'SHLVL': '1', 15:05:25 INFO - 'TERM': 'linux', 15:05:25 INFO - 'TMOUT': '86400', 15:05:25 INFO - 'USER': 'cltbld', 15:05:25 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787', 15:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:25 INFO - '_': '/tools/buildbot/bin/python'} 15:05:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 15:05:25 INFO - mozversion application_buildid: 20160812134617 15:05:25 INFO - mozversion application_changeset: ef3a50774180e1ccc1b6d210295db8275739b92e 15:05:25 INFO - mozversion application_display_name: Nightly 15:05:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:05:25 INFO - mozversion application_name: Firefox 15:05:25 INFO - mozversion application_remotingname: firefox 15:05:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:05:25 INFO - mozversion application_vendor: Mozilla 15:05:25 INFO - mozversion application_version: 51.0a1 15:05:25 INFO - mozversion platform_buildid: 20160812134617 15:05:25 INFO - mozversion platform_changeset: ef3a50774180e1ccc1b6d210295db8275739b92e 15:05:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:05:25 INFO - mozversion platform_version: 51.0a1 15:05:25 INFO - using testdate: 1471039525 15:05:25 INFO - actual date: 1471039525 15:05:25 INFO - starting webserver on 'localhost:44740' 15:05:25 INFO - SUITE-START | Running 2 tests 15:05:25 INFO - TEST-START | dromaeo_css 15:05:25 INFO - operating with platform_type : linux_ 15:05:25 INFO - Initialising browser for dromaeo_css test... 15:05:25 INFO - TEST-INFO | started process 9119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtTMuR/profile http://localhost:44740/getInfo.html) 15:05:30 INFO - PROCESS | 9119 | __metrics Screen width/height:1600/1200 15:05:30 INFO - PROCESS | 9119 | colorDepth:24 15:05:30 INFO - PROCESS | 9119 | Browser inner width/height: 1024/697 15:05:30 INFO - PROCESS | 9119 | __metrics 15:05:31 ERROR - PROCESS | 9119 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 15:05:31 INFO - TEST-INFO | 9119: exit 0 15:05:31 INFO - Browser initialized. 15:05:31 INFO - Running cycle 1/1 for dromaeo_css test... 15:05:31 INFO - TEST-INFO | started process 9238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtTMuR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:05:43 INFO - PROCESS | 9238 | RSS: Main: 164081664 15:05:43 INFO - PROCESS | 9238 | 15:06:33 INFO - PROCESS | 9238 | 1471039593395 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] 15:08:46 INFO - PROCESS | 9238 | Cycle 1(1): loaded http://localhost:44740/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44740/tests/dromaeo/cssquery-ext.html) 15:08:47 INFO - PROCESS | 9238 | RSS: Main: 165117952 15:08:47 INFO - PROCESS | 9238 | 15:11:50 INFO - PROCESS | 9238 | Cycle 1(1): loaded http://localhost:44740/tests/dromaeo/cssquery-ext.html (next: http://localhost:44740/tests/dromaeo/cssquery-jquery.html) 15:11:50 INFO - PROCESS | 9238 | RSS: Main: 164749312 15:11:50 INFO - PROCESS | 9238 | 15:14:52 INFO - PROCESS | 9238 | Cycle 1(1): loaded http://localhost:44740/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44740/tests/dromaeo/cssquery-mootools.html) 15:14:53 INFO - PROCESS | 9238 | RSS: Main: 165629952 15:14:53 INFO - PROCESS | 9238 | 15:17:55 INFO - PROCESS | 9238 | Cycle 1(1): loaded http://localhost:44740/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44740/tests/dromaeo/cssquery-prototype.html) 15:17:56 INFO - PROCESS | 9238 | RSS: Main: 163676160 15:17:56 INFO - PROCESS | 9238 | 15:20:58 INFO - PROCESS | 9238 | Cycle 1(1): loaded http://localhost:44740/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44740/tests/dromaeo/cssquery-yui.html) 15:20:59 INFO - PROCESS | 9238 | RSS: Main: 165224448 15:20:59 INFO - PROCESS | 9238 | 15:24:02 INFO - PROCESS | 9238 | Cycle 1(1): loaded http://localhost:44740/tests/dromaeo/cssquery-yui.html (next: http://localhost:44740/tests/dromaeo/cssquery-dojo.html) 15:24:02 INFO - PROCESS | 9238 | RSS: Main: 166494208 15:24:02 INFO - PROCESS | 9238 | 15:24:02 INFO - PROCESS | 9238 | __start_tp_report 15:24:02 INFO - PROCESS | 9238 | _x_x_mozilla_page_load 15:24:02 INFO - PROCESS | 9238 | _x_x_mozilla_page_load_details 15:24:02 INFO - PROCESS | 9238 | |i|pagename|runs| 15:24:02 INFO - PROCESS | 9238 | |0;dojo.html;2668.546347120989;2682.530557152499;2689.152916831198;2705.891764329427;2713.145359211849;4763.690360126589;4793.999999999995;4797.784099715513;4862.781174847131;4870.829520966767;4711.175544279755;4772.546608072236;4791.880202994927;4797.160496913044;4803.807847686097;4345.3916451696705;4428.689991700582;4453.309736990772;4530.614897733697;4551.658625603093;4434.822607095713;4445.777711114448;4481.148581769469;4484.013517026249;4522.208613492642;4347.2826983547675;4388.868333949987;4420.513743488214;4431.889202769924;4473.843415480475;4374.737515749065;4401.5818497243035;4414.448193975753;4425.513193548707;4433.290673492258;4402.427684401007;4425.601695847389;4448.933266001012;4450.844220452301;4476.2837945928495;4774.832880849153;4811.350467686852;4826.855194344175;4828.155072862235;4861.149298872683;5156.510131537498;5185.248139019821;5189.481051894818;5202.06362854686;5254.185601231815;5210.879660872931;5214.895702085937;5230.058589453897;5241.973790131063;5252.080885845;4681.836135735233;4705.364775755298;4741.170295198395;4857.53853383928;4867.050925069649;5206.193040078718;5243.68537887728;5263.052650522943;5281.12861377876;5299.947000529945;4988.825391111293;4993.325901003391;4995.975020124876;4999.650024498323;5055.6713813602;5074.06129865976;5156.8195113171605;5180.922286165711;5214.765335559909;5265.631405801557;5123.3339665843205;5139.614528910347;5147.794088236504;5162.845114646567;5163;5125.461826508237;5137.897242055213;5144.948550514522;5149.897002059938;5172.741362931838;4320.2655548556195;4421.646268298528;4457.442819647544;4470.418845550058;4522.8643140705835;3866.284737323604;3883.098710779354;3894.279558281727;3920.5295364555864;3933.940990885139;4517.887052823706;4533.070720502289;4536.047430039728;4538.205813982539;4580.702254353457;5112.156494178494;5135.845924622193;5166.741662916915;5199.740012999335;5260.053190425683;4462.776861156929;4470.709403888737;4480.193565158238;4483.955160448354;4535.750533720677;4687.554682305175;4693.859184224479;4700.882477938079;4710.646701497401;4737.1236321279985;4727.503612120678;4803.5916947059895;4867.61059115277;4870.318155458168;4917.532834380728;5182.300389447527;5188.7405629717605;5191.454897235887;5193.7403129844115;5204.609654275869;4849.854504364875;4853.32376424145;4884.218525036119;4897.975510122426;4914.926276105933;4980.526849949249;5068.391792984866;5097.0315640028275;5117.232415137759;5145.45972672864;5182.455842136521;5187.144121220107;5190.844274671766;5192.714400707997;5193.169092945111;5036.093503169464;5048.167052436307;5054.974725126351;5056;5081.644284900021;4978.079055374767;4979.5269449403695;5005;5024.899502010013;5066.31604733371;4898.804047838046;4926.162552366178;4940.975295123501;4961.603071754179;4983.700977941335;5020.397552293748;5031.993601279685;5042.09242336383;5043.193089105725;5097.541221290102;4844.006978569314;4935.703857768545;4960.950390496193;4986.850394488171;5022.246663000579 15:24:02 INFO - PROCESS | 9238 | |1;ext.html;540.3866611396065;547.4990383798824;548.9368722596901;552.5938435250089;580.0689892722183;34600.99999999997;38364.808175959115;38445.231095378076;38517.22965540695;38563.61436385635;38071.61928380715;38472.422913656315;38532.22935541288;38643.61356386435;38829.029274268156;7596.772096837104;7661.770146895602;7665.42509311801;7720.1121870985;7731.304182623563;7622.352100071501;7650.426218033642;7660.540367577935;7693.923060769376;7726.536407815549;7653.425993050543;7752.922470775276;7769.18423565526;7771.727989520368;7790.065192176947;7720.7683769487;7729.690812367498;7752.457327987043;7755.1469338372735;7758.767236982928;7588.950983234496;7652.617369131521;7655.1962043985695;7663.080430348338;7673.386129109658;36635.63364366349;37051.1833461651;37094.44358334627;37168.628313717054;37191;2964.1996660901436;3002.4745669507965;3006.564048213019;3176.1741947093924;3200.471922132845;28257.717422825714;28679.85660071707;28919.855400722863;28955.710442895514;29294.853525732236;3304.5538852254876;3325.584301962255;3333.833308334598;3351.4805205193234;3361.9495707564406;252085;253526;254823.99999999814;255204;256028;50536.49463505392;50586.747066264434;50700.74649626728;50835.7458212714;50878.745606272474;32464.67535324664;33231.833840830644;33282.83358583192;53413.465865341626;53434;13138;13266.137701049402;13270.203787772765;13272.203667779771;13288.933555332162;10316.690499285034;10390.06489415941;10413.375197488174;10429.322094063862;10439.37363758177;17507.912460437616;17646.558836029202;17685.911570442066;17759.822401776077;17874;6489.415952564197;6517.804465866032;6676.432503237279;6798.04827324175;6872.381485666314;788.4008153803151;854.4275335525213;877.903430622631;937.5140402462038;941.4210260689626;28535.57196642052;28589.856405743954;28652.426951460853;28743.56884646732;29021.85489072541;935.5976929920064;943.6272672294406;1001.0840081325651;1018.6994836523244;1036.1348274190984;14351.712965740626;14630;14648.2857541287;14677.92661036688;14960.102393856403;383812;386872;387594;388780;389606;46376.53623463722;46804;46832.5316746835;46864.76567617209;46928.5307146931;1165.6677846813618;1176.206060908883;1189.1556994533805;1202.6692659518703;1206.6078524479578;25583.74416255888;27023.324416889736;27721.861390692917;28062.298442538282;28141;42261.78869105635;47090.76454617705;47140.764296179674;47145.2928206084;47218.76390618025;367136;370464;370595;372302;373294;38814.223715526095;39009;39259.214815704094;39356.12877424584;39360.80319598383;41588.58411415968;42610.57389426066;42705;43029.35455968101;43305.56694433015;36096;36439;36614;37026.444603330434;37262.813685931396;35549;36189.27621447504;36341.636583634885;36429.17133258666;36977.815110924275;35542.28915421729;35550.82224588861;35941.82029089838;35965;35999.46000809938;31156.833928197095;31824.8408757964;33245.16887077843;34228.31543369069;34437;25569;26010.73989260159;26128.60807087857;26153.561554113945;26413.867930660224 15:24:02 INFO - PROCESS | 9238 | |2;jquery.html;362.6772172766239;369.25594926223664;373.132467014192;376.3864900212653;386.39722033627544;15743.448979285713;17010.489685309443;17490.212940417696;17670;17693.815113279605;16525.173741312916;16902.74645880313;17166.57083572911;17172.742408863876;17283.567910802238;4974.925376119352;5165.4834516548235;5169.302144210521;5182.248573956774;5184.351956005499;3713.368727316349;5088.592912566985;5624.831255062355;5878.470937615613;5900.380460051697;5962.463378295953;5978.252718410199;5979.671118088503;5979.760809567612;5989;5948.910766338508;6049.848753781169;6051.667158306292;6064.9090263646085;6071.241094863164;5064.265681476202;5130.358705161855;5283.6037297202865;5296.25852380667;5329.413764485904;15170.31733571992;20910.686339704916;21338;21569.784302156935;21705.240316589003;2077.1795140919253;2367.8105751539833;2385.6183010718373;2436.6223235398543;2481.3424442522746;13383.464661413533;13437.581235377627;13499.25754083525;13575.524856630069;13821.378037988214;1681.2350380576809;1711.4437807712418;1728.8357606027407;1729.6627157704252;1752.7945076461644;65984;66541;66723.66638166827;66838.66580667066;67379.66310168467;9774.511274436392;9804.607815687292;9881.308308418342;10089.899101009043;10101.19190464761;13553.25457099869;13594.796078058836;13624.727505450033;13626.659333516742;13641.522546710818;7049.127741999141;7120.821979450555;7140.892886606705;7286.526375785557;7306.050213472215;6634.86730265392;6650.70071846768;6878.209005964278;6947.235804061549;6973.965130174317;6011.458968692838;6084.9311234180595;6103.206583144163;6142;6306.400891915261;1447.6163816588612;1665.6169081111411;1725.2064050536894;1746.7030604797214;1760.8591312694953;380.8419505905074;381.3783532841451;407.72478576960435;410.2287699125625;848.1942154952819;10333.689989300334;10841.566337346418;10973.341599504056;11195.720106997227;11243.26918750295;400.18362540417223;401.7950845069036;404.1956506551941;411.0648275174003;417.0678533477675;5668.149777533403;5851.736671849777;5883.441073098049;5912.526997840162;5924.14099955504;407042;408096;413581;415718;416770;82358.58820705858;82662.58668706738;82879.5856020716;83447;83999;428.63351834181947;433.6335796252162;435.0255427841612;437.76360765186445;438.21778126045496;9941.850872236777;9942.15491683215;10141.340812847142;10193.184545236512;10468.267221294436;37020;37098.8145059273;37435.812820935724;37906.81046594749;38506.422403663404;52782;52882;53688.463115368344;53738;55039;7646.885296720442;7757;7892.684292628231;7985.760427187193;8223.712170074019;11729.178171469914;11884.227525210834;12038.277703337828;12272.140950133406;12556.748865022832;9724.173445256949;10098.394096354243;10408.167346612405;10590.152787776806;10795.784084318113;10452.738681533023;10831.187660925305;10851.620193293196;10854.891451085388;11019;10237.897621023694;10504.737381565523;10550.630727924487;10565.101966332948;10991.560337586407;7672;7722.575258360844;7736.303732663862;7875.566843823644;8130.390220733587;9681.612735490784;10415.68752937413;10416;10645.361278323326;10813.62152324665 15:24:02 INFO - PROCESS | 9238 | |3;mootools.html;1333.5199328241831;1375.312343828086;1454.2801313349894;1645.7202275613145;1661.5762980439986;6895.620740859251;7525.247475252472;7653.961730191341;8169.673213071477;8254.752357429279;7663.770086897388;7928.445008849383;7952.165022672622;7958.4031197660115;7959.681612735483;2173.369722780396;2218.966715499269;2228.843980921336;2232.2410380470637;2240.9215677451293;2199.516106456577;2219.289827255279;2267.2631394796676;2270;2272.6591011348264;2228.3649159989404;2241.3948233976816;2242.4842286274165;2248.235599896035;2259.164109279569;2152.7847215278425;2159.0931808640407;2167.425632207466;2167.6531754919138;2176.7823217678265;2154.332157031325;2163.9242626508153;2164.39396968849;2167.111484291433;2168.8481806273567;8036.116027236999;8090.150534193943;8145.389095817778;8147.551884646342;8155.918440815575;4569.862904112882;4661.743604101773;4669.229577119771;4696.882577935545;4716.858494245178;2840.14396591826;2959.9704002960125;3022.7732920031085;3026.2888221267986;3046.6039414876145;941.9340646154772;973.634886917406;983.1839573154336;987.6543209876558;997.9002099789963;11049.232122860303;11057.889421105847;11104.666859994213;11155.107591392669;11207.327560346324;4010.1378203685763;4258.488981322199;4269.146170765859;4386.342048692658;4415.337699345124;9376.812463750686;9379.24966002718;9386.906130938603;9409.90590094104;9450.33847630673;4664.416947881515;4704.929426058543;4707.152712511781;4711.882202944886;4714.5521175488275;3613.2954073955325;3960.801959902051;4144.191882582867;4219.78901054946;4266.488021437385;3643.4899114124046;3672.6878215351994;3805.7145714071557;3854.4411060396087;3860.3244432224246;1202.537023246039;1205.15036898986;1208.7219939413983;1214.36245970866;1222.5537678747194;778.2373274191324;804.9798755031054;806.2985202873421;811.7280710961776;824.7154731617583;4735.2186889163595;4772.117158325721;4847.612191024709;4920.360353154067;5185.429602743695;398.245325108917;400.20359484625965;402.7502948172152;404.7874865695533;418.7403809638044;3232.69289417505;3316.137804170933;3321.534985102088;3390;3443.466262729281;8985.146411090936;9212.677556285498;9309.767255818524;9603.37578057424;9625.470599116976;9510.714678559654;9617.086376794194;9629.807403852024;9634.566444510014;9640.855387169198;7158.105236845395;7213.098362704767;7260.782176534713;7330.230325815713;7338.449616278694;4917.0903382874285;5218.347706536683;5229.973850130725;5266.947330526799;5401.243825864303;8935.955320223617;8942.239909607757;8951.865722014305;9016.18854303116;9081.409708368936;8806.559672016245;8951.462912225288;9119.224865886474;9238.907610924074;9244.445333280024;6728.596284222962;6884.93115068863;6905.861882762417;6934.653267336714;7004.264552222147;7688.269614386624;7695.92304076952;7765.22347765219;7766.106897706836;7775.183605721318;6673.5328527004585;6922;6928;6960.79117626472;7136.0723105995885;6815.556988795713;6878.415334696607;6899.275576064441;6900.7929762107215;6915.066466027022;6075.36208698098;6097.024476083805;6102.694865256808;6154.169187159855;6183.3816618337805;4210.179015092028;4257.552956939477;4296.871093867189;4333.15503476819;4475.530069342803;4341.717788343748;4358.411614432011;4370.125974805115;4439.334099885043;4480.798364073689 15:24:02 INFO - PROCESS | 9238 | |4;prototype.html;305.7813663230791;305.7920613982492;312.1182658988358;313.877587740781;320.2809692240917;4930.334404855348;5030.572401345881;5045.293658887749;5053.595712343013;5080;5013.899722005558;5018.172001619738;5018.397792264925;5027.371578552681;5032.144535428976;3786.848526058968;3846.8461261549646;3929.626685464876;4014.1369605534805;4033.455483509733;3930.194310166409;3935.134270460494;3941.0541470047124;3966.9884179534324;3968.9801550992206;3907.316219661562;3917.8824635260844;3949;3949.624785645359;3950.881473555798;3822.866199682998;3935.3900145477496;3968.265870813909;3970.5235371755284;3979.6816254699556;3460.619331873492;3462.8614855405754;3469.3061387722555;3482.982585087084;3493.480336053825;4936.395671406807;4941.085899108641;4953.4303555091265;4959.7024178549045;4976.726280054596;4477.865664030084;4498.370228168059;4530.954690453086;4533.659975501818;4533.863984080483;5005.549500544968;5271.209318602202;5292.576593872481;5299.5230429261555;5315.149576067811;3716.7955762433326;3727;3733.925321493582;3734.066483379155;3746.925061498782;5542.944570554283;5579.191017302468;5589.999999999959;5603.691796951166;5610.438956104398;3672;3673.853045878135;3687.0597997511;3730.0674831292176;3843.962130224824;3736.981315093407;3747.4191500317493;3757.9248415032093;3762.3039737648623;3765.548134223911;4378.496472905656;4402.3176407656865;4409.426774519292;4411.18393097278;4429.623482004002;5199.246109314128;5268.868278293074;5322.574194064466;5324.094903866352;5330.72062704948;1321.359140816703;1345.7350090914508;1347.3936728472227;1349.44672684199;1349.4534713441071;827.2926647716237;854.3805740837843;855.9984817763232;874.5976850648773;875.1642181716445;4122.742563518096;4136.469506282695;4397.516273209944;4506.166359223488;4664.183767840615;5425.511703946664;5478.233047373371;5479.863003424866;5489.149181876815;5521.585881058937;4609.423822022247;4639.675222734376;4658.487566367697;4673.322368256584;4690.812367505261;2790.9023184188454;2877.9712202877704;2897.3046468847324;2904.7530959868227;2912.4127350593976;5096.159133742891;5108.667936584185;5118.950615123891;5127.5897928166405;5152.742362881841;5377.811776587879;5552.611317207838;5582.91625625616;5595.328560572757;5615.466530679579;5060.266261392151;5066.746662666852;5073.898522029613;5074.08666440037;5095.923561146586;5435.673859568438;5436.864078398072;5443.401225865073;5486.670799752028;5502.669839809624;5087.567556757717;5287.127623942007;5342.439043900335;5355.25026496283;5369.919451208313;5056.519630635084;5072.463768115942;5073.239014147907;5095.541401273903;5112.437631860566;3799.525059367579;3805.980970095132;3840.8847734568008;3844.8462061517225;3851.9229615408094;5215.348081489814;5429.457054294697;5463.153211252262;5494.5054945055135;5497.74592417107;5278.627556835174;5291;5293.894122117459;5298.046351656739;5307.734613269398;5193.7403129844115;5246.291750613618;5257.975679363396;5265.21021846726;5332.626716129834;4942.7034377936;5146.845594632167;5153.613478989166;5183.2636066918;5205.167173252262;5076.213186956028;5192.9747398515365;5279.779334605811;5316.840494785162;5323.7071961040965;5226.137687281708;5230.163173892159;5234.24103504982;5242.18746094356;5251.579873610179 15:24:02 INFO - PROCESS | 9238 | |5;yui.html;599.463480185234;602.7076867719156;607.1408956326798;684.0423407229878;688.6969733317342;12326.198797078196;13425.664358391045;13489.730205395887;13506.594802155938;14508;12587.307698076602;12782.296973666445;12786.296753678544;12866.099373043868;12873.485060597588;637.480453430455;737.7012310014453;770.2490072179636;777.708359365238;779.3726050529322;773.6789232468547;775.2054144501874;790.2453157234827;793.175097898188;793.1790596732383;815.6248125862081;825.4675734151499;826.1201820061646;828.2090603473669;828.5691440450992;817.648411183191;822.313368337439;823.2960818500186;824.7484517222244;827.9586020699002;599.4544964082664;599.8950183717832;602.8131279303386;603.7584966013629;604.6885853785304;12836.229826210458;12863.871361286361;12869.16350437228;12881.67795805103;12939.158954667917;13648.112872663245;13855.237961912091;14122.717545649131;14247.430102795875;14401.78397324041;10655.733606659896;10761.623343182951;10863.945680271549;10875.510602022849;11006.284591501526;3208.342289830579;3214.6463888972194;3229.434848901433;3259.8696052157884;3277.918052048694;51112.74443627758;66313.68961017567;68430.65784671095;68475;69650.9552356715;9868.407895526292;10454.581816727246;10560.941139001232;10759.677209683721;10925.781484370267;18660.906695466434;18701.06494675288;18729.625407491774;18730.41104929274;18802.905985469984;6905.447564194852;7061.964690176619;7396.112466504054;7488.5506869588;7493.70025198986;3587.6412358763914;3766.6610005099674;3783.8675646352795;3796.544414670257;3862.8841134766003;2836.858157092137;2940.6324209473814;2947.263184203949;2970.628671416073;2974.940501189964;489.3980404102902;490.7399078488407;499.20127795527594;503.2074482689778;534.0520575977594;485.4368932038818;534.5937087813212;536.1341433584732;555.7915781581906;555.9555235581144;7542.132654744665;8163.632636531371;8229.79425514367;8350.79123021917;8411.663533458594;539.3851009848776;564.2241917363625;569.3196630027161;570.8601392658825;605.6699098991061;3827.4258861170492;3897.142628621699;3925.3326934421216;3938.369860822312;4022.35642297231;89157.66263506052;104910;105323;106409;108257;68688.31311686919;76258;77230.45539089186;80209;87257;43089.13821723548;43171.35242971358;43258;45348.77325613417;49354.50645493499;8165.213802294528;8575.271101956403;9023.548822558978;9026.548672566476;9026.684066057656;42815;43434.348484773385;43855.12289754123;44453.777731111135;45145;56408.71795640996;56866.715666421405;61598.38401616106;62380.68809655923;62385.376146237955;10542.683719488428;10619.787604248026;11186;11226.326420414802;11955.103367247666;11467.19729618952;11675.941620291844;11840;11964.760704785682;12595.811062833882;10756.300840445347;10928.562857485611;11348.319100853645;11392.829107563228;11742.943135117881;10644.361338319726;11290.379029153475;11397.430128493708;11423.257488263236;11674.94162529182;11078.335299882034;11564.248323858923;11768.705782355168;11894.107941904218;11975.700607484883;8758.562071896253;9307.441553506811;9335.253179745469;9498.278430805807;9597.136257736836;8461.534615596202;9278.907210927804;9396.906030939603;9407.529623518934;9471.47906865129 15:24:02 INFO - PROCESS | 9238 | __end_tp_report 15:24:02 INFO - PROCESS | 9238 | __start_cc_report 15:24:02 INFO - PROCESS | 9238 | _x_x_mozilla_cycle_collect,370 15:24:02 INFO - PROCESS | 9238 | __end_cc_report 15:24:02 INFO - PROCESS | 9238 | __startTimestamp1471040642769__endTimestamp 15:24:02 INFO - PROCESS | 9238 | 15:24:02 INFO - PROCESS | 9238 | ------- Summary: start ------- 15:24:02 INFO - PROCESS | 9238 | Number of tests: 6 15:24:02 INFO - PROCESS | 9238 | 15:24:02 INFO - PROCESS | 9238 | [#0] dojo.html Cycles:165 Average:4777.96 Median:4884.22 stddev:493.09 (10.1%) stddev-sans-first:466.01 15:24:02 INFO - PROCESS | 9238 | Values: 2668.5 2682.5 2689.2 2705.9 2713.1 4763.7 4794.0 4797.8 4862.8 4870.8 4711.2 4772.5 4791.9 4797.2 4803.8 4345.4 4428.7 4453.3 4530.6 4551.7 4434.8 4445.8 4481.1 4484.0 4522.2 4347.3 4388.9 4420.5 4431.9 4473.8 4374.7 4401.6 4414.4 4425.5 4433.3 4402.4 4425.6 4448.9 4450.8 4476.3 4774.8 4811.4 4826.9 4828.2 4861.1 5156.5 5185.2 5189.5 5202.1 5254.2 5210.9 5214.9 5230.1 5242.0 5252.1 4681.8 4705.4 4741.2 4857.5 4867.1 5206.2 5243.7 5263.1 5281.1 5299.9 4988.8 4993.3 4996.0 4999.7 5055.7 5074.1 5156.8 5180.9 5214.8 5265.6 5123.3 5139.6 5147.8 5162.8 5163.0 5125.5 5137.9 5144.9 5149.9 5172.7 4320.3 4421.6 4457.4 4470.4 4522.9 3866.3 3883.1 3894.3 3920.5 3933.9 4517.9 4533.1 4536.0 4538.2 4580.7 5112.2 5135.8 5166.7 5199.7 5260.1 4462.8 4470.7 4480.2 4484.0 4535.8 4687.6 4693.9 4700.9 4710.6 4737.1 4727.5 4803.6 4867.6 4870.3 4917.5 5182.3 5188.7 5191.5 5193.7 5204.6 4849.9 4853.3 4884.2 4898.0 4914.9 4980.5 5068.4 5097.0 5117.2 5145.5 5182.5 5187.1 5190.8 5192.7 5193.2 5036.1 5048.2 5055.0 5056.0 5081.6 4978.1 4979.5 5005.0 5024.9 5066.3 4898.8 4926.2 4941.0 4961.6 4983.7 5020.4 5032.0 5042.1 5043.2 5097.5 4844.0 4935.7 4961.0 4986.9 5022.2 15:24:02 INFO - PROCESS | 9238 | 15:24:02 INFO - PROCESS | 9238 | [#1] ext.html Cycles:180 Average:48780.31 Median:203844.72 stddev:90333.32 (44.3%) stddev-sans-first:90514.12 15:24:02 INFO - PROCESS | 9238 | Values: 540.4 547.5 548.9 552.6 580.1 34601.0 38364.8 38445.2 38517.2 38563.6 38071.6 38472.4 38532.2 38643.6 38829.0 7596.8 7661.8 7665.4 7720.1 7731.3 7622.4 7650.4 7660.5 7693.9 7726.5 7653.4 7752.9 7769.2 7771.7 7790.1 7720.8 7729.7 7752.5 7755.1 7758.8 7589.0 7652.6 7655.2 7663.1 7673.4 36635.6 37051.2 37094.4 37168.6 37191.0 2964.2 3002.5 3006.6 3176.2 3200.5 28257.7 28679.9 28919.9 28955.7 29294.9 3304.6 3325.6 3333.8 3351.5 3361.9 252085.0 253526.0 254824.0 255204.0 256028.0 50536.5 50586.7 50700.7 50835.7 50878.7 32464.7 33231.8 33282.8 53413.5 53434.0 13138.0 13266.1 13270.2 13272.2 13288.9 10316.7 10390.1 10413.4 10429.3 10439.4 17507.9 17646.6 17685.9 17759.8 17874.0 6489.4 6517.8 6676.4 6798.0 6872.4 788.4 854.4 877.9 937.5 941.4 28535.6 28589.9 28652.4 28743.6 29021.9 935.6 943.6 1001.1 1018.7 1036.1 14351.7 14630.0 14648.3 14677.9 14960.1 383812.0 386872.0 387594.0 388780.0 389606.0 46376.5 46804.0 46832.5 46864.8 46928.5 1165.7 1176.2 1189.2 1202.7 1206.6 25583.7 27023.3 27721.9 28062.3 28141.0 42261.8 47090.8 47140.8 47145.3 47218.8 367136.0 370464.0 370595.0 372302.0 373294.0 38814.2 39009.0 39259.2 39356.1 39360.8 41588.6 42610.6 42705.0 43029.4 43305.6 36096.0 36439.0 36614.0 37026.4 37262.8 35549.0 36189.3 36341.6 36429.2 36977.8 35542.3 35550.8 35941.8 35965.0 35999.5 31156.8 31824.8 33245.2 34228.3 34437.0 25569.0 26010.7 26128.6 26153.6 26413.9 15:24:02 INFO - PROCESS | 9238 | 15:24:02 INFO - PROCESS | 9238 | [#2] jquery.html Cycles:180 Average:24904.82 Median:407569.00 stddev:68095.09 (16.7%) stddev-sans-first:68261.18 15:24:02 INFO - PROCESS | 9238 | Values: 362.7 369.3 373.1 376.4 386.4 15743.4 17010.5 17490.2 17670.0 17693.8 16525.2 16902.7 17166.6 17172.7 17283.6 4974.9 5165.5 5169.3 5182.2 5184.4 3713.4 5088.6 5624.8 5878.5 5900.4 5962.5 5978.3 5979.7 5979.8 5989.0 5948.9 6049.8 6051.7 6064.9 6071.2 5064.3 5130.4 5283.6 5296.3 5329.4 15170.3 20910.7 21338.0 21569.8 21705.2 2077.2 2367.8 2385.6 2436.6 2481.3 13383.5 13437.6 13499.3 13575.5 13821.4 1681.2 1711.4 1728.8 1729.7 1752.8 65984.0 66541.0 66723.7 66838.7 67379.7 9774.5 9804.6 9881.3 10089.9 10101.2 13553.3 13594.8 13624.7 13626.7 13641.5 7049.1 7120.8 7140.9 7286.5 7306.1 6634.9 6650.7 6878.2 6947.2 6974.0 6011.5 6084.9 6103.2 6142.0 6306.4 1447.6 1665.6 1725.2 1746.7 1760.9 380.8 381.4 407.7 410.2 848.2 10333.7 10841.6 10973.3 11195.7 11243.3 400.2 401.8 404.2 411.1 417.1 5668.1 5851.7 5883.4 5912.5 5924.1 407042.0 408096.0 413581.0 415718.0 416770.0 82358.6 82662.6 82879.6 83447.0 83999.0 428.6 433.6 435.0 437.8 438.2 9941.9 9942.2 10141.3 10193.2 10468.3 37020.0 37098.8 37435.8 37906.8 38506.4 52782.0 52882.0 53688.5 53738.0 55039.0 7646.9 7757.0 7892.7 7985.8 8223.7 11729.2 11884.2 12038.3 12272.1 12556.7 9724.2 10098.4 10408.2 10590.2 10795.8 10452.7 10831.2 10851.6 10854.9 11019.0 10237.9 10504.7 10550.6 10565.1 10991.6 7672.0 7722.6 7736.3 7875.6 8130.4 9681.6 10415.7 10416.0 10645.4 10813.6 15:24:02 INFO - PROCESS | 9238 | 15:24:02 INFO - PROCESS | 9238 | [#3] mootools.html Cycles:180 Average:5154.24 Median:4753.67 stddev:2945.30 (62.0%) stddev-sans-first:2939.57 15:24:02 INFO - PROCESS | 9238 | Values: 1333.5 1375.3 1454.3 1645.7 1661.6 6895.6 7525.2 7654.0 8169.7 8254.8 7663.8 7928.4 7952.2 7958.4 7959.7 2173.4 2219.0 2228.8 2232.2 2240.9 2199.5 2219.3 2267.3 2270.0 2272.7 2228.4 2241.4 2242.5 2248.2 2259.2 2152.8 2159.1 2167.4 2167.7 2176.8 2154.3 2163.9 2164.4 2167.1 2168.8 8036.1 8090.2 8145.4 8147.6 8155.9 4569.9 4661.7 4669.2 4696.9 4716.9 2840.1 2960.0 3022.8 3026.3 3046.6 941.9 973.6 983.2 987.7 997.9 11049.2 11057.9 11104.7 11155.1 11207.3 4010.1 4258.5 4269.1 4386.3 4415.3 9376.8 9379.2 9386.9 9409.9 9450.3 4664.4 4704.9 4707.2 4711.9 4714.6 3613.3 3960.8 4144.2 4219.8 4266.5 3643.5 3672.7 3805.7 3854.4 3860.3 1202.5 1205.2 1208.7 1214.4 1222.6 778.2 805.0 806.3 811.7 824.7 4735.2 4772.1 4847.6 4920.4 5185.4 398.2 400.2 402.8 404.8 418.7 3232.7 3316.1 3321.5 3390.0 3443.5 8985.1 9212.7 9309.8 9603.4 9625.5 9510.7 9617.1 9629.8 9634.6 9640.9 7158.1 7213.1 7260.8 7330.2 7338.4 4917.1 5218.3 5230.0 5266.9 5401.2 8936.0 8942.2 8951.9 9016.2 9081.4 8806.6 8951.5 9119.2 9238.9 9244.4 6728.6 6884.9 6905.9 6934.7 7004.3 7688.3 7695.9 7765.2 7766.1 7775.2 6673.5 6922.0 6928.0 6960.8 7136.1 6815.6 6878.4 6899.3 6900.8 6915.1 6075.4 6097.0 6102.7 6154.2 6183.4 4210.2 4257.6 4296.9 4333.2 4475.5 4341.7 4358.4 4370.1 4439.3 4480.8 15:24:02 INFO - PROCESS | 9238 | 15:24:02 INFO - PROCESS | 9238 | [#4] prototype.html Cycles:180 Average:4369.97 Median:5022.88 stddev:1281.69 (25.5%) stddev-sans-first:1248.45 15:24:02 INFO - PROCESS | 9238 | Values: 305.8 305.8 312.1 313.9 320.3 4930.3 5030.6 5045.3 5053.6 5080.0 5013.9 5018.2 5018.4 5027.4 5032.1 3786.8 3846.8 3929.6 4014.1 4033.5 3930.2 3935.1 3941.1 3967.0 3969.0 3907.3 3917.9 3949.0 3949.6 3950.9 3822.9 3935.4 3968.3 3970.5 3979.7 3460.6 3462.9 3469.3 3483.0 3493.5 4936.4 4941.1 4953.4 4959.7 4976.7 4477.9 4498.4 4531.0 4533.7 4533.9 5005.5 5271.2 5292.6 5299.5 5315.1 3716.8 3727.0 3733.9 3734.1 3746.9 5542.9 5579.2 5590.0 5603.7 5610.4 3672.0 3673.9 3687.1 3730.1 3844.0 3737.0 3747.4 3757.9 3762.3 3765.5 4378.5 4402.3 4409.4 4411.2 4429.6 5199.2 5268.9 5322.6 5324.1 5330.7 1321.4 1345.7 1347.4 1349.4 1349.5 827.3 854.4 856.0 874.6 875.2 4122.7 4136.5 4397.5 4506.2 4664.2 5425.5 5478.2 5479.9 5489.1 5521.6 4609.4 4639.7 4658.5 4673.3 4690.8 2790.9 2878.0 2897.3 2904.8 2912.4 5096.2 5108.7 5119.0 5127.6 5152.7 5377.8 5552.6 5582.9 5595.3 5615.5 5060.3 5066.7 5073.9 5074.1 5095.9 5435.7 5436.9 5443.4 5486.7 5502.7 5087.6 5287.1 5342.4 5355.3 5369.9 5056.5 5072.5 5073.2 5095.5 5112.4 3799.5 3806.0 3840.9 3844.8 3851.9 5215.3 5429.5 5463.2 5494.5 5497.7 5278.6 5291.0 5293.9 5298.0 5307.7 5193.7 5246.3 5258.0 5265.2 5332.6 4942.7 5146.8 5153.6 5183.3 5205.2 5076.2 5193.0 5279.8 5316.8 5323.7 5226.1 5230.2 5234.2 5242.2 5251.6 15:24:02 INFO - PROCESS | 9238 | 15:24:02 INFO - PROCESS | 9238 | [#5] yui.html Cycles:180 Average:16867.30 Median:45246.89 stddev:24011.75 (53.1%) stddev-sans-first:24048.04 15:24:02 INFO - PROCESS | 9238 | Values: 599.5 602.7 607.1 684.0 688.7 12326.2 13425.7 13489.7 13506.6 14508.0 12587.3 12782.3 12786.3 12866.1 12873.5 637.5 737.7 770.2 777.7 779.4 773.7 775.2 790.2 793.2 793.2 815.6 825.5 826.1 828.2 828.6 817.6 822.3 823.3 824.7 828.0 599.5 599.9 602.8 603.8 604.7 12836.2 12863.9 12869.2 12881.7 12939.2 13648.1 13855.2 14122.7 14247.4 14401.8 10655.7 10761.6 10863.9 10875.5 11006.3 3208.3 3214.6 3229.4 3259.9 3277.9 51112.7 66313.7 68430.7 68475.0 69651.0 9868.4 10454.6 10560.9 10759.7 10925.8 18660.9 18701.1 18729.6 18730.4 18802.9 6905.4 7062.0 7396.1 7488.6 7493.7 3587.6 3766.7 3783.9 3796.5 3862.9 2836.9 2940.6 2947.3 2970.6 2974.9 489.4 490.7 499.2 503.2 534.1 485.4 534.6 536.1 555.8 556.0 7542.1 8163.6 8229.8 8350.8 8411.7 539.4 564.2 569.3 570.9 605.7 3827.4 3897.1 3925.3 3938.4 4022.4 89157.7 104910.0 105323.0 106409.0 108257.0 68688.3 76258.0 77230.5 80209.0 87257.0 43089.1 43171.4 43258.0 45348.8 49354.5 8165.2 8575.3 9023.5 9026.5 9026.7 42815.0 43434.3 43855.1 44453.8 45145.0 56408.7 56866.7 61598.4 62380.7 62385.4 10542.7 10619.8 11186.0 11226.3 11955.1 11467.2 11675.9 11840.0 11964.8 12595.8 10756.3 10928.6 11348.3 11392.8 11742.9 10644.4 11290.4 11397.4 11423.3 11674.9 11078.3 11564.2 11768.7 11894.1 11975.7 8758.6 9307.4 9335.3 9498.3 9597.1 8461.5 9278.9 9396.9 9407.5 9471.5 15:24:02 INFO - PROCESS | 9238 | -------- Summary: end -------- 15:24:02 INFO - PROCESS | 9238 | 15:24:03 INFO - TEST-INFO | 9238: exit 0 15:24:03 INFO - TEST-OK | dromaeo_css | took 1118001ms 15:24:03 INFO - TEST-START | kraken 15:24:03 INFO - operating with platform_type : linux_ 15:24:03 INFO - Initialising browser for kraken test... 15:24:03 INFO - TEST-INFO | started process 9602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjbCl2x/profile http://localhost:44740/getInfo.html) 15:24:08 INFO - PROCESS | 9602 | __metrics Screen width/height:1600/1200 15:24:08 INFO - PROCESS | 9602 | colorDepth:24 15:24:08 INFO - PROCESS | 9602 | Browser inner width/height: 1024/697 15:24:08 INFO - PROCESS | 9602 | __metrics 15:24:09 ERROR - PROCESS | 9602 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 15:24:10 INFO - TEST-INFO | 9602: exit 0 15:24:10 INFO - Browser initialized. 15:24:10 INFO - Running cycle 1/1 for kraken test... 15:24:10 INFO - TEST-INFO | started process 9722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjbCl2x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:22 INFO - PROCESS | 9722 | RSS: Main: 164204544 15:24:22 INFO - PROCESS | 9722 | 15:24:24 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44740/tests/kraken/driver.html?testName=audio-beat-detection) 15:24:25 INFO - PROCESS | 9722 | RSS: Main: 169054208 15:24:25 INFO - PROCESS | 9722 | 15:24:28 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44740/tests/kraken/driver.html?testName=audio-dft) 15:24:29 INFO - PROCESS | 9722 | RSS: Main: 167317504 15:24:29 INFO - PROCESS | 9722 | 15:24:32 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44740/tests/kraken/driver.html?testName=audio-fft) 15:24:32 INFO - PROCESS | 9722 | RSS: Main: 164577280 15:24:32 INFO - PROCESS | 9722 | 15:24:34 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44740/tests/kraken/driver.html?testName=audio-oscillator) 15:24:35 INFO - PROCESS | 9722 | RSS: Main: 164270080 15:24:35 INFO - PROCESS | 9722 | 15:24:37 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44740/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:24:38 INFO - PROCESS | 9722 | RSS: Main: 164913152 15:24:38 INFO - PROCESS | 9722 | 15:24:41 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44740/tests/kraken/driver.html?testName=imaging-darkroom) 15:24:42 INFO - PROCESS | 9722 | RSS: Main: 165613568 15:24:42 INFO - PROCESS | 9722 | 15:24:45 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44740/tests/kraken/driver.html?testName=imaging-desaturate) 15:24:46 INFO - PROCESS | 9722 | RSS: Main: 162713600 15:24:46 INFO - PROCESS | 9722 | 15:24:49 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44740/tests/kraken/driver.html?testName=json-parse-financial) 15:24:50 INFO - PROCESS | 9722 | RSS: Main: 164409344 15:24:50 INFO - PROCESS | 9722 | 15:24:51 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44740/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:24:52 INFO - PROCESS | 9722 | RSS: Main: 164618240 15:24:52 INFO - PROCESS | 9722 | 15:24:54 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44740/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:24:54 INFO - PROCESS | 9722 | RSS: Main: 164339712 15:24:54 INFO - PROCESS | 9722 | 15:24:57 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44740/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:24:58 INFO - PROCESS | 9722 | RSS: Main: 165179392 15:24:58 INFO - PROCESS | 9722 | 15:25:00 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44740/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:25:01 INFO - PROCESS | 9722 | RSS: Main: 166502400 15:25:01 INFO - PROCESS | 9722 | 15:25:04 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44740/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:25:05 INFO - PROCESS | 9722 | RSS: Main: 165642240 15:25:05 INFO - PROCESS | 9722 | 15:25:06 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:44740/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44740/tests/kraken/driver.html?testName=ai-astar) 15:25:07 INFO - PROCESS | 9722 | RSS: Main: 166477824 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | __start_tp_report 15:25:07 INFO - PROCESS | 9722 | _x_x_mozilla_page_load 15:25:07 INFO - PROCESS | 9722 | _x_x_mozilla_page_load_details 15:25:07 INFO - PROCESS | 9722 | |i|pagename|runs| 15:25:07 INFO - PROCESS | 9722 | |0;ai-astar;107;115;111;118;116;115;121;114;116;115 15:25:07 INFO - PROCESS | 9722 | |1;audio-beat-detection;150;131;152;197;126;148;153;125;202;124 15:25:07 INFO - PROCESS | 9722 | |2;audio-dft;164;164;164;175;163;164;163;162;163;161 15:25:07 INFO - PROCESS | 9722 | |3;audio-fft;77;77;75;177;78;78;77;76;156;80 15:25:07 INFO - PROCESS | 9722 | |4;audio-oscillator;86;86;144;87;86;88;133;88;87;143 15:25:07 INFO - PROCESS | 9722 | |5;imaging-gaussian-blur;118;117;118;118;118;120;119;118;117;121 15:25:07 INFO - PROCESS | 9722 | |6;imaging-darkroom;148;148;147;148;149;148;148;148;149;147 15:25:07 INFO - PROCESS | 9722 | |7;imaging-desaturate;97;97;95;95;95;96;95;98;96;95 15:25:07 INFO - PROCESS | 9722 | |8;json-parse-financial;63;64;68;65;64;69;64;64;64;67 15:25:07 INFO - PROCESS | 9722 | |9;json-stringify-tinderbox;65;67;72;69;66;66;67;70;66;67 15:25:07 INFO - PROCESS | 9722 | |10;stanford-crypto-aes;91;90;86;82;90;83;87;83;82;83 15:25:07 INFO - PROCESS | 9722 | |11;stanford-crypto-ccm;135;145;137;135;141;134;135;137;154;145 15:25:07 INFO - PROCESS | 9722 | |12;stanford-crypto-pbkdf2;176;176;173;176;174;177;173;179;178;171 15:25:07 INFO - PROCESS | 9722 | |13;stanford-crypto-sha256-iterative;70;73;68;70;70;75;68;71;68;68 15:25:07 INFO - PROCESS | 9722 | __end_tp_report 15:25:07 INFO - PROCESS | 9722 | __start_cc_report 15:25:07 INFO - PROCESS | 9722 | _x_x_mozilla_cycle_collect,998 15:25:07 INFO - PROCESS | 9722 | __end_cc_report 15:25:07 INFO - PROCESS | 9722 | __startTimestamp1471040707061__endTimestamp 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | ------- Summary: start ------- 15:25:07 INFO - PROCESS | 9722 | Number of tests: 14 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.50 stddev:3.77 (3.3%) stddev-sans-first:2.74 15:25:07 INFO - PROCESS | 9722 | Values: 107.0 115.0 111.0 118.0 116.0 115.0 121.0 114.0 116.0 115.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:151.00 stddev:28.21 (18.7%) stddev-sans-first:29.92 15:25:07 INFO - PROCESS | 9722 | Values: 150.0 131.0 152.0 197.0 126.0 148.0 153.0 125.0 202.0 124.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:3.89 (2.4%) stddev-sans-first:4.12 15:25:07 INFO - PROCESS | 9722 | Values: 164.0 164.0 164.0 175.0 163.0 164.0 163.0 162.0 163.0 161.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#3] audio-fft Cycles:10 Average:95.10 Median:77.00 stddev:37.98 (49.3%) stddev-sans-first:39.71 15:25:07 INFO - PROCESS | 9722 | Values: 77.0 77.0 75.0 177.0 78.0 78.0 77.0 76.0 156.0 80.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:86.50 stddev:25.84 (29.9%) stddev-sans-first:26.68 15:25:07 INFO - PROCESS | 9722 | Values: 86.0 86.0 144.0 87.0 86.0 88.0 133.0 88.0 87.0 143.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:1.26 (1.1%) stddev-sans-first:1.33 15:25:07 INFO - PROCESS | 9722 | Values: 118.0 117.0 118.0 118.0 118.0 120.0 119.0 118.0 117.0 121.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:25:07 INFO - PROCESS | 9722 | Values: 148.0 148.0 147.0 148.0 149.0 148.0 148.0 148.0 149.0 147.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:1.10 (1.1%) stddev-sans-first:1.09 15:25:07 INFO - PROCESS | 9722 | Values: 97.0 97.0 95.0 95.0 95.0 96.0 95.0 98.0 96.0 95.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:64.50 stddev:2.04 (3.2%) stddev-sans-first:2.01 15:25:07 INFO - PROCESS | 9722 | Values: 63.0 64.0 68.0 65.0 64.0 69.0 64.0 64.0 64.0 67.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:2.17 (3.2%) stddev-sans-first:2.11 15:25:07 INFO - PROCESS | 9722 | Values: 65.0 67.0 72.0 69.0 66.0 66.0 67.0 70.0 66.0 67.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.50 stddev:3.59 (4.2%) stddev-sans-first:3.26 15:25:07 INFO - PROCESS | 9722 | Values: 91.0 90.0 86.0 82.0 90.0 83.0 87.0 83.0 82.0 83.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:139.00 stddev:6.46 (4.6%) stddev-sans-first:6.61 15:25:07 INFO - PROCESS | 9722 | Values: 135.0 145.0 137.0 135.0 141.0 134.0 135.0 137.0 154.0 145.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:176.00 stddev:2.50 (1.4%) stddev-sans-first:2.64 15:25:07 INFO - PROCESS | 9722 | Values: 176.0 176.0 173.0 176.0 174.0 177.0 173.0 179.0 178.0 171.0 15:25:07 INFO - PROCESS | 9722 | 15:25:07 INFO - PROCESS | 9722 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:2.38 (3.4%) stddev-sans-first:2.52 15:25:07 INFO - PROCESS | 9722 | Values: 70.0 73.0 68.0 70.0 70.0 75.0 68.0 71.0 68.0 68.0 15:25:07 INFO - PROCESS | 9722 | -------- Summary: end -------- 15:25:07 INFO - PROCESS | 9722 | 15:25:08 INFO - TEST-INFO | 9722: exit 0 15:25:08 INFO - TEST-OK | kraken | took 64484ms 15:25:08 INFO - SUITE-END | took 1182s 15:25:08 INFO - Completed test suite (00:19:42) 15:25:08 INFO - javascript benchmark 15:25:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6362.578817821414, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2668.546347120989, 2682.530557152499, 2689.152916831198, 2705.891764329427, 2713.145359211849, 4763.690360126589, 4793.999999999995, 4797.784099715513, 4862.781174847131, 4870.829520966767, 4711.175544279755, 4772.546608072236, 4791.880202994927, 4797.160496913044, 4803.807847686097, 4345.3916451696705, 4428.689991700582, 4453.309736990772, 4530.614897733697, 4551.658625603093, 4434.822607095713, 4445.777711114448, 4481.148581769469, 4484.013517026249, 4522.208613492642, 4347.2826983547675, 4388.868333949987, 4420.513743488214, 4431.889202769924, 4473.843415480475, 4374.737515749065, 4401.5818497243035, 4414.448193975753, 4425.513193548707, 4433.290673492258, 4402.427684401007, 4425.601695847389, 4448.933266001012, 4450.844220452301, 4476.2837945928495, 4774.832880849153, 4811.350467686852, 4826.855194344175, 4828.155072862235, 4861.149298872683, 5156.510131537498, 5185.248139019821, 5189.481051894818, 5202.06362854686, 5254.185601231815, 5210.879660872931, 5214.895702085937, 5230.058589453897, 5241.973790131063, 5252.080885845, 4681.836135735233, 4705.364775755298, 4741.170295198395, 4857.53853383928, 4867.050925069649, 5206.193040078718, 5243.68537887728, 5263.052650522943, 5281.12861377876, 5299.947000529945, 4988.825391111293, 4993.325901003391, 4995.975020124876, 4999.650024498323, 5055.6713813602, 5074.06129865976, 5156.8195113171605, 5180.922286165711, 5214.765335559909, 5265.631405801557, 5123.3339665843205, 5139.614528910347, 5147.794088236504, 5162.845114646567, 5163.0, 5125.461826508237, 5137.897242055213, 5144.948550514522, 5149.897002059938, 5172.741362931838, 4320.2655548556195, 4421.646268298528, 4457.442819647544, 4470.418845550058, 4522.8643140705835, 3866.284737323604, 3883.098710779354, 3894.279558281727, 3920.5295364555864, 3933.940990885139, 4517.887052823706, 4533.070720502289, 4536.047430039728, 4538.205813982539, 4580.702254353457, 5112.156494178494, 5135.845924622193, 5166.741662916915, 5199.740012999335, 5260.053190425683, 4462.776861156929, 4470.709403888737, 4480.193565158238, 4483.955160448354, 4535.750533720677, 4687.554682305175, 4693.859184224479, 4700.882477938079, 4710.646701497401, 4737.1236321279985, 4727.503612120678, 4803.5916947059895, 4867.61059115277, 4870.318155458168, 4917.532834380728, 5182.300389447527, 5188.7405629717605, 5191.454897235887, 5193.7403129844115, 5204.609654275869, 4849.854504364875, 4853.32376424145, 4884.218525036119, 4897.975510122426, 4914.926276105933, 4980.526849949249, 5068.391792984866, 5097.0315640028275, 5117.232415137759, 5145.45972672864, 5182.455842136521, 5187.144121220107, 5190.844274671766, 5192.714400707997, 5193.169092945111, 5036.093503169464, 5048.167052436307, 5054.974725126351, 5056.0, 5081.644284900021, 4978.079055374767, 4979.5269449403695, 5005.0, 5024.899502010013, 5066.31604733371, 4898.804047838046, 4926.162552366178, 4940.975295123501, 4961.603071754179, 4983.700977941335, 5020.397552293748, 5031.993601279685, 5042.09242336383, 5043.193089105725, 5097.541221290102, 4844.006978569314, 4935.703857768545, 4960.950390496193, 4986.850394488171, 5022.246663000579], "value": 4746.713751006659, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.3866611396065, 547.4990383798824, 548.9368722596901, 552.5938435250089, 580.0689892722183, 34600.99999999997, 38364.808175959115, 38445.231095378076, 38517.22965540695, 38563.61436385635, 38071.61928380715, 38472.422913656315, 38532.22935541288, 38643.61356386435, 38829.029274268156, 7596.772096837104, 7661.770146895602, 7665.42509311801, 7720.1121870985, 7731.304182623563, 7622.352100071501, 7650.426218033642, 7660.540367577935, 7693.923060769376, 7726.536407815549, 7653.425993050543, 7752.922470775276, 7769.18423565526, 7771.727989520368, 7790.065192176947, 7720.7683769487, 7729.690812367498, 7752.457327987043, 7755.1469338372735, 7758.767236982928, 7588.950983234496, 7652.617369131521, 7655.1962043985695, 7663.080430348338, 7673.386129109658, 36635.63364366349, 37051.1833461651, 37094.44358334627, 37168.628313717054, 37191.0, 2964.1996660901436, 3002.4745669507965, 3006.564048213019, 3176.1741947093924, 3200.471922132845, 28257.717422825714, 28679.85660071707, 28919.855400722863, 28955.710442895514, 29294.853525732236, 3304.5538852254876, 3325.584301962255, 3333.833308334598, 3351.4805205193234, 3361.9495707564406, 252085.0, 253526.0, 254823.99999999814, 255204.0, 256028.0, 50536.49463505392, 50586.747066264434, 50700.74649626728, 50835.7458212714, 50878.745606272474, 32464.67535324664, 33231.833840830644, 33282.83358583192, 53413.465865341626, 53434.0, 13138.0, 13266.137701049402, 13270.203787772765, 13272.203667779771, 13288.933555332162, 10316.690499285034, 10390.06489415941, 10413.375197488174, 10429.322094063862, 10439.37363758177, 17507.912460437616, 17646.558836029202, 17685.911570442066, 17759.822401776077, 17874.0, 6489.415952564197, 6517.804465866032, 6676.432503237279, 6798.04827324175, 6872.381485666314, 788.4008153803151, 854.4275335525213, 877.903430622631, 937.5140402462038, 941.4210260689626, 28535.57196642052, 28589.856405743954, 28652.426951460853, 28743.56884646732, 29021.85489072541, 935.5976929920064, 943.6272672294406, 1001.0840081325651, 1018.6994836523244, 1036.1348274190984, 14351.712965740626, 14630.0, 14648.2857541287, 14677.92661036688, 14960.102393856403, 383812.0, 386872.0, 387594.0, 388780.0, 389606.0, 46376.53623463722, 46804.0, 46832.5316746835, 46864.76567617209, 46928.5307146931, 1165.6677846813618, 1176.206060908883, 1189.1556994533805, 1202.6692659518703, 1206.6078524479578, 25583.74416255888, 27023.324416889736, 27721.861390692917, 28062.298442538282, 28141.0, 42261.78869105635, 47090.76454617705, 47140.764296179674, 47145.2928206084, 47218.76390618025, 367136.0, 370464.0, 370595.0, 372302.0, 373294.0, 38814.223715526095, 39009.0, 39259.214815704094, 39356.12877424584, 39360.80319598383, 41588.58411415968, 42610.57389426066, 42705.0, 43029.35455968101, 43305.56694433015, 36096.0, 36439.0, 36614.0, 37026.444603330434, 37262.813685931396, 35549.0, 36189.27621447504, 36341.636583634885, 36429.17133258666, 36977.815110924275, 35542.28915421729, 35550.82224588861, 35941.82029089838, 35965.0, 35999.46000809938, 31156.833928197095, 31824.8408757964, 33245.16887077843, 34228.31543369069, 34437.0, 25569.0, 26010.73989260159, 26128.60807087857, 26153.561554113945, 26413.867930660224], "value": 17460.45668409958, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.6772172766239, 369.25594926223664, 373.132467014192, 376.3864900212653, 386.39722033627544, 15743.448979285713, 17010.489685309443, 17490.212940417696, 17670.0, 17693.815113279605, 16525.173741312916, 16902.74645880313, 17166.57083572911, 17172.742408863876, 17283.567910802238, 4974.925376119352, 5165.4834516548235, 5169.302144210521, 5182.248573956774, 5184.351956005499, 3713.368727316349, 5088.592912566985, 5624.831255062355, 5878.470937615613, 5900.380460051697, 5962.463378295953, 5978.252718410199, 5979.671118088503, 5979.760809567612, 5989.0, 5948.910766338508, 6049.848753781169, 6051.667158306292, 6064.9090263646085, 6071.241094863164, 5064.265681476202, 5130.358705161855, 5283.6037297202865, 5296.25852380667, 5329.413764485904, 15170.31733571992, 20910.686339704916, 21338.0, 21569.784302156935, 21705.240316589003, 2077.1795140919253, 2367.8105751539833, 2385.6183010718373, 2436.6223235398543, 2481.3424442522746, 13383.464661413533, 13437.581235377627, 13499.25754083525, 13575.524856630069, 13821.378037988214, 1681.2350380576809, 1711.4437807712418, 1728.8357606027407, 1729.6627157704252, 1752.7945076461644, 65984.0, 66541.0, 66723.66638166827, 66838.66580667066, 67379.66310168467, 9774.511274436392, 9804.607815687292, 9881.308308418342, 10089.899101009043, 10101.19190464761, 13553.25457099869, 13594.796078058836, 13624.727505450033, 13626.659333516742, 13641.522546710818, 7049.127741999141, 7120.821979450555, 7140.892886606705, 7286.526375785557, 7306.050213472215, 6634.86730265392, 6650.70071846768, 6878.209005964278, 6947.235804061549, 6973.965130174317, 6011.458968692838, 6084.9311234180595, 6103.206583144163, 6142.0, 6306.400891915261, 1447.6163816588612, 1665.6169081111411, 1725.2064050536894, 1746.7030604797214, 1760.8591312694953, 380.8419505905074, 381.3783532841451, 407.72478576960435, 410.2287699125625, 848.1942154952819, 10333.689989300334, 10841.566337346418, 10973.341599504056, 11195.720106997227, 11243.26918750295, 400.18362540417223, 401.7950845069036, 404.1956506551941, 411.0648275174003, 417.0678533477675, 5668.149777533403, 5851.736671849777, 5883.441073098049, 5912.526997840162, 5924.14099955504, 407042.0, 408096.0, 413581.0, 415718.0, 416770.0, 82358.58820705858, 82662.58668706738, 82879.5856020716, 83447.0, 83999.0, 428.63351834181947, 433.6335796252162, 435.0255427841612, 437.76360765186445, 438.21778126045496, 9941.850872236777, 9942.15491683215, 10141.340812847142, 10193.184545236512, 10468.267221294436, 37020.0, 37098.8145059273, 37435.812820935724, 37906.81046594749, 38506.422403663404, 52782.0, 52882.0, 53688.463115368344, 53738.0, 55039.0, 7646.885296720442, 7757.0, 7892.684292628231, 7985.760427187193, 8223.712170074019, 11729.178171469914, 11884.227525210834, 12038.277703337828, 12272.140950133406, 12556.748865022832, 9724.173445256949, 10098.394096354243, 10408.167346612405, 10590.152787776806, 10795.784084318113, 10452.738681533023, 10831.187660925305, 10851.620193293196, 10854.891451085388, 11019.0, 10237.897621023694, 10504.737381565523, 10550.630727924487, 10565.101966332948, 10991.560337586407, 7672.0, 7722.575258360844, 7736.303732663862, 7875.566843823644, 8130.390220733587, 9681.612735490784, 10415.68752937413, 10416.0, 10645.361278323326, 10813.62152324665], "value": 7737.228885727597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.5199328241831, 1375.312343828086, 1454.2801313349894, 1645.7202275613145, 1661.5762980439986, 6895.620740859251, 7525.247475252472, 7653.961730191341, 8169.673213071477, 8254.752357429279, 7663.770086897388, 7928.445008849383, 7952.165022672622, 7958.4031197660115, 7959.681612735483, 2173.369722780396, 2218.966715499269, 2228.843980921336, 2232.2410380470637, 2240.9215677451293, 2199.516106456577, 2219.289827255279, 2267.2631394796676, 2270.0, 2272.6591011348264, 2228.3649159989404, 2241.3948233976816, 2242.4842286274165, 2248.235599896035, 2259.164109279569, 2152.7847215278425, 2159.0931808640407, 2167.425632207466, 2167.6531754919138, 2176.7823217678265, 2154.332157031325, 2163.9242626508153, 2164.39396968849, 2167.111484291433, 2168.8481806273567, 8036.116027236999, 8090.150534193943, 8145.389095817778, 8147.551884646342, 8155.918440815575, 4569.862904112882, 4661.743604101773, 4669.229577119771, 4696.882577935545, 4716.858494245178, 2840.14396591826, 2959.9704002960125, 3022.7732920031085, 3026.2888221267986, 3046.6039414876145, 941.9340646154772, 973.634886917406, 983.1839573154336, 987.6543209876558, 997.9002099789963, 11049.232122860303, 11057.889421105847, 11104.666859994213, 11155.107591392669, 11207.327560346324, 4010.1378203685763, 4258.488981322199, 4269.146170765859, 4386.342048692658, 4415.337699345124, 9376.812463750686, 9379.24966002718, 9386.906130938603, 9409.90590094104, 9450.33847630673, 4664.416947881515, 4704.929426058543, 4707.152712511781, 4711.882202944886, 4714.5521175488275, 3613.2954073955325, 3960.801959902051, 4144.191882582867, 4219.78901054946, 4266.488021437385, 3643.4899114124046, 3672.6878215351994, 3805.7145714071557, 3854.4411060396087, 3860.3244432224246, 1202.537023246039, 1205.15036898986, 1208.7219939413983, 1214.36245970866, 1222.5537678747194, 778.2373274191324, 804.9798755031054, 806.2985202873421, 811.7280710961776, 824.7154731617583, 4735.2186889163595, 4772.117158325721, 4847.612191024709, 4920.360353154067, 5185.429602743695, 398.245325108917, 400.20359484625965, 402.7502948172152, 404.7874865695533, 418.7403809638044, 3232.69289417505, 3316.137804170933, 3321.534985102088, 3390.0, 3443.466262729281, 8985.146411090936, 9212.677556285498, 9309.767255818524, 9603.37578057424, 9625.470599116976, 9510.714678559654, 9617.086376794194, 9629.807403852024, 9634.566444510014, 9640.855387169198, 7158.105236845395, 7213.098362704767, 7260.782176534713, 7330.230325815713, 7338.449616278694, 4917.0903382874285, 5218.347706536683, 5229.973850130725, 5266.947330526799, 5401.243825864303, 8935.955320223617, 8942.239909607757, 8951.865722014305, 9016.18854303116, 9081.409708368936, 8806.559672016245, 8951.462912225288, 9119.224865886474, 9238.907610924074, 9244.445333280024, 6728.596284222962, 6884.93115068863, 6905.861882762417, 6934.653267336714, 7004.264552222147, 7688.269614386624, 7695.92304076952, 7765.22347765219, 7766.106897706836, 7775.183605721318, 6673.5328527004585, 6922.0, 6928.0, 6960.79117626472, 7136.0723105995885, 6815.556988795713, 6878.415334696607, 6899.275576064441, 6900.7929762107215, 6915.066466027022, 6075.36208698098, 6097.024476083805, 6102.694865256808, 6154.169187159855, 6183.3816618337805, 4210.179015092028, 4257.552956939477, 4296.871093867189, 4333.15503476819, 4475.530069342803, 4341.717788343748, 4358.411614432011, 4370.125974805115, 4439.334099885043, 4480.798364073689], "value": 4070.328483607738, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.7813663230791, 305.7920613982492, 312.1182658988358, 313.877587740781, 320.2809692240917, 4930.334404855348, 5030.572401345881, 5045.293658887749, 5053.595712343013, 5080.0, 5013.899722005558, 5018.172001619738, 5018.397792264925, 5027.371578552681, 5032.144535428976, 3786.848526058968, 3846.8461261549646, 3929.626685464876, 4014.1369605534805, 4033.455483509733, 3930.194310166409, 3935.134270460494, 3941.0541470047124, 3966.9884179534324, 3968.9801550992206, 3907.316219661562, 3917.8824635260844, 3949.0, 3949.624785645359, 3950.881473555798, 3822.866199682998, 3935.3900145477496, 3968.265870813909, 3970.5235371755284, 3979.6816254699556, 3460.619331873492, 3462.8614855405754, 3469.3061387722555, 3482.982585087084, 3493.480336053825, 4936.395671406807, 4941.085899108641, 4953.4303555091265, 4959.7024178549045, 4976.726280054596, 4477.865664030084, 4498.370228168059, 4530.954690453086, 4533.659975501818, 4533.863984080483, 5005.549500544968, 5271.209318602202, 5292.576593872481, 5299.5230429261555, 5315.149576067811, 3716.7955762433326, 3727.0, 3733.925321493582, 3734.066483379155, 3746.925061498782, 5542.944570554283, 5579.191017302468, 5589.999999999959, 5603.691796951166, 5610.438956104398, 3672.0, 3673.853045878135, 3687.0597997511, 3730.0674831292176, 3843.962130224824, 3736.981315093407, 3747.4191500317493, 3757.9248415032093, 3762.3039737648623, 3765.548134223911, 4378.496472905656, 4402.3176407656865, 4409.426774519292, 4411.18393097278, 4429.623482004002, 5199.246109314128, 5268.868278293074, 5322.574194064466, 5324.094903866352, 5330.72062704948, 1321.359140816703, 1345.7350090914508, 1347.3936728472227, 1349.44672684199, 1349.4534713441071, 827.2926647716237, 854.3805740837843, 855.9984817763232, 874.5976850648773, 875.1642181716445, 4122.742563518096, 4136.469506282695, 4397.516273209944, 4506.166359223488, 4664.183767840615, 5425.511703946664, 5478.233047373371, 5479.863003424866, 5489.149181876815, 5521.585881058937, 4609.423822022247, 4639.675222734376, 4658.487566367697, 4673.322368256584, 4690.812367505261, 2790.9023184188454, 2877.9712202877704, 2897.3046468847324, 2904.7530959868227, 2912.4127350593976, 5096.159133742891, 5108.667936584185, 5118.950615123891, 5127.5897928166405, 5152.742362881841, 5377.811776587879, 5552.611317207838, 5582.91625625616, 5595.328560572757, 5615.466530679579, 5060.266261392151, 5066.746662666852, 5073.898522029613, 5074.08666440037, 5095.923561146586, 5435.673859568438, 5436.864078398072, 5443.401225865073, 5486.670799752028, 5502.669839809624, 5087.567556757717, 5287.127623942007, 5342.439043900335, 5355.25026496283, 5369.919451208313, 5056.519630635084, 5072.463768115942, 5073.239014147907, 5095.541401273903, 5112.437631860566, 3799.525059367579, 3805.980970095132, 3840.8847734568008, 3844.8462061517225, 3851.9229615408094, 5215.348081489814, 5429.457054294697, 5463.153211252262, 5494.5054945055135, 5497.74592417107, 5278.627556835174, 5291.0, 5293.894122117459, 5298.046351656739, 5307.734613269398, 5193.7403129844115, 5246.291750613618, 5257.975679363396, 5265.21021846726, 5332.626716129834, 4942.7034377936, 5146.845594632167, 5153.613478989166, 5183.2636066918, 5205.167173252262, 5076.213186956028, 5192.9747398515365, 5279.779334605811, 5316.840494785162, 5323.7071961040965, 5226.137687281708, 5230.163173892159, 5234.24103504982, 5242.18746094356, 5251.579873610179], "value": 3960.710662034932, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.463480185234, 602.7076867719156, 607.1408956326798, 684.0423407229878, 688.6969733317342, 12326.198797078196, 13425.664358391045, 13489.730205395887, 13506.594802155938, 14508.0, 12587.307698076602, 12782.296973666445, 12786.296753678544, 12866.099373043868, 12873.485060597588, 637.480453430455, 737.7012310014453, 770.2490072179636, 777.708359365238, 779.3726050529322, 773.6789232468547, 775.2054144501874, 790.2453157234827, 793.175097898188, 793.1790596732383, 815.6248125862081, 825.4675734151499, 826.1201820061646, 828.2090603473669, 828.5691440450992, 817.648411183191, 822.313368337439, 823.2960818500186, 824.7484517222244, 827.9586020699002, 599.4544964082664, 599.8950183717832, 602.8131279303386, 603.7584966013629, 604.6885853785304, 12836.229826210458, 12863.871361286361, 12869.16350437228, 12881.67795805103, 12939.158954667917, 13648.112872663245, 13855.237961912091, 14122.717545649131, 14247.430102795875, 14401.78397324041, 10655.733606659896, 10761.623343182951, 10863.945680271549, 10875.510602022849, 11006.284591501526, 3208.342289830579, 3214.6463888972194, 3229.434848901433, 3259.8696052157884, 3277.918052048694, 51112.74443627758, 66313.68961017567, 68430.65784671095, 68475.0, 69650.9552356715, 9868.407895526292, 10454.581816727246, 10560.941139001232, 10759.677209683721, 10925.781484370267, 18660.906695466434, 18701.06494675288, 18729.625407491774, 18730.41104929274, 18802.905985469984, 6905.447564194852, 7061.964690176619, 7396.112466504054, 7488.5506869588, 7493.70025198986, 3587.6412358763914, 3766.6610005099674, 3783.8675646352795, 3796.544414670257, 3862.8841134766003, 2836.858157092137, 2940.6324209473814, 2947.263184203949, 2970.628671416073, 2974.940501189964, 489.3980404102902, 490.7399078488407, 499.20127795527594, 503.2074482689778, 534.0520575977594, 485.4368932038818, 534.5937087813212, 536.1341433584732, 555.7915781581906, 555.9555235581144, 7542.132654744665, 8163.632636531371, 8229.79425514367, 8350.79123021917, 8411.663533458594, 539.3851009848776, 564.2241917363625, 569.3196630027161, 570.8601392658825, 605.6699098991061, 3827.4258861170492, 3897.142628621699, 3925.3326934421216, 3938.369860822312, 4022.35642297231, 89157.66263506052, 104910.0, 105323.0, 106409.0, 108257.0, 68688.31311686919, 76258.0, 77230.45539089186, 80209.0, 87257.0, 43089.13821723548, 43171.35242971358, 43258.0, 45348.77325613417, 49354.50645493499, 8165.213802294528, 8575.271101956403, 9023.548822558978, 9026.548672566476, 9026.684066057656, 42815.0, 43434.348484773385, 43855.12289754123, 44453.777731111135, 45145.0, 56408.71795640996, 56866.715666421405, 61598.38401616106, 62380.68809655923, 62385.376146237955, 10542.683719488428, 10619.787604248026, 11186.0, 11226.326420414802, 11955.103367247666, 11467.19729618952, 11675.941620291844, 11840.0, 11964.760704785682, 12595.811062833882, 10756.300840445347, 10928.562857485611, 11348.319100853645, 11392.829107563228, 11742.943135117881, 10644.361338319726, 11290.379029153475, 11397.430128493708, 11423.257488263236, 11674.94162529182, 11078.335299882034, 11564.248323858923, 11768.705782355168, 11894.107941904218, 11975.700607484883, 8758.562071896253, 9307.441553506811, 9335.253179745469, 9498.278430805807, 9597.136257736836, 8461.534615596202, 9278.907210927804, 9396.906030939603, 9407.529623518934, 9471.47906865129], "value": 6416.754478935217, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 111.0, 118.0, 116.0, 115.0, 121.0, 114.0, 116.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 131.0, 152.0, 197.0, 126.0, 148.0, 153.0, 125.0, 202.0, 124.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 175.0, 163.0, 164.0, 163.0, 162.0, 163.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 177.0, 78.0, 78.0, 77.0, 76.0, 156.0, 80.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 144.0, 87.0, 86.0, 88.0, 133.0, 88.0, 87.0, 143.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 120.0, 119.0, 118.0, 117.0, 121.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 98.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 68.0, 65.0, 64.0, 69.0, 64.0, 64.0, 64.0, 67.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 72.0, 69.0, 66.0, 66.0, 67.0, 70.0, 66.0, 67.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 86.0, 82.0, 90.0, 83.0, 87.0, 83.0, 82.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 145.0, 137.0, 135.0, 141.0, 134.0, 135.0, 137.0, 154.0, 145.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 173.0, 176.0, 174.0, 177.0, 173.0, 179.0, 178.0, 171.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 68.0, 70.0, 70.0, 75.0, 68.0, 71.0, 68.0, 68.0], "value": 70.1, "unit": "score"}]}]} 15:25:08 INFO - Return code: 0 15:25:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:25:08 ERROR - # TBPL SUCCESS # 15:25:08 INFO - Running post-action listener: _resource_record_post_action 15:25:08 INFO - [mozharness: 2016-08-12 22:25:08.386770Z] Finished run-tests step (success) 15:25:08 INFO - Running post-run listener: _resource_record_post_run 15:25:08 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 413790208; Read time: 104; Write time: 289460 15:25:08 INFO - TinderboxPrint: CPU usage
13.3% 15:25:08 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 104 15:25:08 INFO - TinderboxPrint: I/O write bytes / time
413,790,208 / 289,460 15:25:08 INFO - TinderboxPrint: CPU idle
8,291.0 (86.7%) 15:25:08 INFO - TinderboxPrint: CPU user
1,219.2 (12.7%) 15:25:08 INFO - TinderboxPrint: Swap in / out
0 / 0 15:25:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 124661760; Read time: 0; Write time: 105004 15:25:08 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288231424; Read time: 104; Write time: 184428 15:25:09 INFO - Running post-run listener: _upload_blobber_files 15:25:09 INFO - Blob upload gear active. 15:25:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:25:09 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 15:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:25:09 INFO - (blobuploader) - INFO - Open directory for files ... 15:25:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:25:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:25:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:13 INFO - (blobuploader) - INFO - Done attempting. 15:25:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:25:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:25:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:14 INFO - (blobuploader) - INFO - Done attempting. 15:25:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:25:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:25:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:15 INFO - (blobuploader) - INFO - Done attempting. 15:25:15 INFO - (blobuploader) - INFO - Iteration through files over. 15:25:15 INFO - Return code: 0 15:25:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:25:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:25:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4aa790c0232fedf5703b24d3ce0eeaff42c69b00399e06ddcce8ce5756e7b64d4e130396b33afed39ce8f08e1624a7d2d1d716427666a7a203b1d1283d074aeb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/765d1ac769be8e40a52aac554a007913d7f884d7141cb82935132bb2f3e8908cb3bbd87b40a414b9db56c958b75222ed63a245c6bd51425b6b1d81f3a67e36fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01d79ce83efa1b9056b054d890a70b3d3f761e6ebf461f8401a31559d61963ac0fe8df266f606ef9126c6b9e0305ec97ba4f60626a0fd289b48091bf59940770"} 15:25:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:25:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:25:15 INFO - Contents: 15:25:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4aa790c0232fedf5703b24d3ce0eeaff42c69b00399e06ddcce8ce5756e7b64d4e130396b33afed39ce8f08e1624a7d2d1d716427666a7a203b1d1283d074aeb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/765d1ac769be8e40a52aac554a007913d7f884d7141cb82935132bb2f3e8908cb3bbd87b40a414b9db56c958b75222ed63a245c6bd51425b6b1d81f3a67e36fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01d79ce83efa1b9056b054d890a70b3d3f761e6ebf461f8401a31559d61963ac0fe8df266f606ef9126c6b9e0305ec97ba4f60626a0fd289b48091bf59940770"} 15:25:15 INFO - Running post-run listener: copy_logs_to_upload_dir 15:25:15 INFO - Copying logs to upload dir... 15:25:15 INFO - mkdir: /builds/slave/test/build/upload/logs 15:25:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.178990 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-12 15:25:14.884431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 15:25:14.887793) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4aa790c0232fedf5703b24d3ce0eeaff42c69b00399e06ddcce8ce5756e7b64d4e130396b33afed39ce8f08e1624a7d2d1d716427666a7a203b1d1283d074aeb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/765d1ac769be8e40a52aac554a007913d7f884d7141cb82935132bb2f3e8908cb3bbd87b40a414b9db56c958b75222ed63a245c6bd51425b6b1d81f3a67e36fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01d79ce83efa1b9056b054d890a70b3d3f761e6ebf461f8401a31559d61963ac0fe8df266f606ef9126c6b9e0305ec97ba4f60626a0fd289b48091bf59940770"} build_url:https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/T1IFQg1YTf6BjHNxWjO5ig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4aa790c0232fedf5703b24d3ce0eeaff42c69b00399e06ddcce8ce5756e7b64d4e130396b33afed39ce8f08e1624a7d2d1d716427666a7a203b1d1283d074aeb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/765d1ac769be8e40a52aac554a007913d7f884d7141cb82935132bb2f3e8908cb3bbd87b40a414b9db56c958b75222ed63a245c6bd51425b6b1d81f3a67e36fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01d79ce83efa1b9056b054d890a70b3d3f761e6ebf461f8401a31559d61963ac0fe8df266f606ef9126c6b9e0305ec97ba4f60626a0fd289b48091bf59940770"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 15:25:14.913051) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:25:14.913376) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471034639.109744-1925109787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 15:25:14.996478) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 15:25:14.996805) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 15:25:14.997429) ========= ========= Total master_lag: 0.41 =========