builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1471875951.24 results: success (0) buildid: 20160822064115 builduid: 2c3858c2ad4a4d32bfc521ec00bd8e20 revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:51.241236) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:51.241656) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:51.241971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:51.338998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:51.339322) ========= 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=32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 07:25:52-- 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% 85.5M=0s 2016-08-22 07:25:52 (85.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080137 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:51.498134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:51.498415) ========= 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=32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019192 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:51.556567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:51.556883) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 194fe275b4e60ded2af6b25173eec421f0dba8ad --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 194fe275b4e60ded2af6b25173eec421f0dba8ad --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=32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 07:25:52,605 truncating revision to first 12 chars 2016-08-22 07:25:52,605 Setting DEBUG logging. 2016-08-22 07:25:52,605 attempt 1/10 2016-08-22 07:25:52,605 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/194fe275b4e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 07:25:52,885 unpacking tar archive at: mozilla-central-194fe275b4e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561535 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:52.132976) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:52.133256) ========= script_repo_revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:52.133641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:52.133899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 07:25:52.155304) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-22 07:25:52.155607) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:25:53 INFO - MultiFileLogger online at 20160822 07:25:53 in /builds/slave/test 07:25:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:25:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:25:53 INFO - {'append_to_log': False, 07:25:53 INFO - 'base_work_dir': '/builds/slave/test', 07:25:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:25:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:25:53 INFO - 'branch': 'Firefox-Non-PGO', 07:25:53 INFO - 'buildbot_json_path': 'buildprops.json', 07:25:53 INFO - 'config_files': ('talos/linux_config.py',), 07:25:53 INFO - 'default_actions': ('clobber', 07:25:53 INFO - 'read-buildbot-config', 07:25:53 INFO - 'download-and-extract', 07:25:53 INFO - 'populate-webroot', 07:25:53 INFO - 'create-virtualenv', 07:25:53 INFO - 'install', 07:25:53 INFO - 'run-tests'), 07:25:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:25:53 INFO - 'download_minidump_stackwalk': True, 07:25:53 INFO - 'download_symbols': 'ondemand', 07:25:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:25:53 INFO - 'tooltool.py': '/tools/tooltool.py', 07:25:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:25:53 INFO - '/tools/misc-python/virtualenv.py')}, 07:25:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:25:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:25:53 INFO - 'installer_path': 'installer.exe', 07:25:53 INFO - 'log_level': 'info', 07:25:53 INFO - 'log_name': 'talos', 07:25:53 INFO - 'log_to_console': True, 07:25:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:25:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:25:53 INFO - 'opt_config_files': (), 07:25:53 INFO - 'pip_index': False, 07:25:53 INFO - 'sps_profile': False, 07:25:53 INFO - 'sps_profile_interval': 0, 07:25:53 INFO - 'suite': 'dromaeojs', 07:25:53 INFO - 'system_bits': '32', 07:25:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:25:53 INFO - 'title': 'talos-linux64-ix-008', 07:25:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:25:53 INFO - 'use_talos_json': True, 07:25:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:25:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:25:53 INFO - 'work_dir': 'build'} 07:25:53 INFO - [mozharness: 2016-08-22 14:25:53.298113Z] Running clobber step. 07:25:53 INFO - Running pre-action listener: _resource_record_pre_action 07:25:53 INFO - Running main action method: clobber 07:25:53 INFO - rmtree: /builds/slave/test/build 07:25:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:25:54 INFO - Running post-action listener: _resource_record_post_action 07:25:54 INFO - [mozharness: 2016-08-22 14:25:54.283620Z] Finished clobber step (success) 07:25:54 INFO - [mozharness: 2016-08-22 14:25:54.283720Z] Running read-buildbot-config step. 07:25:54 INFO - Running pre-action listener: _resource_record_pre_action 07:25:54 INFO - Running main action method: read_buildbot_config 07:25:54 INFO - Using buildbot properties: 07:25:54 INFO - { 07:25:54 INFO - "project": "", 07:25:54 INFO - "product": "firefox", 07:25:54 INFO - "script_repo_revision": "production", 07:25:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:25:54 INFO - "repository": "", 07:25:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:25:54 INFO - "buildid": "20160822064115", 07:25:54 INFO - "pgo_build": "False", 07:25:54 INFO - "basedir": "/builds/slave/test", 07:25:54 INFO - "buildnumber": 601, 07:25:54 INFO - "slavename": "talos-linux64-ix-008", 07:25:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:25:54 INFO - "platform": "ubuntu64_hw", 07:25:54 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:25:54 INFO - "branch": "mozilla-central", 07:25:54 INFO - "repo_path": "mozilla-central", 07:25:54 INFO - "revision": "194fe275b4e60ded2af6b25173eec421f0dba8ad", 07:25:54 INFO - "stage_platform": "linux64", 07:25:54 INFO - "builduid": "2c3858c2ad4a4d32bfc521ec00bd8e20", 07:25:54 INFO - "slavebuilddir": "test" 07:25:54 INFO - } 07:25:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:25:54 INFO - Running post-action listener: _resource_record_post_action 07:25:54 INFO - [mozharness: 2016-08-22 14:25:54.286121Z] Finished read-buildbot-config step (success) 07:25:54 INFO - [mozharness: 2016-08-22 14:25:54.286226Z] Running download-and-extract step. 07:25:54 INFO - Running pre-action listener: _resource_record_pre_action 07:25:54 INFO - Running main action method: download_and_extract 07:25:54 INFO - mkdir: /builds/slave/test/build/tests 07:25: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')]} 07:25:54 INFO - trying https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:25:54 INFO - Downloading https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/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 07:25:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/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 07:25:54 INFO - Downloaded 1361 bytes. 07:25:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:25:54 INFO - Using the following test package requirements: 07:25:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:25:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:25:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:54 INFO - u'jsshell-linux-x86_64.zip'], 07:25:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:25:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:25:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:25:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:25:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:25:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:25: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')]} 07:25:54 INFO - trying https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:25:54 INFO - Downloading https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/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 07:25:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/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 07:25:55 INFO - Downloaded 20330671 bytes. 07:25:55 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 07:25:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:59 INFO - trying https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:25:59 INFO - Downloading https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/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 07:25:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/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 07:26:00 INFO - Downloaded 20330671 bytes. 07:26:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:26:05 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')]} 07:26:05 INFO - trying https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:26:05 INFO - Downloading https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/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 07:26:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/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 07:26:06 INFO - Downloaded 14413981 bytes. 07:26:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 07:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:26:06 INFO - trying https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:26:06 INFO - Downloading https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/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 07:26:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/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 07:26:08 INFO - Downloaded 55759138 bytes. 07:26:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:26:08 INFO - mkdir: /builds/slave/test/properties 07:26:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:26:08 INFO - Writing to file /builds/slave/test/properties/build_url 07:26:08 INFO - Contents: 07:26:08 INFO - build_url:https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:26:09 INFO - Running post-action listener: _resource_record_post_action 07:26:09 INFO - Running post-action listener: set_extra_try_arguments 07:26:09 INFO - [mozharness: 2016-08-22 14:26:09.646450Z] Finished download-and-extract step (success) 07:26:09 INFO - [mozharness: 2016-08-22 14:26:09.646676Z] Running populate-webroot step. 07:26:09 INFO - Running pre-action listener: _resource_record_pre_action 07:26:09 INFO - Running main action method: populate_webroot 07:26:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:26:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:26:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:26:09 INFO - '--tppagecycles', 07:26:09 INFO - '7'], 07:26:09 INFO - 'tests': ['tsvgm']}}, 07:26:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:26:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:26:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:26:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:26:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:09 INFO - 'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:26:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:26:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:09 INFO - 'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['damp', 'tps']}, 07:26:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:09 INFO - 'tests': ['damp', 'tps']}, 07:26:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['dromaeo_dom']}, 07:26:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:26:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['basic_compositor_video']}, 07:26:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:26:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['a11yr', 07:26:09 INFO - 'ts_paint', 07:26:09 INFO - 'tpaint', 07:26:09 INFO - 'sessionrestore', 07:26:09 INFO - 'sessionrestore_no_auto_restore', 07:26:09 INFO - 'tabpaint']}, 07:26:09 INFO - 'other-e10s': {'tests': ['a11yr', 07:26:09 INFO - 'ts_paint', 07:26:09 INFO - 'tpaint', 07:26:09 INFO - 'sessionrestore', 07:26:09 INFO - 'sessionrestore_no_auto_restore', 07:26:09 INFO - 'tabpaint']}, 07:26:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:26:09 INFO - 'ts_paint', 07:26:09 INFO - 'tpaint', 07:26:09 INFO - 'sessionrestore', 07:26:09 INFO - 'sessionrestore_no_auto_restore', 07:26:09 INFO - 'tabpaint']}, 07:26:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:26:09 INFO - 'ts_paint', 07:26:09 INFO - 'tpaint', 07:26:09 INFO - 'sessionrestore', 07:26:09 INFO - 'sessionrestore_no_auto_restore', 07:26:09 INFO - 'tabpaint']}, 07:26:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['a11yr', 07:26:09 INFO - 'ts_paint', 07:26:09 INFO - 'tpaint', 07:26:09 INFO - 'sessionrestore', 07:26:09 INFO - 'sessionrestore_no_auto_restore', 07:26:09 INFO - 'tabpaint']}, 07:26:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['a11yr', 07:26:09 INFO - 'ts_paint', 07:26:09 INFO - 'tpaint', 07:26:09 INFO - 'sessionrestore', 07:26:09 INFO - 'sessionrestore_no_auto_restore', 07:26:09 INFO - 'tabpaint']}, 07:26:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['tsvgx', 07:26:09 INFO - 'tsvgr_opacity', 07:26:09 INFO - 'tart', 07:26:09 INFO - 'tscrollx', 07:26:09 INFO - 'cart']}, 07:26:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:26:09 INFO - 'tsvgr_opacity', 07:26:09 INFO - 'tart', 07:26:09 INFO - 'tscrollx', 07:26:09 INFO - 'cart']}, 07:26:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:09 INFO - 'talos_options': ['--disable-e10s'], 07:26:09 INFO - 'tests': ['tp5o']}, 07:26:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:09 INFO - 'tests': ['tp5o']}, 07:26:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:09 INFO - 'talos_options': ['--disable-e10s', 07:26:09 INFO - '--xperf_path', 07:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:26:09 INFO - 'tests': ['tp5n']}, 07:26:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:09 INFO - 'talos_options': ['--xperf_path', 07:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:26:09 INFO - 'tests': ['tp5n']}}, 07:26:09 INFO - 'talos.zip': {'path': '', 07:26:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:26:09 INFO - Running post-action listener: _resource_record_post_action 07:26:09 INFO - [mozharness: 2016-08-22 14:26:09.667351Z] Finished populate-webroot step (success) 07:26:09 INFO - [mozharness: 2016-08-22 14:26:09.667439Z] Running create-virtualenv step. 07:26:09 INFO - Running pre-action listener: _resource_record_pre_action 07:26:09 INFO - Running main action method: create_virtualenv 07:26:09 INFO - Creating virtualenv /builds/slave/test/build/venv 07:26:09 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 07:26:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:26:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:26:09 INFO - Using real prefix '/usr' 07:26:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:26:10 INFO - Installing distribute.............................................................................................................................................................................................done. 07:26:12 INFO - Installing pip.................done. 07:26:12 INFO - Return code: 0 07:26:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:26:12 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')]} 07:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:12 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')]} 07:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:12 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 0x7effd9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2543230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, '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': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', '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 07:26:12 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 07:26:12 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 07:26:12 INFO - Using env: {'DISPLAY': ':0', 07:26:12 INFO - 'HOME': '/home/cltbld', 07:26:12 INFO - 'LANG': 'en_US.UTF-8', 07:26:12 INFO - 'LANGUAGE': 'en_US:en', 07:26:12 INFO - 'LOGNAME': 'cltbld', 07:26:12 INFO - 'MAIL': '/var/mail/cltbld', 07:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:12 INFO - 'MOZ_NO_REMOTE': '1', 07:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:12 INFO - 'NO_EM_RESTART': '1', 07:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:12 INFO - 'PWD': '/builds/slave/test', 07:26:12 INFO - 'SHELL': '/bin/bash', 07:26:12 INFO - 'SHLVL': '1', 07:26:12 INFO - 'TERM': 'linux', 07:26:12 INFO - 'TMOUT': '86400', 07:26:12 INFO - 'USER': 'cltbld', 07:26:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:12 INFO - '_': '/tools/buildbot/bin/python'} 07:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:12 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 07:26:12 INFO - Cleaning up... 07:26:12 INFO - Return code: 0 07:26:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:26:12 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')]} 07:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:12 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')]} 07:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:12 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 0x7effd9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2543230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, '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': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', '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 07:26:12 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 07:26:12 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 07:26:12 INFO - Using env: {'DISPLAY': ':0', 07:26:12 INFO - 'HOME': '/home/cltbld', 07:26:12 INFO - 'LANG': 'en_US.UTF-8', 07:26:12 INFO - 'LANGUAGE': 'en_US:en', 07:26:12 INFO - 'LOGNAME': 'cltbld', 07:26:12 INFO - 'MAIL': '/var/mail/cltbld', 07:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:12 INFO - 'MOZ_NO_REMOTE': '1', 07:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:12 INFO - 'NO_EM_RESTART': '1', 07:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:12 INFO - 'PWD': '/builds/slave/test', 07:26:12 INFO - 'SHELL': '/bin/bash', 07:26:12 INFO - 'SHLVL': '1', 07:26:12 INFO - 'TERM': 'linux', 07:26:12 INFO - 'TMOUT': '86400', 07:26:12 INFO - 'USER': 'cltbld', 07:26:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:12 INFO - '_': '/tools/buildbot/bin/python'} 07:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:12 INFO - Downloading/unpacking psutil>=3.1.1 07:26:12 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 07:26:12 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 07:26:12 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 07:26:12 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 07:26:12 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 07:26:12 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 07:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:26:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:26:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:26:14 INFO - Installing collected packages: psutil 07:26:14 INFO - Running setup.py install for psutil 07:26:14 INFO - building 'psutil._psutil_linux' extension 07:26:14 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 07:26:14 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 07:26:14 INFO - building 'psutil._psutil_posix' extension 07:26:14 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 07:26:15 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 07:26:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:26:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:26:15 INFO - Successfully installed psutil 07:26:15 INFO - Cleaning up... 07:26:15 INFO - Return code: 0 07:26:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:26:15 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')]} 07:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:15 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')]} 07:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:15 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 0x7effd9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2543230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, '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': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', '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 07:26:15 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 07:26:15 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 07:26:15 INFO - Using env: {'DISPLAY': ':0', 07:26:15 INFO - 'HOME': '/home/cltbld', 07:26:15 INFO - 'LANG': 'en_US.UTF-8', 07:26:15 INFO - 'LANGUAGE': 'en_US:en', 07:26:15 INFO - 'LOGNAME': 'cltbld', 07:26:15 INFO - 'MAIL': '/var/mail/cltbld', 07:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:15 INFO - 'MOZ_NO_REMOTE': '1', 07:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:15 INFO - 'NO_EM_RESTART': '1', 07:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:15 INFO - 'PWD': '/builds/slave/test', 07:26:15 INFO - 'SHELL': '/bin/bash', 07:26:15 INFO - 'SHLVL': '1', 07:26:15 INFO - 'TERM': 'linux', 07:26:15 INFO - 'TMOUT': '86400', 07:26:15 INFO - 'USER': 'cltbld', 07:26:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:15 INFO - '_': '/tools/buildbot/bin/python'} 07:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:26:15 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 07:26:15 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 07:26:15 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 07:26:15 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 07:26:15 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 07:26:15 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 07:26:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:26:17 INFO - Installing collected packages: mozsystemmonitor 07:26:17 INFO - Running setup.py install for mozsystemmonitor 07:26:17 INFO - Successfully installed mozsystemmonitor 07:26:17 INFO - Cleaning up... 07:26:17 INFO - Return code: 0 07:26:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effd9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2543230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, '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': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', '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 07:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:26:17 INFO - Using env: {'DISPLAY': ':0', 07:26:17 INFO - 'HOME': '/home/cltbld', 07:26:17 INFO - 'LANG': 'en_US.UTF-8', 07:26:17 INFO - 'LANGUAGE': 'en_US:en', 07:26:17 INFO - 'LOGNAME': 'cltbld', 07:26:17 INFO - 'MAIL': '/var/mail/cltbld', 07:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:17 INFO - 'MOZ_NO_REMOTE': '1', 07:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:17 INFO - 'NO_EM_RESTART': '1', 07:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:17 INFO - 'PWD': '/builds/slave/test', 07:26:17 INFO - 'SHELL': '/bin/bash', 07:26:17 INFO - 'SHLVL': '1', 07:26:17 INFO - 'TERM': 'linux', 07:26:17 INFO - 'TMOUT': '86400', 07:26:17 INFO - 'USER': 'cltbld', 07:26:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:17 INFO - '_': '/tools/buildbot/bin/python'} 07:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:17 INFO - Downloading/unpacking jsonschema==2.5.1 07:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:26:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:19 INFO - Downloading functools32-3.2.3-2.tar.gz 07:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:26:19 INFO - warning: no files found matching '*.txt' 07:26:19 INFO - no previously-included directories found matching 'build' 07:26:19 INFO - no previously-included directories found matching 'dist' 07:26:19 INFO - no previously-included directories found matching '.git*' 07:26:19 INFO - Installing collected packages: jsonschema, functools32 07:26:19 INFO - Running setup.py install for functools32 07:26:19 INFO - warning: no files found matching '*.txt' 07:26:19 INFO - no previously-included directories found matching 'build' 07:26:19 INFO - no previously-included directories found matching 'dist' 07:26:19 INFO - no previously-included directories found matching '.git*' 07:26:20 INFO - Successfully installed jsonschema functools32 07:26:20 INFO - Cleaning up... 07:26:20 INFO - Return code: 0 07:26:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:26:20 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')]} 07:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:20 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')]} 07:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:20 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 0x7effd9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2543230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, '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': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', '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 07:26:20 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 07:26:20 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 07:26:20 INFO - Using env: {'DISPLAY': ':0', 07:26:20 INFO - 'HOME': '/home/cltbld', 07:26:20 INFO - 'LANG': 'en_US.UTF-8', 07:26:20 INFO - 'LANGUAGE': 'en_US:en', 07:26:20 INFO - 'LOGNAME': 'cltbld', 07:26:20 INFO - 'MAIL': '/var/mail/cltbld', 07:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:20 INFO - 'MOZ_NO_REMOTE': '1', 07:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:20 INFO - 'NO_EM_RESTART': '1', 07:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:20 INFO - 'PWD': '/builds/slave/test', 07:26:20 INFO - 'SHELL': '/bin/bash', 07:26:20 INFO - 'SHLVL': '1', 07:26:20 INFO - 'TERM': 'linux', 07:26:20 INFO - 'TMOUT': '86400', 07:26:20 INFO - 'USER': 'cltbld', 07:26:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:20 INFO - '_': '/tools/buildbot/bin/python'} 07:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:26:20 INFO - Cleaning up... 07:26:20 INFO - Return code: 0 07:26:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:26:20 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')]} 07:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:20 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')]} 07:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:20 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 0x7effd9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2543230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, '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': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', '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 07:26:20 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 07:26:20 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 07:26:20 INFO - Using env: {'DISPLAY': ':0', 07:26:20 INFO - 'HOME': '/home/cltbld', 07:26:20 INFO - 'LANG': 'en_US.UTF-8', 07:26:20 INFO - 'LANGUAGE': 'en_US:en', 07:26:20 INFO - 'LOGNAME': 'cltbld', 07:26:20 INFO - 'MAIL': '/var/mail/cltbld', 07:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:20 INFO - 'MOZ_NO_REMOTE': '1', 07:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:20 INFO - 'NO_EM_RESTART': '1', 07:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:20 INFO - 'PWD': '/builds/slave/test', 07:26:20 INFO - 'SHELL': '/bin/bash', 07:26:20 INFO - 'SHLVL': '1', 07:26:20 INFO - 'TERM': 'linux', 07:26:20 INFO - 'TMOUT': '86400', 07:26:20 INFO - 'USER': 'cltbld', 07:26:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:20 INFO - '_': '/tools/buildbot/bin/python'} 07:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:20 INFO - Downloading/unpacking blobuploader==1.2.4 07:26:20 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 07:26:20 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 07:26:20 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 07:26:20 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 07:26:20 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 07:26:20 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 07:26:22 INFO - Downloading blobuploader-1.2.4.tar.gz 07:26:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:26:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:26:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:23 INFO - Downloading docopt-0.6.1.tar.gz 07:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:26:23 INFO - Installing collected packages: blobuploader, requests, docopt 07:26:23 INFO - Running setup.py install for blobuploader 07:26:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:26:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:26:23 INFO - Running setup.py install for requests 07:26:23 INFO - Running setup.py install for docopt 07:26:23 INFO - Successfully installed blobuploader requests docopt 07:26:23 INFO - Cleaning up... 07:26:23 INFO - Return code: 0 07:26:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:26:23 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')]} 07:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:23 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')]} 07:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:23 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 0x7effd9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2543230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, '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': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', '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 07:26:23 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 07:26:23 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 07:26:23 INFO - Using env: {'DISPLAY': ':0', 07:26:23 INFO - 'HOME': '/home/cltbld', 07:26:23 INFO - 'LANG': 'en_US.UTF-8', 07:26:23 INFO - 'LANGUAGE': 'en_US:en', 07:26:23 INFO - 'LOGNAME': 'cltbld', 07:26:23 INFO - 'MAIL': '/var/mail/cltbld', 07:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:23 INFO - 'MOZ_NO_REMOTE': '1', 07:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:23 INFO - 'NO_EM_RESTART': '1', 07:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:23 INFO - 'PWD': '/builds/slave/test', 07:26:23 INFO - 'SHELL': '/bin/bash', 07:26:23 INFO - 'SHLVL': '1', 07:26:23 INFO - 'TERM': 'linux', 07:26:23 INFO - 'TMOUT': '86400', 07:26:23 INFO - 'USER': 'cltbld', 07:26:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:23 INFO - '_': '/tools/buildbot/bin/python'} 07:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:26:23 INFO - Running setup.py (path:/tmp/pip-E_N_vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:26:24 INFO - Running setup.py (path:/tmp/pip-_F92dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:26:24 INFO - Running setup.py (path:/tmp/pip-ZU7nDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:26:24 INFO - Running setup.py (path:/tmp/pip-nJf8wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:26:24 INFO - Running setup.py (path:/tmp/pip-N3uiAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:26:24 INFO - Running setup.py (path:/tmp/pip-BW35Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:26:24 INFO - Running setup.py (path:/tmp/pip-nqbZIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:26:24 INFO - Running setup.py (path:/tmp/pip-EOQYW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:26:24 INFO - Running setup.py (path:/tmp/pip-xma4PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:26:24 INFO - Running setup.py (path:/tmp/pip-9Q9ZD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:26:24 INFO - Running setup.py (path:/tmp/pip-_2tL9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:26:24 INFO - Running setup.py (path:/tmp/pip-4VHKXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:26:24 INFO - Running setup.py (path:/tmp/pip-8EfCeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:26:24 INFO - Running setup.py (path:/tmp/pip-PXjFwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:26:24 INFO - Running setup.py (path:/tmp/pip-ePUNmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:26:25 INFO - Running setup.py (path:/tmp/pip-5fk0HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:26:25 INFO - Running setup.py (path:/tmp/pip-lEFrCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:26:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:26:25 INFO - Running setup.py install for manifestparser 07:26:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:26:25 INFO - Running setup.py install for mozcrash 07:26:25 INFO - Running setup.py install for mozdebug 07:26:25 INFO - Running setup.py install for mozdevice 07:26:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:26:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:26:25 INFO - Running setup.py install for mozfile 07:26:25 INFO - Running setup.py install for mozhttpd 07:26:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:26:25 INFO - Running setup.py install for mozinfo 07:26:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:26:25 INFO - Running setup.py install for mozInstall 07:26:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:26:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:26:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:26:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:26:25 INFO - Running setup.py install for mozleak 07:26:26 INFO - Running setup.py install for mozlog 07:26:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:26:26 INFO - Running setup.py install for moznetwork 07:26:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:26:26 INFO - Running setup.py install for mozprocess 07:26:26 INFO - Running setup.py install for mozprofile 07:26:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:26:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:26:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:26:26 INFO - Running setup.py install for mozrunner 07:26:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:26:26 INFO - Running setup.py install for mozscreenshot 07:26:26 INFO - Running setup.py install for moztest 07:26:26 INFO - Running setup.py install for mozversion 07:26:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:26:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:26:26 INFO - Cleaning up... 07:26:26 INFO - Return code: 0 07:26:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:26:26 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')]} 07:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:26 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')]} 07:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:26 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 0x7effd9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2543230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, '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': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', '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 07:26:26 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 07:26:26 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 07:26:26 INFO - Using env: {'DISPLAY': ':0', 07:26:26 INFO - 'HOME': '/home/cltbld', 07:26:26 INFO - 'LANG': 'en_US.UTF-8', 07:26:26 INFO - 'LANGUAGE': 'en_US:en', 07:26:26 INFO - 'LOGNAME': 'cltbld', 07:26:26 INFO - 'MAIL': '/var/mail/cltbld', 07:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:26 INFO - 'MOZ_NO_REMOTE': '1', 07:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:26 INFO - 'NO_EM_RESTART': '1', 07:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:26 INFO - 'PWD': '/builds/slave/test', 07:26:26 INFO - 'SHELL': '/bin/bash', 07:26:26 INFO - 'SHLVL': '1', 07:26:26 INFO - 'TERM': 'linux', 07:26:26 INFO - 'TMOUT': '86400', 07:26:26 INFO - 'USER': 'cltbld', 07:26:26 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:26 INFO - '_': '/tools/buildbot/bin/python'} 07:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:26:27 INFO - Running setup.py (path:/tmp/pip-zf91k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:26:27 INFO - Running setup.py (path:/tmp/pip-NbPPbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:26:27 INFO - Running setup.py (path:/tmp/pip-TtNrb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:26:27 INFO - Running setup.py (path:/tmp/pip-gE_hka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:26:27 INFO - Running setup.py (path:/tmp/pip-MK_d2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:26:27 INFO - Running setup.py (path:/tmp/pip-80nyOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:26:27 INFO - Running setup.py (path:/tmp/pip-VfKIWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:26:27 INFO - Running setup.py (path:/tmp/pip-a_Oz4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:26:27 INFO - Running setup.py (path:/tmp/pip-py2DW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:26:27 INFO - Running setup.py (path:/tmp/pip-Gniq8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:26:27 INFO - Running setup.py (path:/tmp/pip-yUArRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:26:27 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)) 07:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:26:28 INFO - Running setup.py (path:/tmp/pip-kif1f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:26:28 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)) 07:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:26:28 INFO - Running setup.py (path:/tmp/pip-TVDyMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:26:28 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)) 07:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:26:28 INFO - Running setup.py (path:/tmp/pip-efWDr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:26:28 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)) 07:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:26:28 INFO - Running setup.py (path:/tmp/pip-8Gz7cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:26:28 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)) 07:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:26:28 INFO - Running setup.py (path:/tmp/pip-GX7JMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:26:28 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)) 07:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:26:28 INFO - Running setup.py (path:/tmp/pip-rTuifQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:26:28 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)) 07:26:28 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)) 07:26:28 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)) 07:26:28 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)) 07:26:28 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)) 07:26:28 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)) 07:26:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:26:28 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 07:26:28 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 07:26:28 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 07:26:28 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 07:26:28 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 07:26:28 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 07:26:30 INFO - Downloading blessings-1.6.tar.gz 07:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:26:30 INFO - Installing collected packages: blessings 07:26:30 INFO - Running setup.py install for blessings 07:26:30 INFO - Successfully installed blessings 07:26:30 INFO - Cleaning up... 07:26:30 INFO - Return code: 0 07:26:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:26:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:26:30 INFO - Reading from file tmpfile_stdout 07:26:30 INFO - Current package versions: 07:26:30 INFO - argparse == 1.2.1 07:26:30 INFO - blessings == 1.6 07:26:30 INFO - blobuploader == 1.2.4 07:26:30 INFO - docopt == 0.6.1 07:26:30 INFO - functools32 == 3.2.3-2 07:26:30 INFO - jsonschema == 2.5.1 07:26:30 INFO - manifestparser == 1.1 07:26:30 INFO - mozInstall == 1.12 07:26:30 INFO - mozcrash == 0.17 07:26:30 INFO - mozdebug == 0.1 07:26:30 INFO - mozdevice == 0.48 07:26:30 INFO - mozfile == 1.2 07:26:30 INFO - mozhttpd == 0.7 07:26:30 INFO - mozinfo == 0.9 07:26:30 INFO - mozleak == 0.1 07:26:30 INFO - mozlog == 3.3 07:26:30 INFO - moznetwork == 0.27 07:26:30 INFO - mozprocess == 0.23 07:26:30 INFO - mozprofile == 0.28 07:26:30 INFO - mozrunner == 6.12 07:26:30 INFO - mozscreenshot == 0.1 07:26:30 INFO - mozsystemmonitor == 0.3 07:26:30 INFO - moztest == 0.7 07:26:30 INFO - mozversion == 1.4 07:26:30 INFO - psutil == 3.1.1 07:26:30 INFO - requests == 1.2.3 07:26:30 INFO - wsgiref == 0.1.2 07:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:26:30 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')]} 07:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:30 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')]} 07:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:30 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 0x7effd9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2543230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, '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': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', '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 07:26:30 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 07:26:30 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 07:26:30 INFO - Using env: {'DISPLAY': ':0', 07:26:30 INFO - 'HOME': '/home/cltbld', 07:26:30 INFO - 'LANG': 'en_US.UTF-8', 07:26:30 INFO - 'LANGUAGE': 'en_US:en', 07:26:30 INFO - 'LOGNAME': 'cltbld', 07:26:30 INFO - 'MAIL': '/var/mail/cltbld', 07:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:30 INFO - 'MOZ_NO_REMOTE': '1', 07:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:30 INFO - 'NO_EM_RESTART': '1', 07:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:30 INFO - 'PWD': '/builds/slave/test', 07:26:30 INFO - 'SHELL': '/bin/bash', 07:26:30 INFO - 'SHLVL': '1', 07:26:30 INFO - 'TERM': 'linux', 07:26:30 INFO - 'TMOUT': '86400', 07:26:30 INFO - 'USER': 'cltbld', 07:26:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:30 INFO - '_': '/tools/buildbot/bin/python'} 07:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:30 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)) 07:26:30 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)) 07:26:30 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)) 07:26:30 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)) 07:26:30 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)) 07:26:30 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)) 07:26:30 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)) 07:26:30 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)) 07:26:30 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)) 07:26:30 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)) 07:26:30 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)) 07:26:30 INFO - Cleaning up... 07:26:30 INFO - Return code: 0 07:26:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:26:30 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')]} 07:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:30 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')]} 07:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:30 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 0x7effd9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2543230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, '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': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', '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 07:26:30 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 07:26:30 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 07:26:30 INFO - Using env: {'DISPLAY': ':0', 07:26:30 INFO - 'HOME': '/home/cltbld', 07:26:30 INFO - 'LANG': 'en_US.UTF-8', 07:26:30 INFO - 'LANGUAGE': 'en_US:en', 07:26:30 INFO - 'LOGNAME': 'cltbld', 07:26:30 INFO - 'MAIL': '/var/mail/cltbld', 07:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:30 INFO - 'MOZ_NO_REMOTE': '1', 07:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:30 INFO - 'NO_EM_RESTART': '1', 07:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:30 INFO - 'PWD': '/builds/slave/test', 07:26:30 INFO - 'SHELL': '/bin/bash', 07:26:30 INFO - 'SHLVL': '1', 07:26:30 INFO - 'TERM': 'linux', 07:26:30 INFO - 'TMOUT': '86400', 07:26:30 INFO - 'USER': 'cltbld', 07:26:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:30 INFO - '_': '/tools/buildbot/bin/python'} 07:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:26:31 INFO - Cleaning up... 07:26:31 INFO - Return code: 0 07:26:31 INFO - Running post-action listener: _resource_record_post_action 07:26:31 INFO - Running post-action listener: _start_resource_monitoring 07:26:31 INFO - Starting resource monitoring. 07:26:31 INFO - [mozharness: 2016-08-22 14:26:31.227715Z] Finished create-virtualenv step (success) 07:26:31 INFO - [mozharness: 2016-08-22 14:26:31.228185Z] Running install step. 07:26:31 INFO - Running pre-action listener: _resource_record_pre_action 07:26:31 INFO - Running main action method: install 07:26:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:26:31 INFO - Reading from file tmpfile_stdout 07:26:31 INFO - Detecting whether we're running mozinstall >=1.0... 07:26:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:26:31 INFO - Reading from file tmpfile_stdout 07:26:31 INFO - Output received: 07:26:31 INFO - Usage: mozinstall [options] installer 07:26:31 INFO - Options: 07:26:31 INFO - -h, --help show this help message and exit 07:26:31 INFO - -d DEST, --destination=DEST 07:26:31 INFO - Directory to install application into. [default: 07:26:31 INFO - "/builds/slave/test"] 07:26:31 INFO - --app=APP Application being installed. [default: firefox] 07:26:31 INFO - mkdir: /builds/slave/test/build/application 07:26:31 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'] 07:26:31 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 07:26:47 INFO - Reading from file tmpfile_stdout 07:26:47 INFO - Output received: 07:26:47 INFO - /builds/slave/test/build/application/firefox/firefox 07:26:47 INFO - Running post-action listener: _resource_record_post_action 07:26:47 INFO - [mozharness: 2016-08-22 14:26:47.614437Z] Finished install step (success) 07:26:47 INFO - [mozharness: 2016-08-22 14:26:47.614692Z] Running run-tests step. 07:26:47 INFO - Running pre-action listener: _resource_record_pre_action 07:26:47 INFO - Running main action method: run_tests 07:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:26:47 INFO - Python 2.7.3 07:26:47 INFO - Return code: 0 07:26:47 INFO - grabbing minidump binary from tooltool 07:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:26:47 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 0x253d090>, '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 0x25409b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2540e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:26:47 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 07:26:47 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 07:26:47 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 07:26:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:26:47 INFO - Return code: 0 07:26:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:26:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:26:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:26:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:26:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:26:47 INFO - Using env: {'DISPLAY': ':0', 07:26:47 INFO - 'HOME': '/home/cltbld', 07:26:47 INFO - 'LANG': 'en_US.UTF-8', 07:26:47 INFO - 'LANGUAGE': 'en_US:en', 07:26:47 INFO - 'LOGNAME': 'cltbld', 07:26:47 INFO - 'MAIL': '/var/mail/cltbld', 07:26:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:26:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:47 INFO - 'MOZ_NO_REMOTE': '1', 07:26:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:47 INFO - 'NO_EM_RESTART': '1', 07:26:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:47 INFO - 'PWD': '/builds/slave/test', 07:26:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:26:47 INFO - 'SHELL': '/bin/bash', 07:26:47 INFO - 'SHLVL': '1', 07:26:47 INFO - 'TERM': 'linux', 07:26:47 INFO - 'TMOUT': '86400', 07:26:47 INFO - 'USER': 'cltbld', 07:26:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074', 07:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:47 INFO - '_': '/tools/buildbot/bin/python'} 07:26:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:26:47 INFO - mozversion application_buildid: 20160822064115 07:26:47 INFO - mozversion application_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 07:26:47 INFO - mozversion application_display_name: Nightly 07:26:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:26:47 INFO - mozversion application_name: Firefox 07:26:47 INFO - mozversion application_remotingname: firefox 07:26:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:26:47 INFO - mozversion application_vendor: Mozilla 07:26:47 INFO - mozversion application_version: 51.0a1 07:26:47 INFO - mozversion platform_buildid: 20160822064115 07:26:47 INFO - mozversion platform_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 07:26:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:26:47 INFO - mozversion platform_version: 51.0a1 07:26:47 INFO - using testdate: 1471876007 07:26:47 INFO - actual date: 1471876007 07:26:47 INFO - starting webserver on 'localhost:53334' 07:26:47 INFO - SUITE-START | Running 2 tests 07:26:47 INFO - TEST-START | dromaeo_css 07:26:47 INFO - operating with platform_type : linux_ 07:26:47 INFO - Initialising browser for dromaeo_css test... 07:26:47 INFO - TEST-INFO | started process 20369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpliYPax/profile http://localhost:53334/getInfo.html) 07:26:52 INFO - PROCESS | 20369 | __metrics Screen width/height:1600/1200 07:26:52 INFO - PROCESS | 20369 | colorDepth:24 07:26:52 INFO - PROCESS | 20369 | Browser inner width/height: 1024/697 07:26:52 INFO - PROCESS | 20369 | __metrics 07:26:52 INFO - PROCESS | 20369 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:26:52 INFO - PROCESS | 20369 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:26:54 INFO - TEST-INFO | 20369: exit 0 07:26:54 INFO - Browser initialized. 07:26:54 INFO - Running cycle 1/1 for dromaeo_css test... 07:26:54 INFO - TEST-INFO | started process 20449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpliYPax/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:06 INFO - PROCESS | 20449 | RSS: Main: 177872896 07:27:06 INFO - PROCESS | 20449 | 07:27:57 INFO - PROCESS | 20449 | 1471876077131 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] 07:30:09 INFO - PROCESS | 20449 | Cycle 1(1): loaded http://localhost:53334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53334/tests/dromaeo/cssquery-ext.html) 07:30:11 INFO - PROCESS | 20449 | RSS: Main: 277307392 07:30:11 INFO - PROCESS | 20449 | 07:33:13 INFO - PROCESS | 20449 | Cycle 1(1): loaded http://localhost:53334/tests/dromaeo/cssquery-ext.html (next: http://localhost:53334/tests/dromaeo/cssquery-jquery.html) 07:33:14 INFO - PROCESS | 20449 | RSS: Main: 278335488 07:33:14 INFO - PROCESS | 20449 | 07:36:16 INFO - PROCESS | 20449 | Cycle 1(1): loaded http://localhost:53334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53334/tests/dromaeo/cssquery-mootools.html) 07:36:17 INFO - PROCESS | 20449 | RSS: Main: 218443776 07:36:17 INFO - PROCESS | 20449 | 07:39:19 INFO - PROCESS | 20449 | Cycle 1(1): loaded http://localhost:53334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53334/tests/dromaeo/cssquery-prototype.html) 07:39:20 INFO - PROCESS | 20449 | RSS: Main: 217505792 07:39:20 INFO - PROCESS | 20449 | 07:42:23 INFO - PROCESS | 20449 | Cycle 1(1): loaded http://localhost:53334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53334/tests/dromaeo/cssquery-yui.html) 07:42:24 INFO - PROCESS | 20449 | RSS: Main: 222990336 07:42:24 INFO - PROCESS | 20449 | 07:45:26 INFO - PROCESS | 20449 | Cycle 1(1): loaded http://localhost:53334/tests/dromaeo/cssquery-yui.html (next: http://localhost:53334/tests/dromaeo/cssquery-dojo.html) 07:45:27 INFO - PROCESS | 20449 | RSS: Main: 306417664 07:45:27 INFO - PROCESS | 20449 | 07:45:27 INFO - PROCESS | 20449 | __start_tp_report 07:45:27 INFO - PROCESS | 20449 | _x_x_mozilla_page_load 07:45:27 INFO - PROCESS | 20449 | _x_x_mozilla_page_load_details 07:45:27 INFO - PROCESS | 20449 | |i|pagename|runs| 07:45:27 INFO - PROCESS | 20449 | |0;dojo.html;2577.355661084729;2613.673290838645;2616.1759045900553;2627.2249686342525;2637.538430774614;4496.437945256843;4588.931166032512;4600.194965880966;4692.5542073503;4696.953030469695;4596.885077873055;4618.307253911907;4631.2821512665505;4644.744539050351;4725.858224253269;4066.6340029397347;4275.828966841338;4350.521442641307;4370.366296886949;4393.362962370455;4356.891077723067;4386.407834942273;4408.338749187616;4408.669349798778;4410.8235670573295;4162.396452514398;4169.60388763067;4234.026173979971;4312.008238105253;4336.067745434747;4271.658267338606;4277.807498662568;4279.144171165779;4283.378910058055;4292.914141717149;4260.723053001545;4263.147370525907;4265.829366825324;4268.189044081646;4271.508776490712;4488.551144885485;4502.57225563571;4514.751688657123;4525.977370113162;4631.722096674211;4903.53416425439;4920.434150072716;4930.03864246472;4935.92596111055;4939.382577177853;4977.104121258172;4989.700617962898;4994.101061808873;4997.375328083989;4997.675151115202;4488.842890498882;4580.816767329269;4590.97704511482;4599.149157405891;4675.95324046762;5055.266986286968;5068.315777370008;5075.56857667095;5076.822311219164;5077.416097148875;4868.805247790119;4874.293227481995;4877.219644856806;4877.439094504107;4881.121398148367;4796.448408433005;4818.4217893852265;4848.733319667452;4880.560749532488;4992.850214493571;4909.754512274372;4917.213245880642;4925.482824303468;4926.605871530269;4928.6303527235605;4873.171560834667;4906.435759887588;4914.287428322945;4919.065377578248;4919.557239848431;4042.130941847517;4094.508658960884;4146.025683964326;4172.520160181557;4221.767802770877;3673.412254039394;3682.318771027315;3683.5211422514903;3690.6493883081066;3694.3165514379925;4356.803943822536;4361.193179261847;4366.781660916941;4370.7159034662645;4376.846810361622;4752.1921273383605;4901.142300097468;4963.230699241623;4968.378952630921;4986.650934434555;4373.037931655031;4393.077453734688;4396.076823867023;4399.450068741407;4410.691251612357;4542.114287713864;4554.521775213621;4557.589816916494;4559.6124329431705;4560.1335746208115;4637.513061128533;4714;4766.904661906812;4771.73755443454;4818.084563932842;5028.748562571784;5039.941612261467;5041.269015992587;5046.873828154326;5049.495050494921;4800.0639875224;4828.758562071812;4832.782524786323;4843.176659967884;4846.055019271208;4718.079974404958;4789.353437285922;4789.808407663654;4823.469418364048;4967.677100988424;4982.551570358685;4983.426905905867;4993.950060499348;4997;5000.67495612784;4852.8301509447;4866.732329721899;4869.220924652039;4869.951300487091;4872.756362181806;4701.083288758659;4780.880477988078;4812.326274321527;4823.877493902672;4838.975805120952;4815.893748532247;4817.5182481752945;4821.2045012572535;4823.300621409946;4825.589824864785;4915.090708218848;4920.507949205051;4926.334944782552;4934.654574179916;4937.333459982857;4606.56237657422;4620.561046700558;4708.505606911225;4776.331313616027;4810.807567697253 07:45:27 INFO - PROCESS | 20449 | |1;ext.html;506.83274519408576;516.9405518365388;522.3288074823852;525.466651348881;534.6978956889355;32846;34031.489527657104;34050.148746281324;34108.65891341086;37159.4426083609;32450.67549324506;32769.50845737316;32803.83598082012;32827.67172328276;32852.83573582129;7417.7403790867465;7544.622768861563;7545.924540754577;7555.131159916625;7557.395408367345;7430.628468576577;7506.1367942686475;7514.211007844179;7517.4737768356235;7521.473496855222;7481.438892083088;7548.962255188716;7551.207123252035;7555;7557.168711441737;7506.860544744776;7507.624618769067;7512.136104348016;7536.246375362474;7544.019277493918;7373.520721153108;7426.591537465437;7434.665440055211;7439.293267139613;7440.590767507785;30390.240243993856;30732.8463357684;30752.53871191934;30760;30789.692103078905;2666.346745047476;2681.9195424137306;2713.796465265093;2723.523383407896;3014.5327474241526;25315.873420632965;25376.49247015068;25593.23220303394;25633.487330253476;25794.871025644938;3029.1972627253795;3115.641701204368;3151.9054428367185;3172.7937684050694;3191.090539196318;241925;245884;246208;246241;246474.9999999982;39401.40897886534;39568.40647390291;39588.40617390742;39598.60401396007;39623.20753584912;39772.40341394823;43746.781266093465;44835.32747008798;45291;45477.54522454799;11456.19806613529;11906.523739050514;11906.940465297617;11918.165728398928;11943.402829858645;8994.190522852974;9014.774630634156;9017.684381046633;9021.819563608822;9044.186023257938;12772.10595258323;13005.349732513336;13186.406611702496;14055.929720351332;14488.710225795425;5677.205191273225;5782.132680098019;5824.941750582525;5843.5325173985975;5892.175095486636;701.2251462134268;707.8796604577234;801.9558924259222;814.352589691197;864.4856310495245;24332.391690207885;24377.342295811646;25063.373415664755;25309.14180036972;25345;801.1587832775563;807.3541167066323;814.5419698739308;821.4660470694097;858.4849090545747;12278.570250041206;12971.805422918475;13108.213507189408;13149.079564430589;13239.470421183045;399867;403829;405494;406071;407553;38813.61186388157;39229;39244.80377598094;39249.803750981635;39368.21263574713;1028.7016765138176;1044.7910417916446;1078.4499905048324;1078.6278733836814;1080.206048554312;22889.65665515052;22903.312900613008;23609.40976475602;23732.52534949326;23834.284971450885;34969.125771855906;35205.64794352126;35541.28917421585;35549;35569.64430355663;281470;282273;282777;283494;283707;20352.28766993148;21421.571568568852;21928.342149735534;22230.888845556317;22424.215152469584;33415.33169336648;34385;34633.134171645914;34702.13244668904;34997.47503787394;28523.42953140884;29075.563866541597;29327.26681832886;29444.263893402836;30000.549991749704;27236.182914512596;27298.590521142596;27773.444531109668;27977.440451190454;28279.71720282771;29400.411991760473;29808;29851;29900.252493687833;30145;26156.215313540622;26674.866625666746;27169.320766980985;27274.45451091007;27493.17520474389;21897.562048759253;22011.80828779786;22303.77696223017;22369.217077402864;22430.66354004724 07:45:27 INFO - PROCESS | 20449 | |2;jquery.html;324.79700187382883;333.7413504533984;349.8880358285349;353.5086230140106;365.87011610878136;11991.280523168616;15314.54056378309;15395.384184632616;16148.75776863348;16275;14883.553493395188;15144.469943551978;15148;15159.924200378982;15312.540623781277;4676.97661511692;4828.130936431432;5045.545900868921;5063;5066.03745288394;4878.829240976566;5009.073321435528;5009.198528235483;5010.3737032870895;5012.874678133039;4823.5176482351835;4970.428400733907;4978.6514943953935;4979.751012449363;4981.12830254704;4860.5139486051285;4931.063098011402;4934.037862616791;4936.2102063669645;4942.9258561121615;4234.407182994383;4425.15921974827;4429.867103986853;4432.667549933735;4433.1577000369825;18861.622767544573;19082.14130364123;19107.808921910742;19373.709394359095;19380.612387752306;1897.231621193405;1924.7786504551875;1935.458071739915;2091.3307741522717;2513.0324824942345;11868.347240901747;12372;12424.627261182179;12822.80765788514;12877.162984405984;1715.5282297368324;1762.647470505904;1766.7173252279702;1778.5197996540862;1814.4556633010045;67428;68318;68791.65604171997;68873;70777;8297.294729947902;8347.207015333533;8495.150484951455;8634.5251011195;8713.607887645072;10771.676849694364;10819.080378167786;10823.567057317776;10829.187810914213;10839.078678312275;6085.604435711664;6120.816375508742;6235;6309.053641953652;6315.936840631627;5803.649521943619;5886.6173698709445;5995.760169593167;6028.4272994065495;6046.879062418727;5093.083245015859;5161.380634323905;5187.584993200535;5298.417174110845;5305.681659100466;1459.5767227504118;1481.207553958627;1484.5991582272725;1504.6764945536763;1507.5326648738926;736.2674139231499;747.7980945144781;777.2872674366533;779.3492433817712;785.9646315915797;15486.845131548765;15786.052836829827;16130.274137663833;16360.754588681179;16938.49184524466;761;794.7973266816924;803.6303300481727;814.2183503836266;859.5272600069936;8823.955880220557;9023.007469178385;9146.451212927246;9248.676296329731;9485.620575176916;391357;391859;411352;418441;418935;43609;44106.12179615336;70494;70945.6452717733;71451;811.5455345006815;835.3233880556769;838.5681374092347;839.7858546070835;840.8990921089509;13871.79192312096;13985.860141398456;14079;14183.361748721538;14675.41298348054;34673.653263467044;37653.05867353338;37711.24577508379;37808.43287350637;38316.2336753269;47318.90216467557;50580.49419505758;50741.492585073676;51135.74432127816;53172.202416963;7322.926770732224;7336.193018768038;7394.926050739424;7435;7463.067116610424;9903.55434005457;11031.22781405294;11293.604723834625;11340.603078892529;11392.658220253406;9724.367916085432;9731.9026809731;10029.247806414402;10043.443266293736;10154.79690406173;9720.659776907774;9726.173275271682;9887.505624718879;9948.403095814274;9965.750856228653;9822;9864.704058878246;9897.65358212459;9937.155341796028;10114.696559103239;7292;7301.853962920818;7351.191368949304;7369.705211791468;7544.924550754642;8647.697330593399;9743.9025609743;9841.409515429097;9857.654982075594;10203.28576999603 07:45:27 INFO - PROCESS | 20449 | |3;mootools.html;1039.8908114647966;1119;1123.7415394459274;1155.324135380802;1273.1088238233233;6445.903311450326;7150.74972375967;7334.193238743734;7346.081739782534;7571.6214189290595;7324.414046876251;7387.187409384964;7390.113186417624;7391.6304184790815;7394.223606521318;2087.039961617658;2114.4819519217813;2129.4250552350854;2129.58473097746;2130.2544109561686;2084.1246676395876;2139.4009677290305;2161.7405911290666;2164.9891750541306;2167.0898222746405;2113.154738104755;2135;2139.4865232344205;2149;2167.4147980045377;2108.7996640319143;2111.5565731196466;2115.6932244824416;2116.925907593227;2117.396541985542;2062.855600107993;2096.3815674376096;2107.620628286908;2112.324056301984;2115.95768084639;7239.131304243472;7354;7411.258874112599;7430.14553326369;7446.441516886255;4344.565543445662;4552.590266875997;4554.2485489894125;4563.475200351969;4589.426321709786;2918.5768063630867;3072.6773688762582;3094.412061708268;3105.6739042400673;3109.5646609474693;883.960221790021;889.2308153447286;890;890.4523717913437;906.7687739626354;10716.249862509627;10834.40410777407;10841;10861.565537378574;10931.45342732868;3753.8926016825103;3933.7246392752804;4041.312976793952;4060.553339132693;4114.423980642712;7857.842843143105;7860.253275938777;7862.410319226081;7867.724629637935;7874;4393.494748103945;4397.526828512484;4406.1187762447635;4406.294992801137;4415.381846541487;3515.5254040704176;3876.6898648108086;4038.2327357801923;4063.329550624114;4078.653314468244;3359.277755282626;3395.2360718838063;3489.3195826813526;3494.1963348430004;3506.0708912138302;1056.8731752189633;1062.7130674717937;1075.6665433715573;1075.8493810866485;1080.4057768227444;740.344794856545;747.316205671815;759.8556274307974;760.8326168242978;790.5335851847323;4935.925961110586;4987.276844857548;5029.698218106925;5046.974765126224;5249.081410753103;371.7602146615418;377.67331258461235;381.27367365169397;382.1439974457251;389.9317619416591;3329.8668053278084;3468.7571869969365;3494.3688048166473;3525.1715846775987;3527.647235276503;9312.208462280647;9624.855627165598;9665.9033409665;9718.805623887483;9730.12428881404;9609.807803844024;9625.133737963617;9631.71104866855;9633.32566720337;9654.27592930533;6671.199456065303;6716.5634233774645;6730.158730158731;6734.764283250062;6736.292689267654;4713.9292910607055;4812.711237325771;4839.637027222902;4945.357103576512;5037.571806396498;8713.215810576825;8807.691730789391;8813.118688131135;8906.86639700418;8943.418677785923;8997.280217582447;9031.45811251327;9104.954475227581;9113.362064655676;9156.58795354224;5402.270693456333;5746.827595172152;6137.907931381123;6202.4417802398;6210.720517576629;7172.354488096096;7489.28851759082;7490.438217133627;7498.58757768328;7499.737509187153;6522.739090436329;6643.103181070687;6711.094002309821;6843.726250949906;6864.107666003388;6426.518011149089;6516.967415162894;6547.083408322744;6682.599044057372;6712.563683360566;5950.761969521171;6034.125051867367;6041.124037014696;6043.09353596964;6043.697815109315;4354.150940566559;4401.911961760811;4521.502634710245;4577.130345234395;4591.8392856249875;4495.640348772155;4507.129541240349;4622.352870598052;4701.976490117528;4768.022555376209 07:45:27 INFO - PROCESS | 20449 | |4;prototype.html;288.61614053309097;295.69838764460235;298.63715585563534;299.2085932707988;299.64941019007756;4668;4707.811687532495;4713.151632706112;4735.28970654402;4743.217369134089;4612.607928326096;4645.279981602848;4682.578567928886;4688.765561721917;4693.812247510095;3500.247446798944;3603.4414665726854;3624.5831729351066;3678.406723260095;3689.8155092245415;3659.1035196376924;3672.6594792900532;3673.669369756721;3683.907902302437;3694.113412780927;3633.582138054118;3640.9271814563695;3642.4354225095153;3644.817759112047;3661.1945372018113;3482.1990942083207;3530.5939816921127;3640.290143422034;3645.8359373828243;3660.450932360154;3233.2563510392506;3240.4491236489853;3242.789218700777;3244.67553244676;3258.1365938026443;4533.750643714594;4541.751018469947;4544.5228251033495;4552.180607490651;4570.794314255833;3914.5106861642294;4176.728512646669;4189.183109293689;4197.370394440828;4204.26425375558;4833.589144922686;4841.7337046462435;4854.786303424144;4855.927161092586;4866.975665121652;3451.8446669899913;3460.1349662584353;3461.567304086989;3463.5670541182353;3467.763292676235;5002.7248501332415;5038.697678139287;5046.318746969149;5087.8982420351385;5096.923546146773;3464.272502774395;3520.559930008749;3535.133892196377;3564.679178873862;3574.1422058706244;3604.5494313210847;3604.6395360463744;3607.7192596628342;3618.5115009473384;3628.2017956049626;4117.649999750055;4126.484189476316;4128.772917489507;4140.275451795984;4140.399642051885;4654.627629789608;4894.916202792218;4908.239222920453;4916.926246106311;4919.409670839451;1229.4528934624007;1253.2793643654934;1254.3038613569556;1258.5720854909375;1262.5391732017747;787.8778789287669;801.3268854162532;808.8139727862624;808.9838203235902;809.4940662086196;4275.5296917339065;4403.185410699031;4429.357743127229;4429.734215947054;4434.314960315124;5016.147254966664;5017.37282839645;5033.7734801934;5035.446100928895;5041.521055499722;4415.2935530315;4423.270160423558;4423.447069116361;4432.224360736923;4442.9777851111185;2529.6711427514306;2632.605109233592;2646.7617914387797;2647.907323243677;2651.668541432321;4813.326134341195;4841.668541151141;4875.878103047452;4884.5603895649565;4885.387822018725;5004.674696144739;5129.897402051938;5170.819021334235;5171.560417364491;5182.32629758129;4796.304535842353;4815.446223684321;4879.53644403774;4882.8779280517565;4883;5035.571976382049;5036.345275114211;5036.722980236123;5047.747612619428;5058.1654027085115;4724.858254252378;4946.678465899705;4992.850214493571;5000.449950505369;5013.649044566845;4783.445380251363;4832.589229915356;4844.176489996638;4853.854384368334;4858.684185528071;3569.428891377367;3570;3586.282743451268;3597.7514053716427;3600.2439487707875;5009.499050094962;5012.774425150804;5021.669257646654;5040.546350828443;5048.697078175322;4689.531046895283;4806.6687656487275;4859.805607775649;4873.731944742932;4888.877778055577;4837.733924634179;4852.296417019583;4859.757012149307;4860.854174374775;4874.976884592854;4764.332993380999;4780.306855506002;4797.136515427256;4813.9037219254715;4829.9517004830905;4758.690685105457;4869.001854619865;4892.290617860462;4910;4914.410270767531;4771.403574553181;4797.832075877328;4810.831620893252;4817.421909370898;4835.395575553056 07:45:27 INFO - PROCESS | 20449 | |5;yui.html;533.1443033930541;555.7804667156473;556.9805056823012;574.1674571870785;586.0769288370817;11499.252548584336;12783.616491505258;12895.677608059803;12898.806517902216;12920.224786512805;11134.38760868152;11228;11245.493952772125;11281.010532208971;12034.03727701784;559.6138664321616;572.1503567202722;572.3418069220388;572.7880684146871;573.0401577357909;477.88530752619295;546.7676237599024;556.6743455078764;559.1305519916529;563.3605857351914;583.3320847629461;584.75732570983;585.7071464267866;586.2232541882003;586.4956137721556;578.8234588450521;578.9565782566282;579.2672269578986;579.568221674855;579.8289504596133;363.4185303514382;417.1365273883063;418.99371509427385;419.61395516125236;419.89292730353867;10548.947255263674;10599.788004239948;10713.83929241062;10782.892171078345;10833.566657333697;11106.333619982826;11511.942440287829;11591.304521728724;11713.414329283502;12072.396380180955;10849.077828384598;10854.782904341948;10886.455677216187;10986.01125898673;11139.498722557424;3837.347650899326;3890.720207771457;3950.3876899080688;3987.641112299878;4056.0671045659665;62859.68570157166;62925.68537157331;63043.36956630421;63077;63296.68351658258;9227.123423274777;9273.072692730673;9341.626334946663;9391.718248452557;9685.612575496902;16698.58253543671;16740.58148546296;16747.162641867857;16763;16808.74786878198;6365.8726825464155;6408.1669382980845;6416.422521973045;6425;6631.33686631333;3560.501529785832;3625.7099432045375;3630.183208778004;3687.1519550503;3756.3426400379826;2552.9106481273066;2636.1300770745606;2656.242970753326;2660.2950218192195;2664.10752397945;431.91145815108456;432.6076795321875;435.7755755785773;436.14515549522656;439.3695047606695;389.21573030343313;456.49129626583795;478.77497576139854;485.7110019538369;495.13351634639383;7436.59098749574;7581.241875812375;7665.616719164131;7676.961615191888;7773.484170586795;427.8224536817186;468.18535747798586;469.08996546699296;517.1312195511501;520.8333333333297;3547.113221694576;3621.3843646580144;3654.057291146842;3749.1939233065023;3751.1372384351207;58456.41543584595;60278.397216028156;60559.39440605626;60755;60805.69597151986;89306;92217;92348.53825730829;93526;97739.51130244303;80038.59980700059;83897.58051209705;84689;85665.14334856697;85698.00113991961;6977.372036516738;7097.503174777716;7309.707611695472;7439.479236453396;7469.14104877946;35229.64770352366;42292.78853605712;42453.787731061144;44441.555584445035;46447.53552464432;39621.207575847744;40127;40141.79929100336;52020;59594.40405595888;8535.146485351415;8580.528070956158;8706.129387061243;8726;9105.817883642423;9942.353747006422;10063.748406289902;10090.798184036132;10340.172786176938;10449.58201671955;9492.453499468078;9517.095875891779;9523.571439285388;9547.140757331874;9653.1794797443;9306.48814315192;9438.622455101719;9471.857922131036;9539.379940303857;9653.082957119062;8478.152184781473;8699.826003480022;8882.467051976902;8907.376483646083;9098.317626178195;7857.4499785014505;8087.150849160988;8286.129956354736;8300.377471689526;8378.706745263886;8183.386246031452;8245;9477.95261023718;9932.503374831085;9933.801323973335 07:45:27 INFO - PROCESS | 20449 | __end_tp_report 07:45:27 INFO - PROCESS | 20449 | __start_cc_report 07:45:27 INFO - PROCESS | 20449 | _x_x_mozilla_cycle_collect,1038 07:45:27 INFO - PROCESS | 20449 | __end_cc_report 07:45:27 INFO - PROCESS | 20449 | __startTimestamp1471877127249__endTimestamp 07:45:27 INFO - PROCESS | 20449 | 07:45:27 INFO - PROCESS | 20449 | ------- Summary: start ------- 07:45:27 INFO - PROCESS | 20449 | Number of tests: 6 07:45:27 INFO - PROCESS | 20449 | 07:45:27 INFO - PROCESS | 20449 | [#0] dojo.html Cycles:165 Average:4594.22 Median:4752.19 stddev:472.31 (9.9%) stddev-sans-first:446.47 07:45:27 INFO - PROCESS | 20449 | Values: 2577.4 2613.7 2616.2 2627.2 2637.5 4496.4 4588.9 4600.2 4692.6 4697.0 4596.9 4618.3 4631.3 4644.7 4725.9 4066.6 4275.8 4350.5 4370.4 4393.4 4356.9 4386.4 4408.3 4408.7 4410.8 4162.4 4169.6 4234.0 4312.0 4336.1 4271.7 4277.8 4279.1 4283.4 4292.9 4260.7 4263.1 4265.8 4268.2 4271.5 4488.6 4502.6 4514.8 4526.0 4631.7 4903.5 4920.4 4930.0 4935.9 4939.4 4977.1 4989.7 4994.1 4997.4 4997.7 4488.8 4580.8 4591.0 4599.1 4676.0 5055.3 5068.3 5075.6 5076.8 5077.4 4868.8 4874.3 4877.2 4877.4 4881.1 4796.4 4818.4 4848.7 4880.6 4992.9 4909.8 4917.2 4925.5 4926.6 4928.6 4873.2 4906.4 4914.3 4919.1 4919.6 4042.1 4094.5 4146.0 4172.5 4221.8 3673.4 3682.3 3683.5 3690.6 3694.3 4356.8 4361.2 4366.8 4370.7 4376.8 4752.2 4901.1 4963.2 4968.4 4986.7 4373.0 4393.1 4396.1 4399.5 4410.7 4542.1 4554.5 4557.6 4559.6 4560.1 4637.5 4714.0 4766.9 4771.7 4818.1 5028.7 5039.9 5041.3 5046.9 5049.5 4800.1 4828.8 4832.8 4843.2 4846.1 4718.1 4789.4 4789.8 4823.5 4967.7 4982.6 4983.4 4994.0 4997.0 5000.7 4852.8 4866.7 4869.2 4870.0 4872.8 4701.1 4780.9 4812.3 4823.9 4839.0 4815.9 4817.5 4821.2 4823.3 4825.6 4915.1 4920.5 4926.3 4934.7 4937.3 4606.6 4620.6 4708.5 4776.3 4810.8 07:45:27 INFO - PROCESS | 20449 | 07:45:27 INFO - PROCESS | 20449 | [#1] ext.html Cycles:180 Average:43166.98 Median:32610.09 stddev:84286.84 (258.5%) stddev-sans-first:84462.42 07:45:27 INFO - PROCESS | 20449 | Values: 506.8 516.9 522.3 525.5 534.7 32846.0 34031.5 34050.1 34108.7 37159.4 32450.7 32769.5 32803.8 32827.7 32852.8 7417.7 7544.6 7545.9 7555.1 7557.4 7430.6 7506.1 7514.2 7517.5 7521.5 7481.4 7549.0 7551.2 7555.0 7557.2 7506.9 7507.6 7512.1 7536.2 7544.0 7373.5 7426.6 7434.7 7439.3 7440.6 30390.2 30732.8 30752.5 30760.0 30789.7 2666.3 2681.9 2713.8 2723.5 3014.5 25315.9 25376.5 25593.2 25633.5 25794.9 3029.2 3115.6 3151.9 3172.8 3191.1 241925.0 245884.0 246208.0 246241.0 246475.0 39401.4 39568.4 39588.4 39598.6 39623.2 39772.4 43746.8 44835.3 45291.0 45477.5 11456.2 11906.5 11906.9 11918.2 11943.4 8994.2 9014.8 9017.7 9021.8 9044.2 12772.1 13005.3 13186.4 14055.9 14488.7 5677.2 5782.1 5824.9 5843.5 5892.2 701.2 707.9 802.0 814.4 864.5 24332.4 24377.3 25063.4 25309.1 25345.0 801.2 807.4 814.5 821.5 858.5 12278.6 12971.8 13108.2 13149.1 13239.5 399867.0 403829.0 405494.0 406071.0 407553.0 38813.6 39229.0 39244.8 39249.8 39368.2 1028.7 1044.8 1078.4 1078.6 1080.2 22889.7 22903.3 23609.4 23732.5 23834.3 34969.1 35205.6 35541.3 35549.0 35569.6 281470.0 282273.0 282777.0 283494.0 283707.0 20352.3 21421.6 21928.3 22230.9 22424.2 33415.3 34385.0 34633.1 34702.1 34997.5 28523.4 29075.6 29327.3 29444.3 30000.5 27236.2 27298.6 27773.4 27977.4 28279.7 29400.4 29808.0 29851.0 29900.3 30145.0 26156.2 26674.9 27169.3 27274.5 27493.2 21897.6 22011.8 22303.8 22369.2 22430.7 07:45:27 INFO - PROCESS | 20449 | 07:45:27 INFO - PROCESS | 20449 | [#2] jquery.html Cycles:180 Average:23846.57 Median:4956.68 stddev:66826.94 (1348.2%) stddev-sans-first:66991.07 07:45:27 INFO - PROCESS | 20449 | Values: 324.8 333.7 349.9 353.5 365.9 11991.3 15314.5 15395.4 16148.8 16275.0 14883.6 15144.5 15148.0 15159.9 15312.5 4677.0 4828.1 5045.5 5063.0 5066.0 4878.8 5009.1 5009.2 5010.4 5012.9 4823.5 4970.4 4978.7 4979.8 4981.1 4860.5 4931.1 4934.0 4936.2 4942.9 4234.4 4425.2 4429.9 4432.7 4433.2 18861.6 19082.1 19107.8 19373.7 19380.6 1897.2 1924.8 1935.5 2091.3 2513.0 11868.3 12372.0 12424.6 12822.8 12877.2 1715.5 1762.6 1766.7 1778.5 1814.5 67428.0 68318.0 68791.7 68873.0 70777.0 8297.3 8347.2 8495.2 8634.5 8713.6 10771.7 10819.1 10823.6 10829.2 10839.1 6085.6 6120.8 6235.0 6309.1 6315.9 5803.6 5886.6 5995.8 6028.4 6046.9 5093.1 5161.4 5187.6 5298.4 5305.7 1459.6 1481.2 1484.6 1504.7 1507.5 736.3 747.8 777.3 779.3 786.0 15486.8 15786.1 16130.3 16360.8 16938.5 761.0 794.8 803.6 814.2 859.5 8824.0 9023.0 9146.5 9248.7 9485.6 391357.0 391859.0 411352.0 418441.0 418935.0 43609.0 44106.1 70494.0 70945.6 71451.0 811.5 835.3 838.6 839.8 840.9 13871.8 13985.9 14079.0 14183.4 14675.4 34673.7 37653.1 37711.2 37808.4 38316.2 47318.9 50580.5 50741.5 51135.7 53172.2 7322.9 7336.2 7394.9 7435.0 7463.1 9903.6 11031.2 11293.6 11340.6 11392.7 9724.4 9731.9 10029.2 10043.4 10154.8 9720.7 9726.2 9887.5 9948.4 9965.8 9822.0 9864.7 9897.7 9937.2 10114.7 7292.0 7301.9 7351.2 7369.7 7544.9 8647.7 9743.9 9841.4 9857.7 10203.3 07:45:27 INFO - PROCESS | 20449 | 07:45:27 INFO - PROCESS | 20449 | [#3] mootools.html Cycles:180 Average:4940.96 Median:4790.37 stddev:2839.13 (59.3%) stddev-sans-first:2831.95 07:45:27 INFO - PROCESS | 20449 | Values: 1039.9 1119.0 1123.7 1155.3 1273.1 6445.9 7150.7 7334.2 7346.1 7571.6 7324.4 7387.2 7390.1 7391.6 7394.2 2087.0 2114.5 2129.4 2129.6 2130.3 2084.1 2139.4 2161.7 2165.0 2167.1 2113.2 2135.0 2139.5 2149.0 2167.4 2108.8 2111.6 2115.7 2116.9 2117.4 2062.9 2096.4 2107.6 2112.3 2116.0 7239.1 7354.0 7411.3 7430.1 7446.4 4344.6 4552.6 4554.2 4563.5 4589.4 2918.6 3072.7 3094.4 3105.7 3109.6 884.0 889.2 890.0 890.5 906.8 10716.2 10834.4 10841.0 10861.6 10931.5 3753.9 3933.7 4041.3 4060.6 4114.4 7857.8 7860.3 7862.4 7867.7 7874.0 4393.5 4397.5 4406.1 4406.3 4415.4 3515.5 3876.7 4038.2 4063.3 4078.7 3359.3 3395.2 3489.3 3494.2 3506.1 1056.9 1062.7 1075.7 1075.8 1080.4 740.3 747.3 759.9 760.8 790.5 4935.9 4987.3 5029.7 5047.0 5249.1 371.8 377.7 381.3 382.1 389.9 3329.9 3468.8 3494.4 3525.2 3527.6 9312.2 9624.9 9665.9 9718.8 9730.1 9609.8 9625.1 9631.7 9633.3 9654.3 6671.2 6716.6 6730.2 6734.8 6736.3 4713.9 4812.7 4839.6 4945.4 5037.6 8713.2 8807.7 8813.1 8906.9 8943.4 8997.3 9031.5 9105.0 9113.4 9156.6 5402.3 5746.8 6137.9 6202.4 6210.7 7172.4 7489.3 7490.4 7498.6 7499.7 6522.7 6643.1 6711.1 6843.7 6864.1 6426.5 6517.0 6547.1 6682.6 6712.6 5950.8 6034.1 6041.1 6043.1 6043.7 4354.2 4401.9 4521.5 4577.1 4591.8 4495.6 4507.1 4622.4 4702.0 4768.0 07:45:27 INFO - PROCESS | 20449 | 07:45:27 INFO - PROCESS | 20449 | [#4] prototype.html Cycles:180 Average:4071.80 Median:4689.15 stddev:1186.44 (25.3%) stddev-sans-first:1155.29 07:45:27 INFO - PROCESS | 20449 | Values: 288.6 295.7 298.6 299.2 299.6 4668.0 4707.8 4713.2 4735.3 4743.2 4612.6 4645.3 4682.6 4688.8 4693.8 3500.2 3603.4 3624.6 3678.4 3689.8 3659.1 3672.7 3673.7 3683.9 3694.1 3633.6 3640.9 3642.4 3644.8 3661.2 3482.2 3530.6 3640.3 3645.8 3660.5 3233.3 3240.4 3242.8 3244.7 3258.1 4533.8 4541.8 4544.5 4552.2 4570.8 3914.5 4176.7 4189.2 4197.4 4204.3 4833.6 4841.7 4854.8 4855.9 4867.0 3451.8 3460.1 3461.6 3463.6 3467.8 5002.7 5038.7 5046.3 5087.9 5096.9 3464.3 3520.6 3535.1 3564.7 3574.1 3604.5 3604.6 3607.7 3618.5 3628.2 4117.6 4126.5 4128.8 4140.3 4140.4 4654.6 4894.9 4908.2 4916.9 4919.4 1229.5 1253.3 1254.3 1258.6 1262.5 787.9 801.3 808.8 809.0 809.5 4275.5 4403.2 4429.4 4429.7 4434.3 5016.1 5017.4 5033.8 5035.4 5041.5 4415.3 4423.3 4423.4 4432.2 4443.0 2529.7 2632.6 2646.8 2647.9 2651.7 4813.3 4841.7 4875.9 4884.6 4885.4 5004.7 5129.9 5170.8 5171.6 5182.3 4796.3 4815.4 4879.5 4882.9 4883.0 5035.6 5036.3 5036.7 5047.7 5058.2 4724.9 4946.7 4992.9 5000.4 5013.6 4783.4 4832.6 4844.2 4853.9 4858.7 3569.4 3570.0 3586.3 3597.8 3600.2 5009.5 5012.8 5021.7 5040.5 5048.7 4689.5 4806.7 4859.8 4873.7 4888.9 4837.7 4852.3 4859.8 4860.9 4875.0 4764.3 4780.3 4797.1 4813.9 4830.0 4758.7 4869.0 4892.3 4910.0 4914.4 4771.4 4797.8 4810.8 4817.4 4835.4 07:45:27 INFO - PROCESS | 20449 | 07:45:27 INFO - PROCESS | 20449 | [#5] yui.html Cycles:180 Average:16000.15 Median:561.49 stddev:23591.07 (4201.5%) stddev-sans-first:23628.66 07:45:27 INFO - PROCESS | 20449 | Values: 533.1 555.8 557.0 574.2 586.1 11499.3 12783.6 12895.7 12898.8 12920.2 11134.4 11228.0 11245.5 11281.0 12034.0 559.6 572.2 572.3 572.8 573.0 477.9 546.8 556.7 559.1 563.4 583.3 584.8 585.7 586.2 586.5 578.8 579.0 579.3 579.6 579.8 363.4 417.1 419.0 419.6 419.9 10548.9 10599.8 10713.8 10782.9 10833.6 11106.3 11511.9 11591.3 11713.4 12072.4 10849.1 10854.8 10886.5 10986.0 11139.5 3837.3 3890.7 3950.4 3987.6 4056.1 62859.7 62925.7 63043.4 63077.0 63296.7 9227.1 9273.1 9341.6 9391.7 9685.6 16698.6 16740.6 16747.2 16763.0 16808.7 6365.9 6408.2 6416.4 6425.0 6631.3 3560.5 3625.7 3630.2 3687.2 3756.3 2552.9 2636.1 2656.2 2660.3 2664.1 431.9 432.6 435.8 436.1 439.4 389.2 456.5 478.8 485.7 495.1 7436.6 7581.2 7665.6 7677.0 7773.5 427.8 468.2 469.1 517.1 520.8 3547.1 3621.4 3654.1 3749.2 3751.1 58456.4 60278.4 60559.4 60755.0 60805.7 89306.0 92217.0 92348.5 93526.0 97739.5 80038.6 83897.6 84689.0 85665.1 85698.0 6977.4 7097.5 7309.7 7439.5 7469.1 35229.6 42292.8 42453.8 44441.6 46447.5 39621.2 40127.0 40141.8 52020.0 59594.4 8535.1 8580.5 8706.1 8726.0 9105.8 9942.4 10063.7 10090.8 10340.2 10449.6 9492.5 9517.1 9523.6 9547.1 9653.2 9306.5 9438.6 9471.9 9539.4 9653.1 8478.2 8699.8 8882.5 8907.4 9098.3 7857.4 8087.2 8286.1 8300.4 8378.7 8183.4 8245.0 9478.0 9932.5 9933.8 07:45:27 INFO - PROCESS | 20449 | -------- Summary: end -------- 07:45:27 INFO - PROCESS | 20449 | 07:45:28 INFO - TEST-INFO | 20449: exit 0 07:45:28 INFO - TEST-OK | dromaeo_css | took 1120321ms 07:45:28 INFO - TEST-START | kraken 07:45:28 INFO - operating with platform_type : linux_ 07:45:28 INFO - Initialising browser for kraken test... 07:45:28 INFO - TEST-INFO | started process 20793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcb20iU/profile http://localhost:53334/getInfo.html) 07:45:32 INFO - PROCESS | 20793 | __metrics Screen width/height:1600/1200 07:45:32 INFO - PROCESS | 20793 | colorDepth:24 07:45:32 INFO - PROCESS | 20793 | Browser inner width/height: 1024/697 07:45:32 INFO - PROCESS | 20793 | __metrics 07:45:33 INFO - PROCESS | 20793 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:45:33 INFO - PROCESS | 20793 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:45:33 INFO - PROCESS | 20793 | console.error: PushService: 07:45:33 INFO - PROCESS | 20793 | stateChangeProcessEnqueue: Error transitioning state 07:45:33 INFO - PROCESS | 20793 | UnknownError 07:45:34 INFO - TEST-INFO | 20793: exit 0 07:45:34 INFO - Browser initialized. 07:45:34 INFO - Running cycle 1/1 for kraken test... 07:45:34 INFO - TEST-INFO | started process 20872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcb20iU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:46 INFO - PROCESS | 20872 | RSS: Main: 175403008 07:45:46 INFO - PROCESS | 20872 | 07:45:49 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53334/tests/kraken/driver.html?testName=audio-beat-detection) 07:45:50 INFO - PROCESS | 20872 | RSS: Main: 244817920 07:45:50 INFO - PROCESS | 20872 | 07:45:52 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53334/tests/kraken/driver.html?testName=audio-dft) 07:45:53 INFO - PROCESS | 20872 | RSS: Main: 227246080 07:45:53 INFO - PROCESS | 20872 | 07:45:56 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53334/tests/kraken/driver.html?testName=audio-fft) 07:45:57 INFO - PROCESS | 20872 | RSS: Main: 302526464 07:45:57 INFO - PROCESS | 20872 | 07:45:59 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53334/tests/kraken/driver.html?testName=audio-oscillator) 07:46:00 INFO - PROCESS | 20872 | RSS: Main: 210685952 07:46:00 INFO - PROCESS | 20872 | 07:46:02 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:46:03 INFO - PROCESS | 20872 | RSS: Main: 214523904 07:46:03 INFO - PROCESS | 20872 | 07:46:06 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53334/tests/kraken/driver.html?testName=imaging-darkroom) 07:46:06 INFO - PROCESS | 20872 | RSS: Main: 251195392 07:46:06 INFO - PROCESS | 20872 | 07:46:10 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53334/tests/kraken/driver.html?testName=imaging-desaturate) 07:46:11 INFO - PROCESS | 20872 | RSS: Main: 245063680 07:46:11 INFO - PROCESS | 20872 | 07:46:13 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53334/tests/kraken/driver.html?testName=json-parse-financial) 07:46:14 INFO - PROCESS | 20872 | RSS: Main: 247595008 07:46:14 INFO - PROCESS | 20872 | 07:46:16 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:46:16 INFO - PROCESS | 20872 | RSS: Main: 211816448 07:46:16 INFO - PROCESS | 20872 | 07:46:18 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53334/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:46:19 INFO - PROCESS | 20872 | RSS: Main: 219885568 07:46:19 INFO - PROCESS | 20872 | 07:46:21 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:46:22 INFO - PROCESS | 20872 | RSS: Main: 222969856 07:46:22 INFO - PROCESS | 20872 | 07:46:25 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:46:25 INFO - PROCESS | 20872 | RSS: Main: 219140096 07:46:25 INFO - PROCESS | 20872 | 07:46:28 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:46:29 INFO - PROCESS | 20872 | RSS: Main: 221442048 07:46:29 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | Cycle 1(1): loaded http://localhost:53334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53334/tests/kraken/driver.html?testName=ai-astar) 07:46:31 INFO - PROCESS | 20872 | RSS: Main: 273104896 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | __start_tp_report 07:46:31 INFO - PROCESS | 20872 | _x_x_mozilla_page_load 07:46:31 INFO - PROCESS | 20872 | _x_x_mozilla_page_load_details 07:46:31 INFO - PROCESS | 20872 | |i|pagename|runs| 07:46:31 INFO - PROCESS | 20872 | |0;ai-astar;102;116;113;116;114;116;120;116;115;115 07:46:31 INFO - PROCESS | 20872 | |1;audio-beat-detection;159;123;146;192;126;155;154;124;189;122 07:46:31 INFO - PROCESS | 20872 | |2;audio-dft;162;162;160;160;164;162;161;163;160;161 07:46:31 INFO - PROCESS | 20872 | |3;audio-fft;78;76;76;186;76;76;76;108;112;75 07:46:31 INFO - PROCESS | 20872 | |4;audio-oscillator;87;86;147;86;86;88;143;86;85;156 07:46:31 INFO - PROCESS | 20872 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 07:46:31 INFO - PROCESS | 20872 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;145;146 07:46:31 INFO - PROCESS | 20872 | |7;imaging-desaturate;96;95;95;94;94;95;95;94;94;95 07:46:31 INFO - PROCESS | 20872 | |8;json-parse-financial;70;64;66;65;66;64;65;65;65;65 07:46:31 INFO - PROCESS | 20872 | |9;json-stringify-tinderbox;65;66;65;66;67;67;66;67;66;66 07:46:31 INFO - PROCESS | 20872 | |10;stanford-crypto-aes;83;81;83;82;82;82;82;83;82;85 07:46:31 INFO - PROCESS | 20872 | |11;stanford-crypto-ccm;135;131;132;132;134;132;131;144;153;141 07:46:31 INFO - PROCESS | 20872 | |12;stanford-crypto-pbkdf2;175;172;175;177;172;173;177;176;176;175 07:46:31 INFO - PROCESS | 20872 | |13;stanford-crypto-sha256-iterative;72;69;73;70;68;72;70;73;68;69 07:46:31 INFO - PROCESS | 20872 | __end_tp_report 07:46:31 INFO - PROCESS | 20872 | __start_cc_report 07:46:31 INFO - PROCESS | 20872 | _x_x_mozilla_cycle_collect,2018 07:46:31 INFO - PROCESS | 20872 | __end_cc_report 07:46:31 INFO - PROCESS | 20872 | __startTimestamp1471877191436__endTimestamp 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | ------- Summary: start ------- 07:46:31 INFO - PROCESS | 20872 | Number of tests: 14 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#0] ai-astar Cycles:10 Average:114.30 Median:116.00 stddev:4.69 (4.0%) stddev-sans-first:1.94 07:46:31 INFO - PROCESS | 20872 | Values: 102.0 116.0 113.0 116.0 114.0 116.0 120.0 116.0 115.0 115.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.50 stddev:26.20 (17.0%) stddev-sans-first:27.54 07:46:31 INFO - PROCESS | 20872 | Values: 159.0 123.0 146.0 192.0 126.0 155.0 154.0 124.0 189.0 122.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 07:46:31 INFO - PROCESS | 20872 | Values: 162.0 162.0 160.0 160.0 164.0 162.0 161.0 163.0 160.0 161.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:35.31 (46.5%) stddev-sans-first:36.98 07:46:31 INFO - PROCESS | 20872 | Values: 78.0 76.0 76.0 186.0 76.0 76.0 76.0 108.0 112.0 75.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:86.00 stddev:30.31 (35.2%) stddev-sans-first:31.44 07:46:31 INFO - PROCESS | 20872 | Values: 87.0 86.0 147.0 86.0 86.0 88.0 143.0 86.0 85.0 156.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:46:31 INFO - PROCESS | 20872 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 07:46:31 INFO - PROCESS | 20872 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 07:46:31 INFO - PROCESS | 20872 | Values: 96.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.00 stddev:1.72 (2.6%) stddev-sans-first:0.71 07:46:31 INFO - PROCESS | 20872 | Values: 70.0 64.0 66.0 65.0 66.0 64.0 65.0 65.0 65.0 65.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 07:46:31 INFO - PROCESS | 20872 | Values: 65.0 66.0 65.0 66.0 67.0 67.0 66.0 67.0 66.0 66.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:1.08 (1.3%) stddev-sans-first:1.13 07:46:31 INFO - PROCESS | 20872 | Values: 83.0 81.0 83.0 82.0 82.0 82.0 82.0 83.0 82.0 85.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:134.50 stddev:7.29 (5.4%) stddev-sans-first:7.71 07:46:31 INFO - PROCESS | 20872 | Values: 135.0 131.0 132.0 132.0 134.0 132.0 131.0 144.0 153.0 141.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.50 stddev:1.87 (1.1%) stddev-sans-first:1.99 07:46:31 INFO - PROCESS | 20872 | Values: 175.0 172.0 175.0 177.0 172.0 173.0 177.0 176.0 176.0 175.0 07:46:31 INFO - PROCESS | 20872 | 07:46:31 INFO - PROCESS | 20872 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:1.96 (2.8%) stddev-sans-first:1.99 07:46:31 INFO - PROCESS | 20872 | Values: 72.0 69.0 73.0 70.0 68.0 72.0 70.0 73.0 68.0 69.0 07:46:31 INFO - PROCESS | 20872 | -------- Summary: end -------- 07:46:31 INFO - PROCESS | 20872 | 07:46:32 INFO - TEST-INFO | 20872: exit 0 07:46:32 INFO - TEST-OK | kraken | took 64498ms 07:46:32 INFO - SUITE-END | took 1184s 07:46:33 INFO - Completed test suite (00:19:45) 07:46:33 INFO - javascript benchmark 07:46:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.355661084729, 2613.673290838645, 2616.1759045900553, 2627.2249686342525, 2637.538430774614, 4496.437945256843, 4588.931166032512, 4600.194965880966, 4692.5542073503, 4696.953030469695, 4596.885077873055, 4618.307253911907, 4631.2821512665505, 4644.744539050351, 4725.858224253269, 4066.6340029397347, 4275.828966841338, 4350.521442641307, 4370.366296886949, 4393.362962370455, 4356.891077723067, 4386.407834942273, 4408.338749187616, 4408.669349798778, 4410.8235670573295, 4162.396452514398, 4169.60388763067, 4234.026173979971, 4312.008238105253, 4336.067745434747, 4271.658267338606, 4277.807498662568, 4279.144171165779, 4283.378910058055, 4292.914141717149, 4260.723053001545, 4263.147370525907, 4265.829366825324, 4268.189044081646, 4271.508776490712, 4488.551144885485, 4502.57225563571, 4514.751688657123, 4525.977370113162, 4631.722096674211, 4903.53416425439, 4920.434150072716, 4930.03864246472, 4935.92596111055, 4939.382577177853, 4977.104121258172, 4989.700617962898, 4994.101061808873, 4997.375328083989, 4997.675151115202, 4488.842890498882, 4580.816767329269, 4590.97704511482, 4599.149157405891, 4675.95324046762, 5055.266986286968, 5068.315777370008, 5075.56857667095, 5076.822311219164, 5077.416097148875, 4868.805247790119, 4874.293227481995, 4877.219644856806, 4877.439094504107, 4881.121398148367, 4796.448408433005, 4818.4217893852265, 4848.733319667452, 4880.560749532488, 4992.850214493571, 4909.754512274372, 4917.213245880642, 4925.482824303468, 4926.605871530269, 4928.6303527235605, 4873.171560834667, 4906.435759887588, 4914.287428322945, 4919.065377578248, 4919.557239848431, 4042.130941847517, 4094.508658960884, 4146.025683964326, 4172.520160181557, 4221.767802770877, 3673.412254039394, 3682.318771027315, 3683.5211422514903, 3690.6493883081066, 3694.3165514379925, 4356.803943822536, 4361.193179261847, 4366.781660916941, 4370.7159034662645, 4376.846810361622, 4752.1921273383605, 4901.142300097468, 4963.230699241623, 4968.378952630921, 4986.650934434555, 4373.037931655031, 4393.077453734688, 4396.076823867023, 4399.450068741407, 4410.691251612357, 4542.114287713864, 4554.521775213621, 4557.589816916494, 4559.6124329431705, 4560.1335746208115, 4637.513061128533, 4714.0, 4766.904661906812, 4771.73755443454, 4818.084563932842, 5028.748562571784, 5039.941612261467, 5041.269015992587, 5046.873828154326, 5049.495050494921, 4800.0639875224, 4828.758562071812, 4832.782524786323, 4843.176659967884, 4846.055019271208, 4718.079974404958, 4789.353437285922, 4789.808407663654, 4823.469418364048, 4967.677100988424, 4982.551570358685, 4983.426905905867, 4993.950060499348, 4997.0, 5000.67495612784, 4852.8301509447, 4866.732329721899, 4869.220924652039, 4869.951300487091, 4872.756362181806, 4701.083288758659, 4780.880477988078, 4812.326274321527, 4823.877493902672, 4838.975805120952, 4815.893748532247, 4817.5182481752945, 4821.2045012572535, 4823.300621409946, 4825.589824864785, 4915.090708218848, 4920.507949205051, 4926.334944782552, 4934.654574179916, 4937.333459982857, 4606.56237657422, 4620.561046700558, 4708.505606911225, 4776.331313616027, 4810.807567697253], "value": 4564.577487571226, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.83274519408576, 516.9405518365388, 522.3288074823852, 525.466651348881, 534.6978956889355, 32846.0, 34031.489527657104, 34050.148746281324, 34108.65891341086, 37159.4426083609, 32450.67549324506, 32769.50845737316, 32803.83598082012, 32827.67172328276, 32852.83573582129, 7417.7403790867465, 7544.622768861563, 7545.924540754577, 7555.131159916625, 7557.395408367345, 7430.628468576577, 7506.1367942686475, 7514.211007844179, 7517.4737768356235, 7521.473496855222, 7481.438892083088, 7548.962255188716, 7551.207123252035, 7555.0, 7557.168711441737, 7506.860544744776, 7507.624618769067, 7512.136104348016, 7536.246375362474, 7544.019277493918, 7373.520721153108, 7426.591537465437, 7434.665440055211, 7439.293267139613, 7440.590767507785, 30390.240243993856, 30732.8463357684, 30752.53871191934, 30760.0, 30789.692103078905, 2666.346745047476, 2681.9195424137306, 2713.796465265093, 2723.523383407896, 3014.5327474241526, 25315.873420632965, 25376.49247015068, 25593.23220303394, 25633.487330253476, 25794.871025644938, 3029.1972627253795, 3115.641701204368, 3151.9054428367185, 3172.7937684050694, 3191.090539196318, 241925.0, 245884.0, 246208.0, 246241.0, 246474.9999999982, 39401.40897886534, 39568.40647390291, 39588.40617390742, 39598.60401396007, 39623.20753584912, 39772.40341394823, 43746.781266093465, 44835.32747008798, 45291.0, 45477.54522454799, 11456.19806613529, 11906.523739050514, 11906.940465297617, 11918.165728398928, 11943.402829858645, 8994.190522852974, 9014.774630634156, 9017.684381046633, 9021.819563608822, 9044.186023257938, 12772.10595258323, 13005.349732513336, 13186.406611702496, 14055.929720351332, 14488.710225795425, 5677.205191273225, 5782.132680098019, 5824.941750582525, 5843.5325173985975, 5892.175095486636, 701.2251462134268, 707.8796604577234, 801.9558924259222, 814.352589691197, 864.4856310495245, 24332.391690207885, 24377.342295811646, 25063.373415664755, 25309.14180036972, 25345.0, 801.1587832775563, 807.3541167066323, 814.5419698739308, 821.4660470694097, 858.4849090545747, 12278.570250041206, 12971.805422918475, 13108.213507189408, 13149.079564430589, 13239.470421183045, 399867.0, 403829.0, 405494.0, 406071.0, 407553.0, 38813.61186388157, 39229.0, 39244.80377598094, 39249.803750981635, 39368.21263574713, 1028.7016765138176, 1044.7910417916446, 1078.4499905048324, 1078.6278733836814, 1080.206048554312, 22889.65665515052, 22903.312900613008, 23609.40976475602, 23732.52534949326, 23834.284971450885, 34969.125771855906, 35205.64794352126, 35541.28917421585, 35549.0, 35569.64430355663, 281470.0, 282273.0, 282777.0, 283494.0, 283707.0, 20352.28766993148, 21421.571568568852, 21928.342149735534, 22230.888845556317, 22424.215152469584, 33415.33169336648, 34385.0, 34633.134171645914, 34702.13244668904, 34997.47503787394, 28523.42953140884, 29075.563866541597, 29327.26681832886, 29444.263893402836, 30000.549991749704, 27236.182914512596, 27298.590521142596, 27773.444531109668, 27977.440451190454, 28279.71720282771, 29400.411991760473, 29808.0, 29851.0, 29900.252493687833, 30145.0, 26156.215313540622, 26674.866625666746, 27169.320766980985, 27274.45451091007, 27493.17520474389, 21897.562048759253, 22011.80828779786, 22303.77696223017, 22369.217077402864, 22430.66354004724], "value": 15126.919627165948, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.79700187382883, 333.7413504533984, 349.8880358285349, 353.5086230140106, 365.87011610878136, 11991.280523168616, 15314.54056378309, 15395.384184632616, 16148.75776863348, 16275.0, 14883.553493395188, 15144.469943551978, 15148.0, 15159.924200378982, 15312.540623781277, 4676.97661511692, 4828.130936431432, 5045.545900868921, 5063.0, 5066.03745288394, 4878.829240976566, 5009.073321435528, 5009.198528235483, 5010.3737032870895, 5012.874678133039, 4823.5176482351835, 4970.428400733907, 4978.6514943953935, 4979.751012449363, 4981.12830254704, 4860.5139486051285, 4931.063098011402, 4934.037862616791, 4936.2102063669645, 4942.9258561121615, 4234.407182994383, 4425.15921974827, 4429.867103986853, 4432.667549933735, 4433.1577000369825, 18861.622767544573, 19082.14130364123, 19107.808921910742, 19373.709394359095, 19380.612387752306, 1897.231621193405, 1924.7786504551875, 1935.458071739915, 2091.3307741522717, 2513.0324824942345, 11868.347240901747, 12372.0, 12424.627261182179, 12822.80765788514, 12877.162984405984, 1715.5282297368324, 1762.647470505904, 1766.7173252279702, 1778.5197996540862, 1814.4556633010045, 67428.0, 68318.0, 68791.65604171997, 68873.0, 70777.0, 8297.294729947902, 8347.207015333533, 8495.150484951455, 8634.5251011195, 8713.607887645072, 10771.676849694364, 10819.080378167786, 10823.567057317776, 10829.187810914213, 10839.078678312275, 6085.604435711664, 6120.816375508742, 6235.0, 6309.053641953652, 6315.936840631627, 5803.649521943619, 5886.6173698709445, 5995.760169593167, 6028.4272994065495, 6046.879062418727, 5093.083245015859, 5161.380634323905, 5187.584993200535, 5298.417174110845, 5305.681659100466, 1459.5767227504118, 1481.207553958627, 1484.5991582272725, 1504.6764945536763, 1507.5326648738926, 736.2674139231499, 747.7980945144781, 777.2872674366533, 779.3492433817712, 785.9646315915797, 15486.845131548765, 15786.052836829827, 16130.274137663833, 16360.754588681179, 16938.49184524466, 761.0, 794.7973266816924, 803.6303300481727, 814.2183503836266, 859.5272600069936, 8823.955880220557, 9023.007469178385, 9146.451212927246, 9248.676296329731, 9485.620575176916, 391357.0, 391859.0, 411352.0, 418441.0, 418935.0, 43609.0, 44106.12179615336, 70494.0, 70945.6452717733, 71451.0, 811.5455345006815, 835.3233880556769, 838.5681374092347, 839.7858546070835, 840.8990921089509, 13871.79192312096, 13985.860141398456, 14079.0, 14183.361748721538, 14675.41298348054, 34673.653263467044, 37653.05867353338, 37711.24577508379, 37808.43287350637, 38316.2336753269, 47318.90216467557, 50580.49419505758, 50741.492585073676, 51135.74432127816, 53172.202416963, 7322.926770732224, 7336.193018768038, 7394.926050739424, 7435.0, 7463.067116610424, 9903.55434005457, 11031.22781405294, 11293.604723834625, 11340.603078892529, 11392.658220253406, 9724.367916085432, 9731.9026809731, 10029.247806414402, 10043.443266293736, 10154.79690406173, 9720.659776907774, 9726.173275271682, 9887.505624718879, 9948.403095814274, 9965.750856228653, 9822.0, 9864.704058878246, 9897.65358212459, 9937.155341796028, 10114.696559103239, 7292.0, 7301.853962920818, 7351.191368949304, 7369.705211791468, 7544.924550754642, 8647.697330593399, 9743.9025609743, 9841.409515429097, 9857.654982075594, 10203.28576999603], "value": 7724.26759428318, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1039.8908114647966, 1119.0, 1123.7415394459274, 1155.324135380802, 1273.1088238233233, 6445.903311450326, 7150.74972375967, 7334.193238743734, 7346.081739782534, 7571.6214189290595, 7324.414046876251, 7387.187409384964, 7390.113186417624, 7391.6304184790815, 7394.223606521318, 2087.039961617658, 2114.4819519217813, 2129.4250552350854, 2129.58473097746, 2130.2544109561686, 2084.1246676395876, 2139.4009677290305, 2161.7405911290666, 2164.9891750541306, 2167.0898222746405, 2113.154738104755, 2135.0, 2139.4865232344205, 2149.0, 2167.4147980045377, 2108.7996640319143, 2111.5565731196466, 2115.6932244824416, 2116.925907593227, 2117.396541985542, 2062.855600107993, 2096.3815674376096, 2107.620628286908, 2112.324056301984, 2115.95768084639, 7239.131304243472, 7354.0, 7411.258874112599, 7430.14553326369, 7446.441516886255, 4344.565543445662, 4552.590266875997, 4554.2485489894125, 4563.475200351969, 4589.426321709786, 2918.5768063630867, 3072.6773688762582, 3094.412061708268, 3105.6739042400673, 3109.5646609474693, 883.960221790021, 889.2308153447286, 890.0, 890.4523717913437, 906.7687739626354, 10716.249862509627, 10834.40410777407, 10841.0, 10861.565537378574, 10931.45342732868, 3753.8926016825103, 3933.7246392752804, 4041.312976793952, 4060.553339132693, 4114.423980642712, 7857.842843143105, 7860.253275938777, 7862.410319226081, 7867.724629637935, 7874.0, 4393.494748103945, 4397.526828512484, 4406.1187762447635, 4406.294992801137, 4415.381846541487, 3515.5254040704176, 3876.6898648108086, 4038.2327357801923, 4063.329550624114, 4078.653314468244, 3359.277755282626, 3395.2360718838063, 3489.3195826813526, 3494.1963348430004, 3506.0708912138302, 1056.8731752189633, 1062.7130674717937, 1075.6665433715573, 1075.8493810866485, 1080.4057768227444, 740.344794856545, 747.316205671815, 759.8556274307974, 760.8326168242978, 790.5335851847323, 4935.925961110586, 4987.276844857548, 5029.698218106925, 5046.974765126224, 5249.081410753103, 371.7602146615418, 377.67331258461235, 381.27367365169397, 382.1439974457251, 389.9317619416591, 3329.8668053278084, 3468.7571869969365, 3494.3688048166473, 3525.1715846775987, 3527.647235276503, 9312.208462280647, 9624.855627165598, 9665.9033409665, 9718.805623887483, 9730.12428881404, 9609.807803844024, 9625.133737963617, 9631.71104866855, 9633.32566720337, 9654.27592930533, 6671.199456065303, 6716.5634233774645, 6730.158730158731, 6734.764283250062, 6736.292689267654, 4713.9292910607055, 4812.711237325771, 4839.637027222902, 4945.357103576512, 5037.571806396498, 8713.215810576825, 8807.691730789391, 8813.118688131135, 8906.86639700418, 8943.418677785923, 8997.280217582447, 9031.45811251327, 9104.954475227581, 9113.362064655676, 9156.58795354224, 5402.270693456333, 5746.827595172152, 6137.907931381123, 6202.4417802398, 6210.720517576629, 7172.354488096096, 7489.28851759082, 7490.438217133627, 7498.58757768328, 7499.737509187153, 6522.739090436329, 6643.103181070687, 6711.094002309821, 6843.726250949906, 6864.107666003388, 6426.518011149089, 6516.967415162894, 6547.083408322744, 6682.599044057372, 6712.563683360566, 5950.761969521171, 6034.125051867367, 6041.124037014696, 6043.09353596964, 6043.697815109315, 4354.150940566559, 4401.911961760811, 4521.502634710245, 4577.130345234395, 4591.8392856249875, 4495.640348772155, 4507.129541240349, 4622.352870598052, 4701.976490117528, 4768.022555376209], "value": 3877.5469873482516, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.61614053309097, 295.69838764460235, 298.63715585563534, 299.2085932707988, 299.64941019007756, 4668.0, 4707.811687532495, 4713.151632706112, 4735.28970654402, 4743.217369134089, 4612.607928326096, 4645.279981602848, 4682.578567928886, 4688.765561721917, 4693.812247510095, 3500.247446798944, 3603.4414665726854, 3624.5831729351066, 3678.406723260095, 3689.8155092245415, 3659.1035196376924, 3672.6594792900532, 3673.669369756721, 3683.907902302437, 3694.113412780927, 3633.582138054118, 3640.9271814563695, 3642.4354225095153, 3644.817759112047, 3661.1945372018113, 3482.1990942083207, 3530.5939816921127, 3640.290143422034, 3645.8359373828243, 3660.450932360154, 3233.2563510392506, 3240.4491236489853, 3242.789218700777, 3244.67553244676, 3258.1365938026443, 4533.750643714594, 4541.751018469947, 4544.5228251033495, 4552.180607490651, 4570.794314255833, 3914.5106861642294, 4176.728512646669, 4189.183109293689, 4197.370394440828, 4204.26425375558, 4833.589144922686, 4841.7337046462435, 4854.786303424144, 4855.927161092586, 4866.975665121652, 3451.8446669899913, 3460.1349662584353, 3461.567304086989, 3463.5670541182353, 3467.763292676235, 5002.7248501332415, 5038.697678139287, 5046.318746969149, 5087.8982420351385, 5096.923546146773, 3464.272502774395, 3520.559930008749, 3535.133892196377, 3564.679178873862, 3574.1422058706244, 3604.5494313210847, 3604.6395360463744, 3607.7192596628342, 3618.5115009473384, 3628.2017956049626, 4117.649999750055, 4126.484189476316, 4128.772917489507, 4140.275451795984, 4140.399642051885, 4654.627629789608, 4894.916202792218, 4908.239222920453, 4916.926246106311, 4919.409670839451, 1229.4528934624007, 1253.2793643654934, 1254.3038613569556, 1258.5720854909375, 1262.5391732017747, 787.8778789287669, 801.3268854162532, 808.8139727862624, 808.9838203235902, 809.4940662086196, 4275.5296917339065, 4403.185410699031, 4429.357743127229, 4429.734215947054, 4434.314960315124, 5016.147254966664, 5017.37282839645, 5033.7734801934, 5035.446100928895, 5041.521055499722, 4415.2935530315, 4423.270160423558, 4423.447069116361, 4432.224360736923, 4442.9777851111185, 2529.6711427514306, 2632.605109233592, 2646.7617914387797, 2647.907323243677, 2651.668541432321, 4813.326134341195, 4841.668541151141, 4875.878103047452, 4884.5603895649565, 4885.387822018725, 5004.674696144739, 5129.897402051938, 5170.819021334235, 5171.560417364491, 5182.32629758129, 4796.304535842353, 4815.446223684321, 4879.53644403774, 4882.8779280517565, 4883.0, 5035.571976382049, 5036.345275114211, 5036.722980236123, 5047.747612619428, 5058.1654027085115, 4724.858254252378, 4946.678465899705, 4992.850214493571, 5000.449950505369, 5013.649044566845, 4783.445380251363, 4832.589229915356, 4844.176489996638, 4853.854384368334, 4858.684185528071, 3569.428891377367, 3570.0, 3586.282743451268, 3597.7514053716427, 3600.2439487707875, 5009.499050094962, 5012.774425150804, 5021.669257646654, 5040.546350828443, 5048.697078175322, 4689.531046895283, 4806.6687656487275, 4859.805607775649, 4873.731944742932, 4888.877778055577, 4837.733924634179, 4852.296417019583, 4859.757012149307, 4860.854174374775, 4874.976884592854, 4764.332993380999, 4780.306855506002, 4797.136515427256, 4813.9037219254715, 4829.9517004830905, 4758.690685105457, 4869.001854619865, 4892.290617860462, 4910.0, 4914.410270767531, 4771.403574553181, 4797.832075877328, 4810.831620893252, 4817.421909370898, 4835.395575553056], "value": 3693.914711611245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.1443033930541, 555.7804667156473, 556.9805056823012, 574.1674571870785, 586.0769288370817, 11499.252548584336, 12783.616491505258, 12895.677608059803, 12898.806517902216, 12920.224786512805, 11134.38760868152, 11228.0, 11245.493952772125, 11281.010532208971, 12034.03727701784, 559.6138664321616, 572.1503567202722, 572.3418069220388, 572.7880684146871, 573.0401577357909, 477.88530752619295, 546.7676237599024, 556.6743455078764, 559.1305519916529, 563.3605857351914, 583.3320847629461, 584.75732570983, 585.7071464267866, 586.2232541882003, 586.4956137721556, 578.8234588450521, 578.9565782566282, 579.2672269578986, 579.568221674855, 579.8289504596133, 363.4185303514382, 417.1365273883063, 418.99371509427385, 419.61395516125236, 419.89292730353867, 10548.947255263674, 10599.788004239948, 10713.83929241062, 10782.892171078345, 10833.566657333697, 11106.333619982826, 11511.942440287829, 11591.304521728724, 11713.414329283502, 12072.396380180955, 10849.077828384598, 10854.782904341948, 10886.455677216187, 10986.01125898673, 11139.498722557424, 3837.347650899326, 3890.720207771457, 3950.3876899080688, 3987.641112299878, 4056.0671045659665, 62859.68570157166, 62925.68537157331, 63043.36956630421, 63077.0, 63296.68351658258, 9227.123423274777, 9273.072692730673, 9341.626334946663, 9391.718248452557, 9685.612575496902, 16698.58253543671, 16740.58148546296, 16747.162641867857, 16763.0, 16808.74786878198, 6365.8726825464155, 6408.1669382980845, 6416.422521973045, 6425.0, 6631.33686631333, 3560.501529785832, 3625.7099432045375, 3630.183208778004, 3687.1519550503, 3756.3426400379826, 2552.9106481273066, 2636.1300770745606, 2656.242970753326, 2660.2950218192195, 2664.10752397945, 431.91145815108456, 432.6076795321875, 435.7755755785773, 436.14515549522656, 439.3695047606695, 389.21573030343313, 456.49129626583795, 478.77497576139854, 485.7110019538369, 495.13351634639383, 7436.59098749574, 7581.241875812375, 7665.616719164131, 7676.961615191888, 7773.484170586795, 427.8224536817186, 468.18535747798586, 469.08996546699296, 517.1312195511501, 520.8333333333297, 3547.113221694576, 3621.3843646580144, 3654.057291146842, 3749.1939233065023, 3751.1372384351207, 58456.41543584595, 60278.397216028156, 60559.39440605626, 60755.0, 60805.69597151986, 89306.0, 92217.0, 92348.53825730829, 93526.0, 97739.51130244303, 80038.59980700059, 83897.58051209705, 84689.0, 85665.14334856697, 85698.00113991961, 6977.372036516738, 7097.503174777716, 7309.707611695472, 7439.479236453396, 7469.14104877946, 35229.64770352366, 42292.78853605712, 42453.787731061144, 44441.555584445035, 46447.53552464432, 39621.207575847744, 40127.0, 40141.79929100336, 52020.0, 59594.40405595888, 8535.146485351415, 8580.528070956158, 8706.129387061243, 8726.0, 9105.817883642423, 9942.353747006422, 10063.748406289902, 10090.798184036132, 10340.172786176938, 10449.58201671955, 9492.453499468078, 9517.095875891779, 9523.571439285388, 9547.140757331874, 9653.1794797443, 9306.48814315192, 9438.622455101719, 9471.857922131036, 9539.379940303857, 9653.082957119062, 8478.152184781473, 8699.826003480022, 8882.467051976902, 8907.376483646083, 9098.317626178195, 7857.4499785014505, 8087.150849160988, 8286.129956354736, 8300.377471689526, 8378.706745263886, 8183.386246031452, 8245.0, 9477.95261023718, 9932.503374831085, 9933.801323973335], "value": 5637.300657974927, "unit": "score"}], "name": "dromaeo_css", "value": 5920.544909851821, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 113.0, 116.0, 114.0, 116.0, 120.0, 116.0, 115.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 123.0, 146.0, 192.0, 126.0, 155.0, 154.0, 124.0, 189.0, 122.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 160.0, 164.0, 162.0, 161.0, 163.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 186.0, 76.0, 76.0, 76.0, 108.0, 112.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 147.0, 86.0, 86.0, 88.0, 143.0, 86.0, 85.0, 156.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 66.0, 65.0, 66.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 67.0, 67.0, 66.0, 67.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 83.0, 82.0, 82.0, 82.0, 82.0, 83.0, 82.0, 85.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 132.0, 132.0, 134.0, 132.0, 131.0, 144.0, 153.0, 141.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 175.0, 177.0, 172.0, 173.0, 177.0, 176.0, 176.0, 175.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 73.0, 70.0, 68.0, 72.0, 70.0, 73.0, 68.0, 69.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1577.1000000000001, "alertThreshold": 2.0}]} 07:46:33 INFO - Return code: 0 07:46:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:46:33 INFO - # TBPL SUCCESS # 07:46:33 INFO - Running post-action listener: _resource_record_post_action 07:46:33 INFO - [mozharness: 2016-08-22 14:46:33.242858Z] Finished run-tests step (success) 07:46:33 INFO - Running post-run listener: _resource_record_post_run 07:46:33 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 2187264; Write bytes: 425594880; Read time: 760; Write time: 301192 07:46:33 INFO - TinderboxPrint: CPU usage
13.2% 07:46:33 INFO - TinderboxPrint: I/O read bytes / time
2,187,264 / 760 07:46:33 INFO - TinderboxPrint: I/O write bytes / time
425,594,880 / 301,192 07:46:33 INFO - TinderboxPrint: CPU idle
8,313.1 (86.7%) 07:46:33 INFO - TinderboxPrint: CPU user
1,205.0 (12.6%) 07:46:33 INFO - TinderboxPrint: Swap in / out
0 / 0 07:46:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 130125824; Read time: 0; Write time: 103980 07:46:33 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 2183168; Write bytes: 294617088; Read time: 744; Write time: 197188 07:46:33 INFO - Running post-run listener: _upload_blobber_files 07:46:33 INFO - Blob upload gear active. 07:46:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:46:33 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 07:46:33 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'] 07:46:33 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 07:46:34 INFO - (blobuploader) - INFO - Open directory for files ... 07:46:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:46:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:46:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:46:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:46:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:46:38 INFO - (blobuploader) - INFO - Done attempting. 07:46:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:46:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:46:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:46:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:46:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:46:39 INFO - (blobuploader) - INFO - Done attempting. 07:46:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:46:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:46:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:46:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:46:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:46:39 INFO - (blobuploader) - INFO - Done attempting. 07:46:39 INFO - (blobuploader) - INFO - Iteration through files over. 07:46:39 INFO - Return code: 0 07:46:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:46:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:46:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f4f77a11507635855f0e2bd8e507da689ae2858a86c8c3a00c295d9c2248b02f59876d2ffd3c29228b6e4f18e9878e35f4ced41822ae853f09c62d502a32c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb7c4ed4b3278c7058f2785ac2c18b132bd9a4d429f06b1d68378aeaae5a5d91942d7f175586fe8dec456915f5c2d6c70f8f94de23c971d9fa2422300812083c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e53596a93e477aed4cdb7a8d3ef49f9cc3546008b1a9d89a815470050c1511fa804b48fb3f414f7d2c5836dd596eb2030e79be557a7c0086b7ed69e3f621a9d"} 07:46:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:46:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:46:39 INFO - Contents: 07:46:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f4f77a11507635855f0e2bd8e507da689ae2858a86c8c3a00c295d9c2248b02f59876d2ffd3c29228b6e4f18e9878e35f4ced41822ae853f09c62d502a32c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb7c4ed4b3278c7058f2785ac2c18b132bd9a4d429f06b1d68378aeaae5a5d91942d7f175586fe8dec456915f5c2d6c70f8f94de23c971d9fa2422300812083c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e53596a93e477aed4cdb7a8d3ef49f9cc3546008b1a9d89a815470050c1511fa804b48fb3f414f7d2c5836dd596eb2030e79be557a7c0086b7ed69e3f621a9d"} 07:46:39 INFO - Running post-run listener: copy_logs_to_upload_dir 07:46:39 INFO - Copying logs to upload dir... 07:46:39 INFO - mkdir: /builds/slave/test/build/upload/logs 07:46:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.748185 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-22 07:46:38.912669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 07:46:38.916496) ========= 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=32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f4f77a11507635855f0e2bd8e507da689ae2858a86c8c3a00c295d9c2248b02f59876d2ffd3c29228b6e4f18e9878e35f4ced41822ae853f09c62d502a32c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb7c4ed4b3278c7058f2785ac2c18b132bd9a4d429f06b1d68378aeaae5a5d91942d7f175586fe8dec456915f5c2d6c70f8f94de23c971d9fa2422300812083c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e53596a93e477aed4cdb7a8d3ef49f9cc3546008b1a9d89a815470050c1511fa804b48fb3f414f7d2c5836dd596eb2030e79be557a7c0086b7ed69e3f621a9d"} build_url:https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/PjdXQIJVRXahSuRhG7LdQA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f4f77a11507635855f0e2bd8e507da689ae2858a86c8c3a00c295d9c2248b02f59876d2ffd3c29228b6e4f18e9878e35f4ced41822ae853f09c62d502a32c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb7c4ed4b3278c7058f2785ac2c18b132bd9a4d429f06b1d68378aeaae5a5d91942d7f175586fe8dec456915f5c2d6c70f8f94de23c971d9fa2422300812083c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e53596a93e477aed4cdb7a8d3ef49f9cc3546008b1a9d89a815470050c1511fa804b48fb3f414f7d2c5836dd596eb2030e79be557a7c0086b7ed69e3f621a9d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 07:46:38.943033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:46:38.943394) ========= 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=32c5991c409366f7fec8a718000001d2-1471874425.254155-1223790074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 07:46:39.027057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 07:46:39.027397) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 07:46:39.027726) ========= ========= Total master_lag: 0.24 =========