builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1483747618.54 results: success (0) revision: f9c041db5cc4182e4750d9f79ec21dc27ca8dfd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:58.543368) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:58.543813) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:58.544099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:58.558447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:58.558736) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-06 16:06:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2017-01-06 16:06:59 (43.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142147 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:58.714485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:58.714814) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:58.764906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:58.765257) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev f9c041db5cc4182e4750d9f79ec21dc27ca8dfd2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev f9c041db5cc4182e4750d9f79ec21dc27ca8dfd2 --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=74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-06 16:06:59,228 truncating revision to first 12 chars 2017-01-06 16:06:59,228 Setting DEBUG logging. 2017-01-06 16:06:59,228 attempt 1/10 2017-01-06 16:06:59,229 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/f9c041db5cc4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 16:06:59,829 unpacking tar archive at: graphics-f9c041db5cc4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.897590 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:59.676167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:59.676511) ========= script_repo_revision: f9c041db5cc4182e4750d9f79ec21dc27ca8dfd2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:59.676892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:59.677175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 16:06:59.688150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-01-06 16:06:59.688546) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:07:00 INFO - MultiFileLogger online at 20170106 16:07:00 in /builds/slave/test 16:07:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 16:07:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:07:00 INFO - {'append_to_log': False, 16:07:00 INFO - 'base_work_dir': '/builds/slave/test', 16:07:00 INFO - 'blob_upload_branch': 'Graphics', 16:07:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:07:00 INFO - 'branch': 'Graphics', 16:07:00 INFO - 'buildbot_json_path': 'buildprops.json', 16:07:00 INFO - 'config_files': ('talos/linux_config.py',), 16:07:00 INFO - 'default_actions': ('clobber', 16:07:00 INFO - 'read-buildbot-config', 16:07:00 INFO - 'download-and-extract', 16:07:00 INFO - 'populate-webroot', 16:07:00 INFO - 'create-virtualenv', 16:07:00 INFO - 'install', 16:07:00 INFO - 'run-tests'), 16:07:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:07:00 INFO - 'download_minidump_stackwalk': True, 16:07:00 INFO - 'download_symbols': 'ondemand', 16:07:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:07:00 INFO - 'tooltool.py': '/tools/tooltool.py', 16:07:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:07:00 INFO - '/tools/misc-python/virtualenv.py')}, 16:07:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:07:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:07:00 INFO - 'installer_path': 'installer.exe', 16:07:00 INFO - 'log_level': 'info', 16:07:00 INFO - 'log_name': 'talos', 16:07:00 INFO - 'log_to_console': True, 16:07:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:07:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:07:00 INFO - 'opt_config_files': (), 16:07:00 INFO - 'pip_index': False, 16:07:00 INFO - 'sps_profile': False, 16:07:00 INFO - 'sps_profile_interval': 0, 16:07:00 INFO - 'suite': 'dromaeojs-e10s', 16:07:00 INFO - 'system_bits': '32', 16:07:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:07:00 INFO - 'title': 'talos-linux64-ix-042', 16:07:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:07:00 INFO - 'use_talos_json': True, 16:07:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:07:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:07:00 INFO - 'work_dir': 'build'} 16:07:00 INFO - [mozharness: 2017-01-07 00:07:00.255147Z] Running clobber step. 16:07:00 INFO - Running pre-action listener: _resource_record_pre_action 16:07:00 INFO - Running main action method: clobber 16:07:00 INFO - rmtree: /builds/slave/test/build 16:07:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:07:00 INFO - Running post-action listener: _resource_record_post_action 16:07:00 INFO - [mozharness: 2017-01-07 00:07:00.718400Z] Finished clobber step (success) 16:07:00 INFO - [mozharness: 2017-01-07 00:07:00.718503Z] Running read-buildbot-config step. 16:07:00 INFO - Running pre-action listener: _resource_record_pre_action 16:07:00 INFO - Running main action method: read_buildbot_config 16:07:00 INFO - Using buildbot properties: 16:07:00 INFO - { 16:07:00 INFO - "project": "", 16:07:00 INFO - "product": "firefox", 16:07:00 INFO - "who": "kgupta@mozilla.com", 16:07:00 INFO - "installer_path": "public/build/target.tar.bz2", 16:07:00 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 16:07:00 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 16:07:00 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 16:07:00 INFO - "stage_platform": "linux64", 16:07:00 INFO - "basedir": "/builds/slave/test", 16:07:00 INFO - "buildnumber": 27, 16:07:00 INFO - "platform": "ubuntu64_hw", 16:07:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:07:00 INFO - "slavebuilddir": "test", 16:07:00 INFO - "taskId": "Jd_p-zVJQyidG1BVb5K5mg", 16:07:00 INFO - "branch": "graphics", 16:07:00 INFO - "script_repo_revision": "default", 16:07:00 INFO - "revision": "f9c041db5cc4182e4750d9f79ec21dc27ca8dfd2", 16:07:00 INFO - "slavename": "talos-linux64-ix-042", 16:07:00 INFO - "repo_path": "projects/graphics" 16:07:00 INFO - } 16:07:00 INFO - Finding installer, test and symbols from parent task. 16:07:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jd_p-zVJQyidG1BVb5K5mg'}, attempt #1 16:07:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jd_p-zVJQyidG1BVb5K5mg'}, attempt #1 16:07:01 INFO - Task dependencies: chkP8OQcSr2zftSlHmkJtA 16:07:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA'}, attempt #1 16:07:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.tar.bz2 16:07:02 INFO - Set test_url: https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/test_packages.json 16:07:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.crashreporter-symbols.zip 16:07:02 INFO - Running post-action listener: _resource_record_post_action 16:07:02 INFO - [mozharness: 2017-01-07 00:07:02.150611Z] Finished read-buildbot-config step (success) 16:07:02 INFO - [mozharness: 2017-01-07 00:07:02.150829Z] Running download-and-extract step. 16:07:02 INFO - Running pre-action listener: _resource_record_pre_action 16:07:02 INFO - Running main action method: download_and_extract 16:07:02 INFO - mkdir: /builds/slave/test/build/tests 16:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:02 INFO - trying https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.test_packages.json 16:07:02 INFO - Downloading https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:07:02 INFO - Downloaded 896 bytes. 16:07:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:07:02 INFO - Using the following test package requirements: 16:07:02 INFO - {u'common': [u'target.common.tests.zip'], 16:07:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:07:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:07:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:07:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:07:02 INFO - u'mozbase': [u'target.common.tests.zip'], 16:07:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:07:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:07:02 INFO - u'web-platform': [u'target.common.tests.zip', 16:07:02 INFO - u'target.web-platform.tests.zip'], 16:07:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:07:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:07:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.common.tests.zip 16:07:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:07:02 INFO - Fetch https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.common.tests.zip into memory 16:07:03 INFO - Expected file size: 20246889 16:07:03 INFO - Obtained file size: 20246889 16:07:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:07:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.common.tests.zip 16:07:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:07:07 INFO - Fetch https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.common.tests.zip into memory 16:07:08 INFO - Expected file size: 20246889 16:07:08 INFO - Obtained file size: 20246889 16:07:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.talos.tests.zip 16:07:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:07:12 INFO - Fetch https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.talos.tests.zip into memory 16:07:13 INFO - Expected file size: 14403730 16:07:13 INFO - Obtained file size: 14403730 16:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:13 INFO - trying https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.tar.bz2 16:07:13 INFO - Downloading https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:07:14 INFO - Downloaded 55981693 bytes. 16:07:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.tar.bz2 16:07:14 INFO - mkdir: /builds/slave/test/properties 16:07:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:07:14 INFO - Writing to file /builds/slave/test/properties/build_url 16:07:14 INFO - Contents: 16:07:14 INFO - build_url:https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.tar.bz2 16:07:14 INFO - Running post-action listener: _resource_record_post_action 16:07:14 INFO - Running post-action listener: set_extra_try_arguments 16:07:14 INFO - [mozharness: 2017-01-07 00:07:14.750891Z] Finished download-and-extract step (success) 16:07:14 INFO - [mozharness: 2017-01-07 00:07:14.750988Z] Running populate-webroot step. 16:07:14 INFO - Running pre-action listener: _resource_record_pre_action 16:07:14 INFO - Running main action method: populate_webroot 16:07:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:07:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:07:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:07:14 INFO - '--tppagecycles', 16:07:14 INFO - '7'], 16:07:14 INFO - 'tests': ['tsvgm']}}, 16:07:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:07:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:07:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:07:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:07:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:07:14 INFO - 'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:07:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:07:14 INFO - 'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['damp', 'tps']}, 16:07:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:07:14 INFO - 'tests': ['damp', 'tps']}, 16:07:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['dromaeo_dom']}, 16:07:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:07:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['basic_compositor_video']}, 16:07:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:07:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['a11yr', 16:07:14 INFO - 'ts_paint', 16:07:14 INFO - 'tpaint', 16:07:14 INFO - 'sessionrestore', 16:07:14 INFO - 'sessionrestore_no_auto_restore', 16:07:14 INFO - 'tabpaint']}, 16:07:14 INFO - 'other-e10s': {'tests': ['a11yr', 16:07:14 INFO - 'ts_paint', 16:07:14 INFO - 'tpaint', 16:07:14 INFO - 'sessionrestore', 16:07:14 INFO - 'sessionrestore_no_auto_restore', 16:07:14 INFO - 'tabpaint']}, 16:07:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:07:14 INFO - 'ts_paint', 16:07:14 INFO - 'tpaint', 16:07:14 INFO - 'sessionrestore', 16:07:14 INFO - 'sessionrestore_no_auto_restore', 16:07:14 INFO - 'tabpaint']}, 16:07:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:07:14 INFO - 'ts_paint', 16:07:14 INFO - 'tpaint', 16:07:14 INFO - 'sessionrestore', 16:07:14 INFO - 'sessionrestore_no_auto_restore', 16:07:14 INFO - 'tabpaint']}, 16:07:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['a11yr', 16:07:14 INFO - 'ts_paint', 16:07:14 INFO - 'tpaint', 16:07:14 INFO - 'sessionrestore', 16:07:14 INFO - 'sessionrestore_no_auto_restore', 16:07:14 INFO - 'tabpaint']}, 16:07:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['a11yr', 16:07:14 INFO - 'ts_paint', 16:07:14 INFO - 'tpaint', 16:07:14 INFO - 'sessionrestore', 16:07:14 INFO - 'sessionrestore_no_auto_restore', 16:07:14 INFO - 'tabpaint']}, 16:07:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['tsvgx', 16:07:14 INFO - 'tsvgr_opacity', 16:07:14 INFO - 'tart', 16:07:14 INFO - 'tscrollx', 16:07:14 INFO - 'cart', 16:07:14 INFO - 'tsvg_static']}, 16:07:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:07:14 INFO - 'tsvgr_opacity', 16:07:14 INFO - 'tart', 16:07:14 INFO - 'tscrollx', 16:07:14 INFO - 'cart', 16:07:14 INFO - 'tsvg_static']}, 16:07:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:07:14 INFO - 'talos_options': ['--disable-e10s'], 16:07:14 INFO - 'tests': ['tp5o']}, 16:07:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:07:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:07:14 INFO - 'talos_options': ['--disable-e10s', 16:07:14 INFO - '--xperf_path', 16:07:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:14 INFO - 'tests': ['tp5n']}, 16:07:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:07:14 INFO - 'talos_options': ['--xperf_path', 16:07:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:14 INFO - 'tests': ['tp5n']}}, 16:07:14 INFO - 'talos.zip': {'path': '', 16:07:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:07:14 INFO - Running post-action listener: _resource_record_post_action 16:07:14 INFO - [mozharness: 2017-01-07 00:07:14.764135Z] Finished populate-webroot step (success) 16:07:14 INFO - [mozharness: 2017-01-07 00:07:14.764229Z] Running create-virtualenv step. 16:07:14 INFO - Running pre-action listener: _resource_record_pre_action 16:07:14 INFO - Running main action method: create_virtualenv 16:07:14 INFO - Creating virtualenv /builds/slave/test/build/venv 16:07:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:07:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:07:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:07:14 INFO - Using real prefix '/usr' 16:07:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:07:15 INFO - Installing distribute.............................................................................................................................................................................................done. 16:07:17 INFO - Installing pip.................done. 16:07:17 INFO - Return code: 0 16:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:07:17 INFO - Reading from file tmpfile_stdout 16:07:17 INFO - Output received: 16:07:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:07:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07: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', 'pip>=1.5'] in /builds/slave/test/build 16:07: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 pip>=1.5 16:07:17 INFO - Using env: {'DISPLAY': ':0', 16:07:17 INFO - 'HOME': '/home/cltbld', 16:07:17 INFO - 'LANG': 'en_US.UTF-8', 16:07:17 INFO - 'LANGUAGE': 'en_US:en', 16:07:17 INFO - 'LOGNAME': 'cltbld', 16:07:17 INFO - 'MAIL': '/var/mail/cltbld', 16:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:17 INFO - 'MOZ_NO_REMOTE': '1', 16:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:17 INFO - 'NO_EM_RESTART': '1', 16:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:17 INFO - 'PWD': '/builds/slave/test', 16:07:17 INFO - 'SHELL': '/bin/bash', 16:07:17 INFO - 'SHLVL': '1', 16:07:17 INFO - 'TERM': 'linux', 16:07:17 INFO - 'TMOUT': '86400', 16:07:17 INFO - 'USER': 'cltbld', 16:07:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:17 INFO - '_': '/tools/buildbot/bin/python'} 16:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:07:17 INFO - Cleaning up... 16:07:17 INFO - Return code: 0 16:07:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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', '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 0x224f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:07: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 psutil>=3.1.1 16:07:17 INFO - Using env: {'DISPLAY': ':0', 16:07:17 INFO - 'HOME': '/home/cltbld', 16:07:17 INFO - 'LANG': 'en_US.UTF-8', 16:07:17 INFO - 'LANGUAGE': 'en_US:en', 16:07:17 INFO - 'LOGNAME': 'cltbld', 16:07:17 INFO - 'MAIL': '/var/mail/cltbld', 16:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:17 INFO - 'MOZ_NO_REMOTE': '1', 16:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:17 INFO - 'NO_EM_RESTART': '1', 16:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:17 INFO - 'PWD': '/builds/slave/test', 16:07:17 INFO - 'SHELL': '/bin/bash', 16:07:17 INFO - 'SHLVL': '1', 16:07:17 INFO - 'TERM': 'linux', 16:07:17 INFO - 'TMOUT': '86400', 16:07:17 INFO - 'USER': 'cltbld', 16:07:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:17 INFO - '_': '/tools/buildbot/bin/python'} 16:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:17 INFO - Downloading/unpacking psutil>=3.1.1 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:07:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:20 INFO - Installing collected packages: psutil 16:07:20 INFO - Running setup.py install for psutil 16:07:20 INFO - building 'psutil._psutil_linux' extension 16:07:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:07:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:07:20 INFO - building 'psutil._psutil_posix' extension 16:07:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:07:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:07:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:20 INFO - Successfully installed psutil 16:07:20 INFO - Cleaning up... 16:07:20 INFO - Return code: 0 16:07:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:07: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 mozsystemmonitor==0.3 16:07:20 INFO - Using env: {'DISPLAY': ':0', 16:07:20 INFO - 'HOME': '/home/cltbld', 16:07:20 INFO - 'LANG': 'en_US.UTF-8', 16:07:20 INFO - 'LANGUAGE': 'en_US:en', 16:07:20 INFO - 'LOGNAME': 'cltbld', 16:07:20 INFO - 'MAIL': '/var/mail/cltbld', 16:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:20 INFO - 'MOZ_NO_REMOTE': '1', 16:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:20 INFO - 'NO_EM_RESTART': '1', 16:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:20 INFO - 'PWD': '/builds/slave/test', 16:07:20 INFO - 'SHELL': '/bin/bash', 16:07:20 INFO - 'SHLVL': '1', 16:07:20 INFO - 'TERM': 'linux', 16:07:20 INFO - 'TMOUT': '86400', 16:07:20 INFO - 'USER': 'cltbld', 16:07:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:20 INFO - '_': '/tools/buildbot/bin/python'} 16:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:07:22 INFO - Installing collected packages: mozsystemmonitor 16:07:22 INFO - Running setup.py install for mozsystemmonitor 16:07:23 INFO - Successfully installed mozsystemmonitor 16:07:23 INFO - Cleaning up... 16:07:23 INFO - Return code: 0 16:07:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:23 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 0x224f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:07:23 INFO - Using env: {'DISPLAY': ':0', 16:07:23 INFO - 'HOME': '/home/cltbld', 16:07:23 INFO - 'LANG': 'en_US.UTF-8', 16:07:23 INFO - 'LANGUAGE': 'en_US:en', 16:07:23 INFO - 'LOGNAME': 'cltbld', 16:07:23 INFO - 'MAIL': '/var/mail/cltbld', 16:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:23 INFO - 'MOZ_NO_REMOTE': '1', 16:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:23 INFO - 'NO_EM_RESTART': '1', 16:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:23 INFO - 'PWD': '/builds/slave/test', 16:07:23 INFO - 'SHELL': '/bin/bash', 16:07:23 INFO - 'SHLVL': '1', 16:07:23 INFO - 'TERM': 'linux', 16:07:23 INFO - 'TMOUT': '86400', 16:07:23 INFO - 'USER': 'cltbld', 16:07:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:23 INFO - '_': '/tools/buildbot/bin/python'} 16:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:23 INFO - Downloading/unpacking jsonschema==2.5.1 16:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:07:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:25 INFO - Downloading functools32-3.2.3-2.tar.gz 16:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:07:25 INFO - warning: no files found matching '*.txt' 16:07:25 INFO - no previously-included directories found matching 'build' 16:07:25 INFO - no previously-included directories found matching 'dist' 16:07:25 INFO - no previously-included directories found matching '.git*' 16:07:25 INFO - Installing collected packages: jsonschema, functools32 16:07:25 INFO - Running setup.py install for functools32 16:07:25 INFO - warning: no files found matching '*.txt' 16:07:25 INFO - no previously-included directories found matching 'build' 16:07:25 INFO - no previously-included directories found matching 'dist' 16:07:25 INFO - no previously-included directories found matching '.git*' 16:07:25 INFO - Successfully installed jsonschema functools32 16:07:25 INFO - Cleaning up... 16:07:25 INFO - Return code: 0 16:07:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:25 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 0x224f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:07:25 INFO - Using env: {'DISPLAY': ':0', 16:07:25 INFO - 'HOME': '/home/cltbld', 16:07:25 INFO - 'LANG': 'en_US.UTF-8', 16:07:25 INFO - 'LANGUAGE': 'en_US:en', 16:07:25 INFO - 'LOGNAME': 'cltbld', 16:07:25 INFO - 'MAIL': '/var/mail/cltbld', 16:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:25 INFO - 'MOZ_NO_REMOTE': '1', 16:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:25 INFO - 'NO_EM_RESTART': '1', 16:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:25 INFO - 'PWD': '/builds/slave/test', 16:07:25 INFO - 'SHELL': '/bin/bash', 16:07:25 INFO - 'SHLVL': '1', 16:07:25 INFO - 'TERM': 'linux', 16:07:25 INFO - 'TMOUT': '86400', 16:07:25 INFO - 'USER': 'cltbld', 16:07:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:25 INFO - '_': '/tools/buildbot/bin/python'} 16:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:07:26 INFO - Cleaning up... 16:07:26 INFO - Return code: 0 16:07:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:26 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 0x224f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:07:26 INFO - Using env: {'DISPLAY': ':0', 16:07:26 INFO - 'HOME': '/home/cltbld', 16:07:26 INFO - 'LANG': 'en_US.UTF-8', 16:07:26 INFO - 'LANGUAGE': 'en_US:en', 16:07:26 INFO - 'LOGNAME': 'cltbld', 16:07:26 INFO - 'MAIL': '/var/mail/cltbld', 16:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:26 INFO - 'MOZ_NO_REMOTE': '1', 16:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:26 INFO - 'NO_EM_RESTART': '1', 16:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:26 INFO - 'PWD': '/builds/slave/test', 16:07:26 INFO - 'SHELL': '/bin/bash', 16:07:26 INFO - 'SHLVL': '1', 16:07:26 INFO - 'TERM': 'linux', 16:07:26 INFO - 'TMOUT': '86400', 16:07:26 INFO - 'USER': 'cltbld', 16:07:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:26 INFO - '_': '/tools/buildbot/bin/python'} 16:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:26 INFO - Downloading/unpacking blobuploader==1.2.4 16:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:28 INFO - Downloading blobuploader-1.2.4.tar.gz 16:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:07:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:07:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07:28 INFO - Downloading docopt-0.6.1.tar.gz 16:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:07:29 INFO - Installing collected packages: blobuploader, requests, docopt 16:07:29 INFO - Running setup.py install for blobuploader 16:07:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:07:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:07:29 INFO - Running setup.py install for requests 16:07:29 INFO - Running setup.py install for docopt 16:07:29 INFO - Successfully installed blobuploader requests docopt 16:07:29 INFO - Cleaning up... 16:07:29 INFO - Return code: 0 16:07:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:29 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 0x224f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:07:29 INFO - Using env: {'DISPLAY': ':0', 16:07:29 INFO - 'HOME': '/home/cltbld', 16:07:29 INFO - 'LANG': 'en_US.UTF-8', 16:07:29 INFO - 'LANGUAGE': 'en_US:en', 16:07:29 INFO - 'LOGNAME': 'cltbld', 16:07:29 INFO - 'MAIL': '/var/mail/cltbld', 16:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:29 INFO - 'MOZ_NO_REMOTE': '1', 16:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:29 INFO - 'NO_EM_RESTART': '1', 16:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:29 INFO - 'PWD': '/builds/slave/test', 16:07:29 INFO - 'SHELL': '/bin/bash', 16:07:29 INFO - 'SHLVL': '1', 16:07:29 INFO - 'TERM': 'linux', 16:07:29 INFO - 'TMOUT': '86400', 16:07:29 INFO - 'USER': 'cltbld', 16:07:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:29 INFO - '_': '/tools/buildbot/bin/python'} 16:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:29 INFO - Running setup.py (path:/tmp/pip-PYQ1b1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:29 INFO - Running setup.py (path:/tmp/pip-zZWWIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:30 INFO - Running setup.py (path:/tmp/pip-wPgCHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:30 INFO - Running setup.py (path:/tmp/pip-QYMAZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:30 INFO - Running setup.py (path:/tmp/pip-NPM7Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:30 INFO - Running setup.py (path:/tmp/pip-ZskAMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:30 INFO - Running setup.py (path:/tmp/pip-FgPES5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:30 INFO - Running setup.py (path:/tmp/pip-oZZxsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:30 INFO - Running setup.py (path:/tmp/pip-oggizd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:30 INFO - Running setup.py (path:/tmp/pip-ObryAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:30 INFO - Running setup.py (path:/tmp/pip-pAO0hI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:30 INFO - Running setup.py (path:/tmp/pip-WLkJvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:30 INFO - Running setup.py (path:/tmp/pip-_FfSQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:30 INFO - Running setup.py (path:/tmp/pip-dYSWIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:30 INFO - Running setup.py (path:/tmp/pip-kWOhZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:30 INFO - Running setup.py (path:/tmp/pip-aXlflG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:31 INFO - Running setup.py (path:/tmp/pip-0pTKN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:07:31 INFO - Running setup.py install for manifestparser 16:07:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:07:31 INFO - Running setup.py install for mozcrash 16:07:31 INFO - Running setup.py install for mozdebug 16:07:31 INFO - Running setup.py install for mozdevice 16:07:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:07:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:07:31 INFO - Running setup.py install for mozfile 16:07:31 INFO - Running setup.py install for mozhttpd 16:07:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:07:31 INFO - Running setup.py install for mozinfo 16:07:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:07:31 INFO - Running setup.py install for mozInstall 16:07:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:07:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:07:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:07:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:07:31 INFO - Running setup.py install for mozleak 16:07:32 INFO - Running setup.py install for mozlog 16:07:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:07:32 INFO - Running setup.py install for moznetwork 16:07:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:07:32 INFO - Running setup.py install for mozprocess 16:07:32 INFO - Running setup.py install for mozprofile 16:07:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:07:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:07:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:07:32 INFO - Running setup.py install for mozrunner 16:07:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:07:32 INFO - Running setup.py install for mozscreenshot 16:07:32 INFO - Running setup.py install for moztest 16:07:32 INFO - Running setup.py install for mozversion 16:07:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:07:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:07:32 INFO - Cleaning up... 16:07:32 INFO - Return code: 0 16:07:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:32 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 0x224f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:07:32 INFO - Using env: {'DISPLAY': ':0', 16:07:32 INFO - 'HOME': '/home/cltbld', 16:07:32 INFO - 'LANG': 'en_US.UTF-8', 16:07:32 INFO - 'LANGUAGE': 'en_US:en', 16:07:32 INFO - 'LOGNAME': 'cltbld', 16:07:32 INFO - 'MAIL': '/var/mail/cltbld', 16:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:32 INFO - 'MOZ_NO_REMOTE': '1', 16:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:32 INFO - 'NO_EM_RESTART': '1', 16:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:32 INFO - 'PWD': '/builds/slave/test', 16:07:32 INFO - 'SHELL': '/bin/bash', 16:07:32 INFO - 'SHLVL': '1', 16:07:32 INFO - 'TERM': 'linux', 16:07:32 INFO - 'TMOUT': '86400', 16:07:32 INFO - 'USER': 'cltbld', 16:07:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:32 INFO - '_': '/tools/buildbot/bin/python'} 16:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:33 INFO - Running setup.py (path:/tmp/pip-Fnc7Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:33 INFO - Running setup.py (path:/tmp/pip-P4xEOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:33 INFO - Running setup.py (path:/tmp/pip-M7iTAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:33 INFO - Running setup.py (path:/tmp/pip-yhs58P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:33 INFO - Running setup.py (path:/tmp/pip-n98qw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:33 INFO - Running setup.py (path:/tmp/pip-1A0ybP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:33 INFO - Running setup.py (path:/tmp/pip-nqGRVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:33 INFO - Running setup.py (path:/tmp/pip-VZymfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:33 INFO - Running setup.py (path:/tmp/pip-Dt_LcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:33 INFO - Running setup.py (path:/tmp/pip-eFYviD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:33 INFO - Running setup.py (path:/tmp/pip-zx_N93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:33 INFO - Running setup.py (path:/tmp/pip-bbzPu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:34 INFO - Running setup.py (path:/tmp/pip-Mym5Lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:34 INFO - Running setup.py (path:/tmp/pip-hJhha_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:34 INFO - Running setup.py (path:/tmp/pip-MxJcBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:34 INFO - Running setup.py (path:/tmp/pip-wqimKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:34 INFO - Running setup.py (path:/tmp/pip-8XBLHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:07:34 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:07:34 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:07:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:36 INFO - Downloading blessings-1.6.tar.gz 16:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:07:36 INFO - Installing collected packages: blessings 16:07:36 INFO - Running setup.py install for blessings 16:07:36 INFO - Successfully installed blessings 16:07:36 INFO - Cleaning up... 16:07:36 INFO - Return code: 0 16:07:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:07:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:36 INFO - Reading from file tmpfile_stdout 16:07:36 INFO - Current package versions: 16:07:36 INFO - argparse == 1.2.1 16:07:36 INFO - blessings == 1.6 16:07:36 INFO - blobuploader == 1.2.4 16:07:36 INFO - docopt == 0.6.1 16:07:36 INFO - functools32 == 3.2.3-2 16:07:36 INFO - jsonschema == 2.5.1 16:07:36 INFO - manifestparser == 1.1 16:07:36 INFO - mozInstall == 1.12 16:07:36 INFO - mozcrash == 1.0 16:07:36 INFO - mozdebug == 0.1 16:07:36 INFO - mozdevice == 0.49 16:07:36 INFO - mozfile == 1.2 16:07:36 INFO - mozhttpd == 0.7 16:07:36 INFO - mozinfo == 0.9 16:07:36 INFO - mozleak == 0.1 16:07:36 INFO - mozlog == 3.4 16:07:36 INFO - moznetwork == 0.27 16:07:36 INFO - mozprocess == 0.23 16:07:36 INFO - mozprofile == 0.28 16:07:36 INFO - mozrunner == 6.13 16:07:36 INFO - mozscreenshot == 0.1 16:07:36 INFO - mozsystemmonitor == 0.3 16:07:36 INFO - moztest == 0.8 16:07:36 INFO - mozversion == 1.4 16:07:36 INFO - psutil == 3.1.1 16:07:36 INFO - requests == 1.2.3 16:07:36 INFO - wsgiref == 0.1.2 16:07:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:36 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 0x224f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:07:36 INFO - Using env: {'DISPLAY': ':0', 16:07:36 INFO - 'HOME': '/home/cltbld', 16:07:36 INFO - 'LANG': 'en_US.UTF-8', 16:07:36 INFO - 'LANGUAGE': 'en_US:en', 16:07:36 INFO - 'LOGNAME': 'cltbld', 16:07:36 INFO - 'MAIL': '/var/mail/cltbld', 16:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:36 INFO - 'MOZ_NO_REMOTE': '1', 16:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:36 INFO - 'NO_EM_RESTART': '1', 16:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:36 INFO - 'PWD': '/builds/slave/test', 16:07:36 INFO - 'SHELL': '/bin/bash', 16:07:36 INFO - 'SHLVL': '1', 16:07:36 INFO - 'TERM': 'linux', 16:07:36 INFO - 'TMOUT': '86400', 16:07:36 INFO - 'USER': 'cltbld', 16:07:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:36 INFO - '_': '/tools/buildbot/bin/python'} 16:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:07:37 INFO - Cleaning up... 16:07:37 INFO - Return code: 0 16:07:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:37 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 0x224f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:07:37 INFO - Using env: {'DISPLAY': ':0', 16:07:37 INFO - 'HOME': '/home/cltbld', 16:07:37 INFO - 'LANG': 'en_US.UTF-8', 16:07:37 INFO - 'LANGUAGE': 'en_US:en', 16:07:37 INFO - 'LOGNAME': 'cltbld', 16:07:37 INFO - 'MAIL': '/var/mail/cltbld', 16:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:37 INFO - 'MOZ_NO_REMOTE': '1', 16:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:37 INFO - 'NO_EM_RESTART': '1', 16:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:37 INFO - 'PWD': '/builds/slave/test', 16:07:37 INFO - 'SHELL': '/bin/bash', 16:07:37 INFO - 'SHLVL': '1', 16:07:37 INFO - 'TERM': 'linux', 16:07:37 INFO - 'TMOUT': '86400', 16:07:37 INFO - 'USER': 'cltbld', 16:07:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:37 INFO - '_': '/tools/buildbot/bin/python'} 16:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:07:37 INFO - Cleaning up... 16:07:37 INFO - Return code: 0 16:07:37 INFO - Running post-action listener: _resource_record_post_action 16:07:37 INFO - Running post-action listener: _start_resource_monitoring 16:07:37 INFO - Starting resource monitoring. 16:07:37 INFO - [mozharness: 2017-01-07 00:07:37.398217Z] Finished create-virtualenv step (success) 16:07:37 INFO - [mozharness: 2017-01-07 00:07:37.398723Z] Running install step. 16:07:37 INFO - Running pre-action listener: _resource_record_pre_action 16:07:37 INFO - Running main action method: install 16:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:37 INFO - Reading from file tmpfile_stdout 16:07:37 INFO - Detecting whether we're running mozinstall >=1.0... 16:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:07:37 INFO - Reading from file tmpfile_stdout 16:07:37 INFO - Output received: 16:07:37 INFO - Usage: mozinstall [options] installer 16:07:37 INFO - Options: 16:07:37 INFO - -h, --help show this help message and exit 16:07:37 INFO - -d DEST, --destination=DEST 16:07:37 INFO - Directory to install application into. [default: 16:07:37 INFO - "/builds/slave/test"] 16:07:37 INFO - --app=APP Application being installed. [default: firefox] 16:07:37 INFO - mkdir: /builds/slave/test/build/application 16:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:07:53 INFO - Reading from file tmpfile_stdout 16:07:53 INFO - Output received: 16:07:53 INFO - /builds/slave/test/build/application/firefox/firefox 16:07:53 INFO - Running post-action listener: _resource_record_post_action 16:07:53 INFO - [mozharness: 2017-01-07 00:07:53.802940Z] Finished install step (success) 16:07:53 INFO - [mozharness: 2017-01-07 00:07:53.803217Z] Running run-tests step. 16:07:53 INFO - Running pre-action listener: _resource_record_pre_action 16:07:53 INFO - Running main action method: run_tests 16:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:07:53 INFO - Python 2.7.3 16:07:53 INFO - Return code: 0 16:07:53 INFO - grabbing minidump binary from tooltool 16:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:53 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 0x25be3f0>, '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 0x25becf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bf1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:07:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:07:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:07:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:07:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:07:53 INFO - Return code: 0 16:07:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:07:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:07:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:07:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:07:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:07:53 INFO - Using env: {'DISPLAY': ':0', 16:07:53 INFO - 'HOME': '/home/cltbld', 16:07:53 INFO - 'LANG': 'en_US.UTF-8', 16:07:53 INFO - 'LANGUAGE': 'en_US:en', 16:07:53 INFO - 'LOGNAME': 'cltbld', 16:07:53 INFO - 'MAIL': '/var/mail/cltbld', 16:07:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:53 INFO - 'MOZ_NO_REMOTE': '1', 16:07:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:53 INFO - 'NO_EM_RESTART': '1', 16:07:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:53 INFO - 'PWD': '/builds/slave/test', 16:07:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:53 INFO - 'SHELL': '/bin/bash', 16:07:53 INFO - 'SHLVL': '1', 16:07:53 INFO - 'TERM': 'linux', 16:07:53 INFO - 'TMOUT': '86400', 16:07:53 INFO - 'USER': 'cltbld', 16:07:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565', 16:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:53 INFO - '_': '/tools/buildbot/bin/python'} 16:07:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:07:54 INFO - mozversion application_buildid: 20170106183636 16:07:54 INFO - mozversion application_changeset: f9c041db5cc4182e4750d9f79ec21dc27ca8dfd2 16:07:54 INFO - mozversion application_display_name: Nightly 16:07:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:07:54 INFO - mozversion application_name: Firefox 16:07:54 INFO - mozversion application_remotingname: firefox 16:07:54 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 16:07:54 INFO - mozversion application_vendor: Mozilla 16:07:54 INFO - mozversion application_version: 53.0a1 16:07:54 INFO - mozversion platform_buildid: 20170106183636 16:07:54 INFO - mozversion platform_changeset: f9c041db5cc4182e4750d9f79ec21dc27ca8dfd2 16:07:54 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 16:07:54 INFO - mozversion platform_version: 53.0a1 16:07:54 INFO - using testdate: 1483747674 16:07:54 INFO - actual date: 1483747674 16:07:54 INFO - starting webserver on 'localhost:49717' 16:07:54 INFO - SUITE-START | Running 2 tests 16:07:54 INFO - TEST-START | dromaeo_css 16:07:54 INFO - operating with platform_type : linux_ 16:07:54 INFO - Initialising browser for dromaeo_css test... 16:07:54 INFO - TEST-INFO | started process 23634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd6MULT/profile http://localhost:49717/getInfo.html) 16:07:54 INFO - PROCESS | 23634 | 1483747674604 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 16:07:58 INFO - PROCESS | 23634 | __metrics Screen width/height:1600/1200 16:07:58 INFO - PROCESS | 23634 | colorDepth:24 16:07:58 INFO - PROCESS | 23634 | Browser inner width/height: 1024/697 16:07:58 INFO - PROCESS | 23634 | __metrics 16:07:59 ERROR - PROCESS | 23634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 16:08:00 INFO - TEST-INFO | 23634: exit 0 16:08:00 INFO - Browser initialized. 16:08:00 INFO - Running cycle 1/1 for dromaeo_css test... 16:08:00 INFO - TEST-INFO | started process 23753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd6MULT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:12 INFO - PROCESS | 23753 | RSS: Main: 159125504 16:08:12 INFO - PROCESS | 23753 | 16:11:15 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:49717/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49717/tests/dromaeo/cssquery-ext.html) 16:11:16 INFO - PROCESS | 23753 | RSS: Main: 166744064 16:11:16 INFO - PROCESS | 23753 | 16:13:00 INFO - PROCESS | 23753 | ************************* 16:13:00 INFO - PROCESS | 23753 | A coding exception was thrown and uncaught in a Task. 16:13:00 INFO - PROCESS | 23753 | 16:13:00 INFO - PROCESS | 23753 | Full message: ReferenceError: fetch is not defined 16:13:00 INFO - PROCESS | 23753 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 16:13:00 INFO - PROCESS | 23753 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 16:13:00 INFO - PROCESS | 23753 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 16:13:00 INFO - PROCESS | 23753 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 16:13:00 INFO - PROCESS | 23753 | TaskImpl@resource://gre/modules/Task.jsm:277:3 16:13:00 INFO - PROCESS | 23753 | asyncFunction@resource://gre/modules/Task.jsm:252:14 16:13:00 INFO - PROCESS | 23753 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 16:13:00 INFO - PROCESS | 23753 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 16:13:00 INFO - PROCESS | 23753 | TaskImpl@resource://gre/modules/Task.jsm:277:3 16:13:00 INFO - PROCESS | 23753 | asyncFunction@resource://gre/modules/Task.jsm:252:14 16:13:00 INFO - PROCESS | 23753 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 16:13:00 INFO - PROCESS | 23753 | 16:13:00 INFO - PROCESS | 23753 | ************************* 16:14:18 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:49717/tests/dromaeo/cssquery-ext.html (next: http://localhost:49717/tests/dromaeo/cssquery-jquery.html) 16:14:19 INFO - PROCESS | 23753 | RSS: Main: 162283520 16:14:19 INFO - PROCESS | 23753 | 16:17:21 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:49717/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49717/tests/dromaeo/cssquery-mootools.html) 16:17:22 INFO - PROCESS | 23753 | RSS: Main: 167456768 16:17:22 INFO - PROCESS | 23753 | 16:20:24 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:49717/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49717/tests/dromaeo/cssquery-prototype.html) 16:20:25 INFO - PROCESS | 23753 | RSS: Main: 163389440 16:20:25 INFO - PROCESS | 23753 | 16:23:28 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:49717/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49717/tests/dromaeo/cssquery-yui.html) 16:23:28 INFO - PROCESS | 23753 | RSS: Main: 166453248 16:23:28 INFO - PROCESS | 23753 | 16:26:31 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:49717/tests/dromaeo/cssquery-yui.html (next: http://localhost:49717/tests/dromaeo/cssquery-dojo.html) 16:26:31 INFO - PROCESS | 23753 | RSS: Main: 166813696 16:26:31 INFO - PROCESS | 23753 | 16:26:31 INFO - PROCESS | 23753 | __start_tp_report 16:26:31 INFO - PROCESS | 23753 | _x_x_mozilla_page_load 16:26:31 INFO - PROCESS | 23753 | _x_x_mozilla_page_load_details 16:26:31 INFO - PROCESS | 23753 | |i|pagename|runs| 16:26:31 INFO - PROCESS | 23753 | |0;dojo.html;2560.2703229579574;2568.216693908358;2572.459783445476;2587.974120258797;2603.0368763557476;4696.154692155411;4708.599769019633;4712.764361781914;4733.502982186872;4737.1946769049255;4632.305154226868;4640.0255946251245;4650.069986002804;4767.5709186173235;4780.80876764929;4329.913401731971;4382.956170438287;4393.428854248959;4473.507914129459;4501.919539310558;4077.2864748668862;4487.775611219442;4500.234960056799;4521.796519156645;4525.208088584501;4280.464941882265;4432.312991486325;4445.622122119624;4462.352958820969;4549.1129229800035;4295.226859165349;4389.253826849444;4443.666724995638;4460.1971645104195;4483.327500874895;4376.6936314458;4394.340848872663;4396.450443694538;4400.845970391021;4417.271150260203;4749.121412538691;4753.33453316536;4754.881127971794;4766.285057241442;4814.470408255089;4960.33035540201;4968.22992436173;4972.328735620717;4979.377577802775;5010.574101201402;5045.293658887758;5052.444231134572;5061.848144555669;5082.542571168576;5110.8466745997675;4726.503717109723;4728.219843725816;4733.077049975291;4763.380760501147;4783.354247176656;5118.820841270612;5136.203888397305;5144.639875208774;5161.303224064778;5163.741812909339;4974.403071631355;5002.274670172805;5007.098722230034;5016.974915125401;5046.1926091825135;5019.422766381913;5051.1413059779925;5053.216751403538;5056.6713163644245;5093.363329583802;4928.67963582366;4975.577075948512;4981.975090124526;5053.69677819332;5082.720450375265;5094.312267843868;5097.464766199496;5100.183970564692;5102.821401250939;5146.047981123429;4352.564743525622;4374.650027997753;4376.6498680105515;4386.978065109654;4422;3731.7014638828828;3744.344739670547;3754.0802503386844;3756.13608869956;3763.9059023524082;4457.77711114443;4464.30803225494;4496.820127194876;4510.030343476168;4520.570545798144;5120.8719782005;5133.101707201225;5133.153029750124;5140.254663073908;5141.074606570778;4367.65058795302;4398.582134697199;4431.667624928144;4478.395416618715;4511.187986162522;4543.318502224693;4570.54294570547;4570.9314360284625;4592.8622141335145;4607.0785842831565;4711.81152753886;4719.551642593948;4742.668013239109;4749.335093086971;4752.738599376929;4902.411710594752;4961;5057.039162559249;5071.746412679425;5121.487851214849;4700.271457924027;4704.247320428715;4723.291506274087;4787.257975013878;4818.915743957581;5001.349824522788;5008.649394542347;5014.247862820606;5031.773570189277;5074.6194035448225;4989.151844186569;5108.69347839116;5112.207607820794;5115.2071428928575;5154.639175257696;4888.828890988798;4893.143699852582;4935.506449355035;4956.752162391938;5037.899242015066;4968.602511798975;4971.328870602567;4973.751312434436;4975.875603109951;5040.294358789845;4754.168020596313;4846.757662116809;4885.316055752127;4934.18585933317;4942.5304596063315;5000.749962501933;5022.096022715946;5051.2423136529815;5104.081265372269;5118.181091025418;4934.654574179773;4935.309056731989;4939.110960027086;4941.728204948762;4969.975150124226 16:26:31 INFO - PROCESS | 23753 | |1;ext.html;523.8219005538116;530.8964751873385;554.498179147871;560.9214709940609;579.5218944370895;34955.65044349556;39194;39202.607973920254;39226.80386598066;39254.607453925455;39284;39674;39736.40395394072;39794.8010259949;39854;7523.586202758833;7750.8449831003345;7755.612219389036;9409;9792.608295668164;9756.268279879003;9822.557984890696;9852.704418867446;9858.950705246463;9863.802723945517;9791.16775074116;9839.508024598741;9840.95079524605;9870.309078364517;9879.259055570861;9774.462404567746;9776.608935642565;9799.804003919882;9801.117899389017;9835.704928852147;9659.275554333453;9690.079442452956;9716.465594392377;9717.271204659608;9726.513674316328;34650.30699385998;35109.29781404357;35139.12152196216;35182.648173518195;35289.117772055906;3581.8746343877838;3642.562892452896;3659.5791483979415;3686.8340924658455;3720.069982504374;25896.48207035849;26507.072252471266;26616.73383266162;26618;26803.597946030826;3375.763696541243;3440.449528075521;3668.0279725872665;3684.470944558005;3698.1124530112847;252045.47954520403;253127;253845;254009;254337;47832.282515762294;48051.5194848047;48186.5181348182;48354.516454835706;48393.516064839605;50909;50978;51004.48995510072;51061.23408148881;51154;13182.209067455791;13315.334233288297;13344.733105338033;13360.13159144672;13390.598282051555;9929.950350248202;10114.595416183418;10479.738006549896;10716.089132423675;10718.14254859625;15882.285297161656;15892.125933073561;15938.203089845461;15943.601409964844;16185.83814161867;6580.736770529125;6582.210134783857;6612.305707900698;6653.933460665428;6799.864002719918;810.0926961802819;821.5440430561096;831.0359982420364;832.8709050097244;854;27271.181864544094;28221.858890705415;28358.149255522367;28458.71541284602;28537.14388568346;956.3353469338742;958.3195930889146;968.840141376665;983.7983213441228;991.9355241909253;13882.583522494342;14866.554003379915;14893;15025.173615451255;15048.172350520608;332602;336341;337233;337282;343622;50510;51022.48977510251;51070.23394649083;51107;51237.48762512327;1165.8134698448207;1182.1901997131993;1199.7240634653904;1209.7399059202137;1245.1408528115753;26002.479950401263;26826.463470730087;26958;27445.176644700692;27605.58591621087;42350.576494234665;42747.14505709806;42764.14471710611;42935.57064429441;43069.138617226854;287324;288048;288267;288633;290252;25866;25905.481890362465;26049.743782027246;26135;26206;41327;41689.58310416857;41773.58226417697;41935.790321048196;42622;35380.292394152486;36019.27961440704;36187.638123618424;36609.816950915076;36867.446988295735;34674;35300.47049294314;35354;35393.82303088468;35493.467597986564;34022;34981.65018349886;35047.299054018265;35062.29875402529;35259.64740352564;30549.23626909345;31634.525482117326;31834.52248216325;31925.840370797996;32050.19874503156;23552.411189720395;24554.754452455247;24613;24863.62704559469;24868.875655621607 16:26:31 INFO - PROCESS | 23753 | |2;jquery.html;380.42365815789066;382.3156549775901;388.8405753641007;398.583480263125;406.1551971898451;16174.999999999985;17739.290428382883;18083.909580452095;18275.45173644791;18759.624807503842;10436.791264174712;10693;10761.30051546649;17135.400260990868;17565;4491.528389519102;4662.696924699892;4803.3995750531185;4806.182948898678;4808.278758186282;4458.933116003246;4716.575508204261;4731.33761273422;4740.976295118519;4741.122892264925;4697.436307643087;4716.127516409458;4732.171869922767;4733.384659994196;4737.455192652855;4723.197056500386;5355.437679043684;5591.8042868499615;5604.971975140139;5702.971485142548;5550.250716153308;5582.330120385539;5588.189712491707;5592.0773072443;5594.328680558359;12377.443015064344;12425.19236249641;12501.93749031249;12542.81185782214;12576.622701318975;2198.604251234777;2199.9560008799895;2201.4716468047714;2217.6562632791943;2241.0475547892243;9033.864492032624;9335.859962100574;9369.76575585609;9712.562934667956;10071.194304455626;1723.9913800431043;1743.9215235314314;1755.1224387806096;1799.478151336111;1806.1330561330635;65737;74771;74866.25133748702;76625.61687191584;78505;10314.174866010851;10421;10523.894761052292;10649;10763.569457221623;14779.187144707144;14794.926025369805;14794.926025369805;14831.629209269855;14898.180600066884;7212.819679508054;7417.814554636069;7549.0563679540055;7689.423293252917;7824.9608751955875;7037.788866334018;7052.576845389191;7252.347288744038;7285.526440781332;7319.121705395387;4251.128518653669;4356.520782713899;4434.711743736647;4509.661775366861;4668.11305851887;1842.309134074722;1876.1088482970479;1894.2801735340483;1902.6480101181048;1922.3944457495843;810.3476701255428;821.6425854753202;832.7876391520124;850.3919697416377;868.4832524647825;17318.220680069426;18157.27370905149;18282.268709251483;18473.5381615458;18533.258669653333;833.4749108062003;839.1189251286125;843.9704610338608;855.8758979947872;863.5250612163285;9677.758056048515;10113.128386983875;10311.329763565343;10351.948240258751;10474.895251047392;499355;523472;524777;526775;558153;97263.51368243113;98393;100833;102396;102987;941.1952780372683;946.1768261612303;972.5526257921435;975.9609615615295;981.1120935553336;16594.50649441556;16824.411145609844;16962.406315778888;17063.82936170672;17144.885582437102;39997.40003899886;40931.38602921018;41456.79271603622;41839.606841281224;42131.57868421276;49481.752591238255;49914.75042624909;57830;58364.07810672111;58783.70608146932;8009.8398032040195;8074.677012919417;8183.138886271955;8248.505089694638;8313.41806073569;11680.299182049104;12044.698882527657;12641.304728240035;13166.01254905905;13630.795538066739;10355.94822025885;10570.365778053341;10687.5190616424;10909.290896091728;10969.23215374916;10220.540075696463;10546.683599492027;10943.233973621771;10998.395088270221;11179.441027948733;10416.791664166523;10754.465263535349;10896.073833724222;11058.391788451712;11590.652280431601;7089.680964356719;7527.360174385239;7604.581748003913;8041.155678653891;8267.214614611603;9217.308701847254;10835.945820271163;10942.23404361687;11203.88796112061;11472.483738231967 16:26:31 INFO - PROCESS | 23753 | |3;mootools.html;1308.7644224039673;1328.780751176056;1338.759023375792;1346.5089584269103;1349.156777014366;6120.755169793203;6288.937110628893;6553;6933.30666933307;6946.895796563049;6507.154069970898;6725.697343619537;6773.322667733224;6895;6895.620740859264;2096.15105882118;2126.5746850629857;2131.8507704460694;2132.402927180392;2133.925312614059;2080.3446914222045;2121.968170477444;2125.4473836802467;2127.957440851182;2218.279059305724;2098.874067555944;2122.883241421729;2124.1397234120204;2125.043730321354;2125.51113243954;2060.6084843879767;2062.051456330075;2070.3995841206033;2072.274703853654;2081.812636862682;2099.0338883758855;2102.075086961732;2112.387407651779;2113.2392338758036;2131.989340053305;6882.931170688279;7010.404115650176;7055;7064.505484616079;7080.256573059857;4213.5786421357925;4324.805383757738;4339.631131353839;4340.175366680352;4342.609165175149;2697.824641398303;2864.5273529867545;2894.3198348388114;2921.3865088331477;2967.4955257606257;1148.0425873885006;1160.425589333277;1187.9881201187964;1190.2560899437851;1244.3778110944527;8684;8719.738407847775;8823.514706691129;8835.955820220857;8838.602262898185;3581.5702115746276;3680.852765889388;3686.562240726119;3788.1855401088897;3794.354959656865;7252.057232559733;7276.854462910712;7276.890846637305;7279.090113735783;7298;4181.498220213533;4189.162167566499;4193.203291374629;4194.224068547267;4202.201581699467;3863.4204869269274;3936.527616685959;4007.73949693269;4011.2378648056774;4016.3172260715164;3067.8619462124257;3137.8117312961294;3198.792078514889;3199.744020478356;3203.759718021158;895.4314010603314;934.1779234273931;979.8089372572423;987.225028352754;1112.2547892911768;837.2883049407955;850.4472093139385;856.1737922904302;865.8484765166197;878.6002368922125;4617.515160908123;4676.228422310281;4743.0988112258565;4764.38063051808;4991.550760431579;873.8470767615769;907.3622112087745;915.4827522449795;917.958691858868;923.1138107416955;3297.835108244626;3421.298633780069;3421.674940880612;3452.7583069184916;3616.9638303617153;7606.467547271638;7965.641546130438;7986.800329991796;7997.6800927963395;8053.952986111768;7463.552186868806;7805.726799561988;7842.921570784333;7983.68065277394;8051.436399451982;6297.464715499143;6411.070394792729;6422;6422.903656445157;6441.967790161019;4572.977135114304;4805.087033463631;4833.564979151894;4913;5143.588512918883;7308.940203670544;7359.889601656087;7427.962860185665;7460.738874139379;7491.812704682208;7001.614911179934;7569.394448444222;7669;7687.231276872268;7690.077190737147;5788.305403351625;6015.518758499397;6021.187139736079;6029.51763858899;6047.395260473917;6350.96824515893;6430.260520040255;6444.7744328948265;6519.967400162969;6547.9672601638595;6057.1519987200945;6075.422834830684;6112.572119951561;6139.201903752483;6149.938500614937;5929.584929055098;5937.614055086406;5969.253843269591;6073.665948372882;6101.420365065312;5402.864928376822;5438.809641662523;5441.483059109379;5465.070937940639;5524;4115.71190016696;4163.812628431789;4257.169851878978;4288.442502474658;4314.288142456459;4063.1670507546473;4105.630493255621;4159.6880233981965;4161.583841615814;4246.681498887534 16:26:31 INFO - PROCESS | 23753 | |4;prototype.html;352.53641461478156;356.44750636513396;356.7306683453992;356.7877113117694;358.9551306086739;5021.673591216573;5060.54455099041;5065.151219804772;5114;5124.538791508769;4990.702417371483;5056.797728090872;5065.366829146356;5082.212257100146;5088.414832294287;3770.679492243149;3863.971415007116;3910.687145028391;3912.2762288976487;4079.7348172368847;3908.335582950891;3909.6285852843935;3916.7454115482547;3918.5101862267215;3926.5877082906313;3885.436611691303;3887.3002859485423;3895.8831235062994;3907.7069219808486;3918.784466854322;3729.2914346274392;3901.1027463683513;3919.412088186766;3923.411488276767;3926.528816542019;3386.305807309496;3399.354122716676;3399.9660003399895;3410.1304167437393;3412.146963259185;4826.589739872115;4932.876678083041;4940.777665005084;4947.851564453073;4984.177610694231;4423.301785910592;4434.68957172998;4449.688521803475;4455.487618923833;4465.486469056068;5042.218456139304;5249.160134378481;5270.762815673265;5291.058161669543;5321.680699158024;3674.7978861162624;3676.3015027145025;3678.6321367863;3685.963140368589;3717.8288839015895;5347.278117454132;5484.945150548483;5492.47821456961;5507.7246137692955;5581.74882130301;3751.868684596026;3754.192848537523;3775.6601905828607;3778.244351129785;3786.9431958520645;3833.463315135883;3852.2295540891932;3859.903502412406;3878.301905657009;3880.5149356330458;4423.270160423494;4439.935430025054;4450.465944086665;4462.7768611569945;4466.798994045275;5182.367554220484;5311.061462566136;5313.57491400687;5357.785688572491;5418.945810541923;1289.278004317585;1289.5164313382481;1292.7395789105547;1296.2157894473896;1307.1438207973792;848.5969164646743;878.885744853165;886.1625763653286;897.0491279244022;902.4089221559889;4495.303227999665;4512.481064677604;4544.363789069533;4568.880624247081;4573.268277075652;5199.2201169824075;5266.3943646480375;5300.708461034603;5319.6808191508635;5341.519263266325;4323.329883868006;4478.753668548261;4479.3057076153245;4523.185826551186;4539.72761634303;2753.5318995770767;2761.9309517262227;2798.7061358557467;2799.972000280012;2814.32456210508;4909.165441874889;4925.359703238628;4930.4747105819515;4942.777575009133;4969.304297398367;5106.565941894906;5358.383785864676;5367.919481207785;5374.479715786167;5453.209284653783;4903.313536104948;4921.188003979303;4930.4961986593;4944.307796908436;4946.925796113062;5290.920636190383;5293.364796224478;5294.8411547652095;5302.496262855023;5309.2301616266195;5084.6440749147205;5176.317696748647;5179.352580927384;5197.54468748751;5256.710880901587;4830.420349558076;4901.975490122527;4911.189653707098;4922.975385123052;4936.827211047596;3737.8131093445763;3789.583145854009;3795.6394142556414;3795.829187686616;3843.5195600549932;5432.755526001419;5487.396386397573;5492.286002819608;5495.395506494362;5498.725063746877;5171.9482805171465;5318.574514038945;5326.760295786777;5328.626996110235;5346.8395948121615;5274.947250527445;5288.360608211467;5297.152455607084;5302.310699609026;5304.124819404755;5213.556847667991;5223.973880130575;5227.372715274191;5235.633505654568;5284.180951952453;5111.79552817898;5246.009774428691;5305.946940530545;5313.256144139901;5319.281896943863;5136.2552429896705;5148.794048238028;5159.162460646554;5161;5188.844334669966 16:26:31 INFO - PROCESS | 23753 | |5;yui.html;601.254444488834;607.1863702638461;637.9138816259805;654.7708302094268;660.597035808157;12906.354682265885;13111.54109606164;13325.267110308929;13526.053176277665;13543;12139.635810925687;12170.756584868297;12199.695007624814;12236.44935977881;12852.742945141092;790.7232468635989;811.3509192645889;822.4571782623469;822.4653974916292;823.2878560045577;795.2008231727107;818.1654712193559;820.7373640435063;822.1942496353577;822.8889099971487;853.9444936079166;856.4689892266772;857.2798848966867;858.5149390594325;860.8665656823171;851.2083762101244;852.1308265569115;855.9229669329728;855.9443636163661;856.6359297298624;627.1658693937098;627.3318915355178;627.645380360095;629.3926361061598;631.5484428633503;12338.444769985372;12353.567625133168;12359.134860559765;12361.258324500559;13244.47022119114;12410.193337433127;13410.061295709304;13466.326683665875;13527.458901643922;13666.18002919818;10335.586576536929;10469.267151299413;10515.474226288656;10662;10733.355998640107;3274.7380209583175;3285.5564498792596;3289.424350738635;3304.2400247943106;3391.355642427931;64430.3556964429;65340;65538;66128.6693566534;66387;10133.290669653054;10159.796804063877;10256.974302569683;10393.9480302598;10465;18800.62398752045;18855.90572047131;19019.42941711751;19097;19193.712094318595;6521.543491955613;6573.244076931119;6577.408033277028;6600.075989361493;6854.794356169323;3428.5200071989943;3596.946045809315;3612.548431446069;3617.330793803155;3621.203335266237;2876.137158852378;2903.5209190483756;2927.575501552263;2933.9413211735646;2938.4270067336665;462.23500107322434;465.1650287733526;467.04722366372897;471.62977063005377;497.99502004979485;578.4764787866987;599.3736545310161;604.1783174882157;614.7110857896781;616.2143267334185;8522.87215691765;8854.513001784964;8902.198802107841;9096.636134554676;9145.268378529834;589.3664310865836;592.7154965616442;605.5851741557047;607.6354187487473;607.957442978996;3807.2956503047026;4032.9395059074136;4039.939400908989;4080.7959602019782;4121.52602450722;57145.42854571484;68896;69738;71966.64016679987;73496.63251683707;61362.38637613567;61610.38389616046;61616;61918.69040654768;65376;52859.735701321246;52970.47029529655;53971;54204.18693719598;54495.45504544983;7517.586532740752;7739.7678069658;7808.726694565663;7967.721129760431;7981.800454988672;33500.49247783807;36230.818845905604;37359.25281494409;38907.41638875363;40255;47182;47751.52248477471;48097.519024809306;48220.27669585029;49100.75449622872;11032;11058.949399807005;11095.611653592085;11216.775664486828;11232.269902456314;11801.645950621494;12193.756124877631;12305.507779689071;12551.686207844878;12924.806127907901;11482.220255860355;11730.88269117298;11952.521899124285;12051.457684404048;12265.938670306949;11200.372684967333;11354.943225283821;11405.087592992706;11906.107041971714;11924.284542927453;11117.16621253393;11171;11486.368249746343;11499.310041397543;11745.882541174478;8675.30597552207;8697.869531957153;9061.864072038792;9165.129312715548;9357.298202634965;8560.529170895661;9039.502827344559;9086.182243598108;9147.313951453802;9268.443893366419 16:26:31 INFO - PROCESS | 23753 | __end_tp_report 16:26:31 INFO - PROCESS | 23753 | __start_cc_report 16:26:31 INFO - PROCESS | 23753 | _x_x_mozilla_cycle_collect,333 16:26:31 INFO - PROCESS | 23753 | __end_cc_report 16:26:31 INFO - PROCESS | 23753 | __startTimestamp1483748791749__endTimestamp 16:26:31 INFO - PROCESS | 23753 | 16:26:31 INFO - PROCESS | 23753 | ------- Summary: start ------- 16:26:31 INFO - PROCESS | 23753 | Number of tests: 6 16:26:31 INFO - PROCESS | 23753 | 16:26:31 INFO - PROCESS | 23753 | [#0] dojo.html Cycles:165 Average:4701.86 Median:4783.35 stddev:491.95 (10.3%) stddev-sans-first:463.89 16:26:31 INFO - PROCESS | 23753 | Values: 2560.3 2568.2 2572.5 2588.0 2603.0 4696.2 4708.6 4712.8 4733.5 4737.2 4632.3 4640.0 4650.1 4767.6 4780.8 4329.9 4383.0 4393.4 4473.5 4501.9 4077.3 4487.8 4500.2 4521.8 4525.2 4280.5 4432.3 4445.6 4462.4 4549.1 4295.2 4389.3 4443.7 4460.2 4483.3 4376.7 4394.3 4396.5 4400.8 4417.3 4749.1 4753.3 4754.9 4766.3 4814.5 4960.3 4968.2 4972.3 4979.4 5010.6 5045.3 5052.4 5061.8 5082.5 5110.8 4726.5 4728.2 4733.1 4763.4 4783.4 5118.8 5136.2 5144.6 5161.3 5163.7 4974.4 5002.3 5007.1 5017.0 5046.2 5019.4 5051.1 5053.2 5056.7 5093.4 4928.7 4975.6 4982.0 5053.7 5082.7 5094.3 5097.5 5100.2 5102.8 5146.0 4352.6 4374.7 4376.6 4387.0 4422.0 3731.7 3744.3 3754.1 3756.1 3763.9 4457.8 4464.3 4496.8 4510.0 4520.6 5120.9 5133.1 5133.2 5140.3 5141.1 4367.7 4398.6 4431.7 4478.4 4511.2 4543.3 4570.5 4570.9 4592.9 4607.1 4711.8 4719.6 4742.7 4749.3 4752.7 4902.4 4961.0 5057.0 5071.7 5121.5 4700.3 4704.2 4723.3 4787.3 4818.9 5001.3 5008.6 5014.2 5031.8 5074.6 4989.2 5108.7 5112.2 5115.2 5154.6 4888.8 4893.1 4935.5 4956.8 5037.9 4968.6 4971.3 4973.8 4975.9 5040.3 4754.2 4846.8 4885.3 4934.2 4942.5 5000.7 5022.1 5051.2 5104.1 5118.2 4934.7 4935.3 4939.1 4941.7 4970.0 16:26:31 INFO - PROCESS | 23753 | 16:26:31 INFO - PROCESS | 23753 | [#1] ext.html Cycles:180 Average:44913.07 Median:19915.10 stddev:77255.76 (387.9%) stddev-sans-first:77400.60 16:26:31 INFO - PROCESS | 23753 | Values: 523.8 530.9 554.5 560.9 579.5 34955.7 39194.0 39202.6 39226.8 39254.6 39284.0 39674.0 39736.4 39794.8 39854.0 7523.6 7750.8 7755.6 9409.0 9792.6 9756.3 9822.6 9852.7 9859.0 9863.8 9791.2 9839.5 9841.0 9870.3 9879.3 9774.5 9776.6 9799.8 9801.1 9835.7 9659.3 9690.1 9716.5 9717.3 9726.5 34650.3 35109.3 35139.1 35182.6 35289.1 3581.9 3642.6 3659.6 3686.8 3720.1 25896.5 26507.1 26616.7 26618.0 26803.6 3375.8 3440.4 3668.0 3684.5 3698.1 252045.5 253127.0 253845.0 254009.0 254337.0 47832.3 48051.5 48186.5 48354.5 48393.5 50909.0 50978.0 51004.5 51061.2 51154.0 13182.2 13315.3 13344.7 13360.1 13390.6 9930.0 10114.6 10479.7 10716.1 10718.1 15882.3 15892.1 15938.2 15943.6 16185.8 6580.7 6582.2 6612.3 6653.9 6799.9 810.1 821.5 831.0 832.9 854.0 27271.2 28221.9 28358.1 28458.7 28537.1 956.3 958.3 968.8 983.8 991.9 13882.6 14866.6 14893.0 15025.2 15048.2 332602.0 336341.0 337233.0 337282.0 343622.0 50510.0 51022.5 51070.2 51107.0 51237.5 1165.8 1182.2 1199.7 1209.7 1245.1 26002.5 26826.5 26958.0 27445.2 27605.6 42350.6 42747.1 42764.1 42935.6 43069.1 287324.0 288048.0 288267.0 288633.0 290252.0 25866.0 25905.5 26049.7 26135.0 26206.0 41327.0 41689.6 41773.6 41935.8 42622.0 35380.3 36019.3 36187.6 36609.8 36867.4 34674.0 35300.5 35354.0 35393.8 35493.5 34022.0 34981.7 35047.3 35062.3 35259.6 30549.2 31634.5 31834.5 31925.8 32050.2 23552.4 24554.8 24613.0 24863.6 24868.9 16:26:31 INFO - PROCESS | 23753 | 16:26:31 INFO - PROCESS | 23753 | [#2] jquery.html Cycles:180 Average:29046.67 Median:41985.59 stddev:86897.82 (207.0%) stddev-sans-first:87114.93 16:26:31 INFO - PROCESS | 23753 | Values: 380.4 382.3 388.8 398.6 406.2 16175.0 17739.3 18083.9 18275.5 18759.6 10436.8 10693.0 10761.3 17135.4 17565.0 4491.5 4662.7 4803.4 4806.2 4808.3 4458.9 4716.6 4731.3 4741.0 4741.1 4697.4 4716.1 4732.2 4733.4 4737.5 4723.2 5355.4 5591.8 5605.0 5703.0 5550.3 5582.3 5588.2 5592.1 5594.3 12377.4 12425.2 12501.9 12542.8 12576.6 2198.6 2200.0 2201.5 2217.7 2241.0 9033.9 9335.9 9369.8 9712.6 10071.2 1724.0 1743.9 1755.1 1799.5 1806.1 65737.0 74771.0 74866.3 76625.6 78505.0 10314.2 10421.0 10523.9 10649.0 10763.6 14779.2 14794.9 14794.9 14831.6 14898.2 7212.8 7417.8 7549.1 7689.4 7825.0 7037.8 7052.6 7252.3 7285.5 7319.1 4251.1 4356.5 4434.7 4509.7 4668.1 1842.3 1876.1 1894.3 1902.6 1922.4 810.3 821.6 832.8 850.4 868.5 17318.2 18157.3 18282.3 18473.5 18533.3 833.5 839.1 844.0 855.9 863.5 9677.8 10113.1 10311.3 10351.9 10474.9 499355.0 523472.0 524777.0 526775.0 558153.0 97263.5 98393.0 100833.0 102396.0 102987.0 941.2 946.2 972.6 976.0 981.1 16594.5 16824.4 16962.4 17063.8 17144.9 39997.4 40931.4 41456.8 41839.6 42131.6 49481.8 49914.8 57830.0 58364.1 58783.7 8009.8 8074.7 8183.1 8248.5 8313.4 11680.3 12044.7 12641.3 13166.0 13630.8 10355.9 10570.4 10687.5 10909.3 10969.2 10220.5 10546.7 10943.2 10998.4 11179.4 10416.8 10754.5 10896.1 11058.4 11590.7 7089.7 7527.4 7604.6 8041.2 8267.2 9217.3 10835.9 10942.2 11203.9 11472.5 16:26:31 INFO - PROCESS | 23753 | 16:26:31 INFO - PROCESS | 23753 | [#3] mootools.html Cycles:180 Average:4526.53 Median:5273.23 stddev:2321.92 (44.0%) stddev-sans-first:2315.83 16:26:31 INFO - PROCESS | 23753 | Values: 1308.8 1328.8 1338.8 1346.5 1349.2 6120.8 6288.9 6553.0 6933.3 6946.9 6507.2 6725.7 6773.3 6895.0 6895.6 2096.2 2126.6 2131.9 2132.4 2133.9 2080.3 2122.0 2125.4 2128.0 2218.3 2098.9 2122.9 2124.1 2125.0 2125.5 2060.6 2062.1 2070.4 2072.3 2081.8 2099.0 2102.1 2112.4 2113.2 2132.0 6882.9 7010.4 7055.0 7064.5 7080.3 4213.6 4324.8 4339.6 4340.2 4342.6 2697.8 2864.5 2894.3 2921.4 2967.5 1148.0 1160.4 1188.0 1190.3 1244.4 8684.0 8719.7 8823.5 8836.0 8838.6 3581.6 3680.9 3686.6 3788.2 3794.4 7252.1 7276.9 7276.9 7279.1 7298.0 4181.5 4189.2 4193.2 4194.2 4202.2 3863.4 3936.5 4007.7 4011.2 4016.3 3067.9 3137.8 3198.8 3199.7 3203.8 895.4 934.2 979.8 987.2 1112.3 837.3 850.4 856.2 865.8 878.6 4617.5 4676.2 4743.1 4764.4 4991.6 873.8 907.4 915.5 918.0 923.1 3297.8 3421.3 3421.7 3452.8 3617.0 7606.5 7965.6 7986.8 7997.7 8054.0 7463.6 7805.7 7842.9 7983.7 8051.4 6297.5 6411.1 6422.0 6422.9 6442.0 4573.0 4805.1 4833.6 4913.0 5143.6 7308.9 7359.9 7428.0 7460.7 7491.8 7001.6 7569.4 7669.0 7687.2 7690.1 5788.3 6015.5 6021.2 6029.5 6047.4 6351.0 6430.3 6444.8 6520.0 6548.0 6057.2 6075.4 6112.6 6139.2 6149.9 5929.6 5937.6 5969.3 6073.7 6101.4 5402.9 5438.8 5441.5 5465.1 5524.0 4115.7 4163.8 4257.2 4288.4 4314.3 4063.2 4105.6 4159.7 4161.6 4246.7 16:26:31 INFO - PROCESS | 23753 | 16:26:31 INFO - PROCESS | 23753 | [#4] prototype.html Cycles:180 Average:4333.84 Median:4931.69 stddev:1262.26 (25.6%) stddev-sans-first:1229.92 16:26:31 INFO - PROCESS | 23753 | Values: 352.5 356.4 356.7 356.8 359.0 5021.7 5060.5 5065.2 5114.0 5124.5 4990.7 5056.8 5065.4 5082.2 5088.4 3770.7 3864.0 3910.7 3912.3 4079.7 3908.3 3909.6 3916.7 3918.5 3926.6 3885.4 3887.3 3895.9 3907.7 3918.8 3729.3 3901.1 3919.4 3923.4 3926.5 3386.3 3399.4 3400.0 3410.1 3412.1 4826.6 4932.9 4940.8 4947.9 4984.2 4423.3 4434.7 4449.7 4455.5 4465.5 5042.2 5249.2 5270.8 5291.1 5321.7 3674.8 3676.3 3678.6 3686.0 3717.8 5347.3 5484.9 5492.5 5507.7 5581.7 3751.9 3754.2 3775.7 3778.2 3786.9 3833.5 3852.2 3859.9 3878.3 3880.5 4423.3 4439.9 4450.5 4462.8 4466.8 5182.4 5311.1 5313.6 5357.8 5418.9 1289.3 1289.5 1292.7 1296.2 1307.1 848.6 878.9 886.2 897.0 902.4 4495.3 4512.5 4544.4 4568.9 4573.3 5199.2 5266.4 5300.7 5319.7 5341.5 4323.3 4478.8 4479.3 4523.2 4539.7 2753.5 2761.9 2798.7 2800.0 2814.3 4909.2 4925.4 4930.5 4942.8 4969.3 5106.6 5358.4 5367.9 5374.5 5453.2 4903.3 4921.2 4930.5 4944.3 4946.9 5290.9 5293.4 5294.8 5302.5 5309.2 5084.6 5176.3 5179.4 5197.5 5256.7 4830.4 4902.0 4911.2 4923.0 4936.8 3737.8 3789.6 3795.6 3795.8 3843.5 5432.8 5487.4 5492.3 5495.4 5498.7 5171.9 5318.6 5326.8 5328.6 5346.8 5274.9 5288.4 5297.2 5302.3 5304.1 5213.6 5224.0 5227.4 5235.6 5284.2 5111.8 5246.0 5305.9 5313.3 5319.3 5136.3 5148.8 5159.2 5161.0 5188.8 16:26:31 INFO - PROCESS | 23753 | 16:26:31 INFO - PROCESS | 23753 | [#5] yui.html Cycles:180 Average:15173.35 Median:47924.52 stddev:19422.71 (40.5%) stddev-sans-first:19446.37 16:26:31 INFO - PROCESS | 23753 | Values: 601.3 607.2 637.9 654.8 660.6 12906.4 13111.5 13325.3 13526.1 13543.0 12139.6 12170.8 12199.7 12236.4 12852.7 790.7 811.4 822.5 822.5 823.3 795.2 818.2 820.7 822.2 822.9 853.9 856.5 857.3 858.5 860.9 851.2 852.1 855.9 855.9 856.6 627.2 627.3 627.6 629.4 631.5 12338.4 12353.6 12359.1 12361.3 13244.5 12410.2 13410.1 13466.3 13527.5 13666.2 10335.6 10469.3 10515.5 10662.0 10733.4 3274.7 3285.6 3289.4 3304.2 3391.4 64430.4 65340.0 65538.0 66128.7 66387.0 10133.3 10159.8 10257.0 10393.9 10465.0 18800.6 18855.9 19019.4 19097.0 19193.7 6521.5 6573.2 6577.4 6600.1 6854.8 3428.5 3596.9 3612.5 3617.3 3621.2 2876.1 2903.5 2927.6 2933.9 2938.4 462.2 465.2 467.0 471.6 498.0 578.5 599.4 604.2 614.7 616.2 8522.9 8854.5 8902.2 9096.6 9145.3 589.4 592.7 605.6 607.6 608.0 3807.3 4032.9 4039.9 4080.8 4121.5 57145.4 68896.0 69738.0 71966.6 73496.6 61362.4 61610.4 61616.0 61918.7 65376.0 52859.7 52970.5 53971.0 54204.2 54495.5 7517.6 7739.8 7808.7 7967.7 7981.8 33500.5 36230.8 37359.3 38907.4 40255.0 47182.0 47751.5 48097.5 48220.3 49100.8 11032.0 11058.9 11095.6 11216.8 11232.3 11801.6 12193.8 12305.5 12551.7 12924.8 11482.2 11730.9 11952.5 12051.5 12265.9 11200.4 11354.9 11405.1 11906.1 11924.3 11117.2 11171.0 11486.4 11499.3 11745.9 8675.3 8697.9 9061.9 9165.1 9357.3 8560.5 9039.5 9086.2 9147.3 9268.4 16:26:31 INFO - PROCESS | 23753 | -------- Summary: end -------- 16:26:31 INFO - PROCESS | 23753 | 16:26:32 INFO - TEST-INFO | 23753: exit 0 16:26:32 INFO - TEST-OK | dromaeo_css | took 1118519ms 16:26:32 INFO - TEST-START | kraken 16:26:32 INFO - operating with platform_type : linux_ 16:26:32 INFO - Initialising browser for kraken test... 16:26:32 INFO - TEST-INFO | started process 24112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBZV_rV/profile http://localhost:49717/getInfo.html) 16:26:33 INFO - PROCESS | 24112 | 1483748793097 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 16:26:37 INFO - PROCESS | 24112 | __metrics Screen width/height:1600/1200 16:26:37 INFO - PROCESS | 24112 | colorDepth:24 16:26:37 INFO - PROCESS | 24112 | Browser inner width/height: 1024/697 16:26:37 INFO - PROCESS | 24112 | __metrics 16:26:37 ERROR - PROCESS | 24112 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 16:26:38 INFO - TEST-INFO | 24112: exit 0 16:26:38 INFO - Browser initialized. 16:26:38 INFO - Running cycle 1/1 for kraken test... 16:26:38 INFO - TEST-INFO | started process 24232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBZV_rV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:50 INFO - PROCESS | 24232 | RSS: Main: 158609408 16:26:50 INFO - PROCESS | 24232 | 16:26:53 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49717/tests/kraken/driver.html?testName=audio-beat-detection) 16:26:54 INFO - PROCESS | 24232 | RSS: Main: 164888576 16:26:54 INFO - PROCESS | 24232 | 16:26:57 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49717/tests/kraken/driver.html?testName=audio-dft) 16:26:58 INFO - PROCESS | 24232 | RSS: Main: 163315712 16:26:58 INFO - PROCESS | 24232 | 16:27:01 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49717/tests/kraken/driver.html?testName=audio-fft) 16:27:01 INFO - PROCESS | 24232 | RSS: Main: 160436224 16:27:01 INFO - PROCESS | 24232 | 16:27:03 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49717/tests/kraken/driver.html?testName=audio-oscillator) 16:27:04 INFO - PROCESS | 24232 | RSS: Main: 160677888 16:27:04 INFO - PROCESS | 24232 | 16:27:06 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49717/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:27:07 INFO - PROCESS | 24232 | RSS: Main: 161062912 16:27:07 INFO - PROCESS | 24232 | 16:27:10 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49717/tests/kraken/driver.html?testName=imaging-darkroom) 16:27:11 INFO - PROCESS | 24232 | RSS: Main: 166174720 16:27:11 INFO - PROCESS | 24232 | 16:27:14 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49717/tests/kraken/driver.html?testName=imaging-desaturate) 16:27:15 INFO - PROCESS | 24232 | RSS: Main: 162308096 16:27:15 INFO - PROCESS | 24232 | 16:27:18 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49717/tests/kraken/driver.html?testName=json-parse-financial) 16:27:18 INFO - PROCESS | 24232 | RSS: Main: 163246080 16:27:18 INFO - PROCESS | 24232 | 16:27:20 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49717/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:27:21 INFO - PROCESS | 24232 | RSS: Main: 163459072 16:27:21 INFO - PROCESS | 24232 | 16:27:23 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49717/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:27:23 INFO - PROCESS | 24232 | RSS: Main: 163536896 16:27:23 INFO - PROCESS | 24232 | 16:27:25 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49717/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:27:26 INFO - PROCESS | 24232 | RSS: Main: 163856384 16:27:26 INFO - PROCESS | 24232 | 16:27:29 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:27:30 INFO - PROCESS | 24232 | RSS: Main: 164110336 16:27:30 INFO - PROCESS | 24232 | 16:27:33 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:27:33 INFO - PROCESS | 24232 | RSS: Main: 163442688 16:27:33 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | Cycle 1(1): loaded http://localhost:49717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49717/tests/kraken/driver.html?testName=ai-astar) 16:27:35 INFO - PROCESS | 24232 | RSS: Main: 165384192 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | __start_tp_report 16:27:35 INFO - PROCESS | 24232 | _x_x_mozilla_page_load 16:27:35 INFO - PROCESS | 24232 | _x_x_mozilla_page_load_details 16:27:35 INFO - PROCESS | 24232 | |i|pagename|runs| 16:27:35 INFO - PROCESS | 24232 | |0;ai-astar;106;118;117;115;115;116;114;119;118;115 16:27:35 INFO - PROCESS | 24232 | |1;audio-beat-detection;149;124;125;168;127;129;131;125;153;128 16:27:35 INFO - PROCESS | 24232 | |2;audio-dft;164;167;175;163;163;165;163;165;163;164 16:27:35 INFO - PROCESS | 24232 | |3;audio-fft;76;77;77;111;76;77;76;76;94;78 16:27:35 INFO - PROCESS | 24232 | |4;audio-oscillator;85;84;104;85;85;84;109;83;86;115 16:27:35 INFO - PROCESS | 24232 | |5;imaging-gaussian-blur;117;118;118;119;122;118;118;120;121;118 16:27:35 INFO - PROCESS | 24232 | |6;imaging-darkroom;151;150;150;150;150;150;151;150;150;150 16:27:35 INFO - PROCESS | 24232 | |7;imaging-desaturate;96;98;98;96;96;96;97;96;96;96 16:27:35 INFO - PROCESS | 24232 | |8;json-parse-financial;65;65;66;66;67;67;67;68;65;68 16:27:35 INFO - PROCESS | 24232 | |9;json-stringify-tinderbox;66;67;67;67;68;70;67;68;67;67 16:27:35 INFO - PROCESS | 24232 | |10;stanford-crypto-aes;86;92;87;85;87;92;85;86;84;87 16:27:35 INFO - PROCESS | 24232 | |11;stanford-crypto-ccm;143;133;133;145;139;138;132;145;183;141 16:27:35 INFO - PROCESS | 24232 | |12;stanford-crypto-pbkdf2;178;181;177;180;181;179;189;178;177;177 16:27:35 INFO - PROCESS | 24232 | |13;stanford-crypto-sha256-iterative;70;70;70;70;69;69;67;69;68;71 16:27:35 INFO - PROCESS | 24232 | __end_tp_report 16:27:35 INFO - PROCESS | 24232 | __start_cc_report 16:27:35 INFO - PROCESS | 24232 | _x_x_mozilla_cycle_collect,809 16:27:35 INFO - PROCESS | 24232 | __end_cc_report 16:27:35 INFO - PROCESS | 24232 | __startTimestamp1483748855782__endTimestamp 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | ------- Summary: start ------- 16:27:35 INFO - PROCESS | 24232 | Number of tests: 14 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.50 stddev:3.65 (3.1%) stddev-sans-first:1.73 16:27:35 INFO - PROCESS | 24232 | Values: 106.0 118.0 117.0 115.0 115.0 116.0 114.0 119.0 118.0 115.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:130.00 stddev:15.23 (11.7%) stddev-sans-first:15.40 16:27:35 INFO - PROCESS | 24232 | Values: 149.0 124.0 125.0 168.0 127.0 129.0 131.0 125.0 153.0 128.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:3.68 (2.2%) stddev-sans-first:3.87 16:27:35 INFO - PROCESS | 24232 | Values: 164.0 167.0 175.0 163.0 163.0 165.0 163.0 165.0 163.0 164.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:11.64 (15.1%) stddev-sans-first:12.16 16:27:35 INFO - PROCESS | 24232 | Values: 76.0 77.0 77.0 111.0 76.0 77.0 76.0 76.0 94.0 78.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:84.50 stddev:12.27 (14.5%) stddev-sans-first:12.75 16:27:35 INFO - PROCESS | 24232 | Values: 85.0 84.0 104.0 85.0 85.0 84.0 109.0 83.0 86.0 115.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:118.50 stddev:1.60 (1.3%) stddev-sans-first:1.54 16:27:35 INFO - PROCESS | 24232 | Values: 117.0 118.0 118.0 119.0 122.0 118.0 118.0 120.0 121.0 118.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 16:27:35 INFO - PROCESS | 24232 | Values: 151.0 150.0 150.0 150.0 150.0 150.0 151.0 150.0 150.0 150.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 16:27:35 INFO - PROCESS | 24232 | Values: 96.0 98.0 98.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:67.00 stddev:1.17 (1.8%) stddev-sans-first:1.13 16:27:35 INFO - PROCESS | 24232 | Values: 65.0 65.0 66.0 66.0 67.0 67.0 67.0 68.0 65.0 68.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.01 16:27:35 INFO - PROCESS | 24232 | Values: 66.0 67.0 67.0 67.0 68.0 70.0 67.0 68.0 67.0 67.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:2.77 (3.2%) stddev-sans-first:2.91 16:27:35 INFO - PROCESS | 24232 | Values: 86.0 92.0 87.0 85.0 87.0 92.0 85.0 86.0 84.0 87.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:142.00 stddev:14.81 (10.4%) stddev-sans-first:15.71 16:27:35 INFO - PROCESS | 24232 | Values: 143.0 133.0 133.0 145.0 139.0 138.0 132.0 145.0 183.0 141.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:179.50 stddev:3.62 (2.0%) stddev-sans-first:3.79 16:27:35 INFO - PROCESS | 24232 | Values: 178.0 181.0 177.0 180.0 181.0 179.0 189.0 178.0 177.0 177.0 16:27:35 INFO - PROCESS | 24232 | 16:27:35 INFO - PROCESS | 24232 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 16:27:35 INFO - PROCESS | 24232 | Values: 70.0 70.0 70.0 70.0 69.0 69.0 67.0 69.0 68.0 71.0 16:27:35 INFO - PROCESS | 24232 | -------- Summary: end -------- 16:27:35 INFO - PROCESS | 24232 | 16:27:36 INFO - TEST-INFO | 24232: exit 0 16:27:36 INFO - TEST-OK | kraken | took 64355ms 16:27:36 INFO - SUITE-END | took 1182s 16:27:37 INFO - Completed test suite (00:19:43) 16:27:37 INFO - javascript benchmark 16:27:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6333.56736762634, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2560.2703229579574, 2568.216693908358, 2572.459783445476, 2587.974120258797, 2603.0368763557476, 4696.154692155411, 4708.599769019633, 4712.764361781914, 4733.502982186872, 4737.1946769049255, 4632.305154226868, 4640.0255946251245, 4650.069986002804, 4767.5709186173235, 4780.80876764929, 4329.913401731971, 4382.956170438287, 4393.428854248959, 4473.507914129459, 4501.919539310558, 4077.2864748668862, 4487.775611219442, 4500.234960056799, 4521.796519156645, 4525.208088584501, 4280.464941882265, 4432.312991486325, 4445.622122119624, 4462.352958820969, 4549.1129229800035, 4295.226859165349, 4389.253826849444, 4443.666724995638, 4460.1971645104195, 4483.327500874895, 4376.6936314458, 4394.340848872663, 4396.450443694538, 4400.845970391021, 4417.271150260203, 4749.121412538691, 4753.33453316536, 4754.881127971794, 4766.285057241442, 4814.470408255089, 4960.33035540201, 4968.22992436173, 4972.328735620717, 4979.377577802775, 5010.574101201402, 5045.293658887758, 5052.444231134572, 5061.848144555669, 5082.542571168576, 5110.8466745997675, 4726.503717109723, 4728.219843725816, 4733.077049975291, 4763.380760501147, 4783.354247176656, 5118.820841270612, 5136.203888397305, 5144.639875208774, 5161.303224064778, 5163.741812909339, 4974.403071631355, 5002.274670172805, 5007.098722230034, 5016.974915125401, 5046.1926091825135, 5019.422766381913, 5051.1413059779925, 5053.216751403538, 5056.6713163644245, 5093.363329583802, 4928.67963582366, 4975.577075948512, 4981.975090124526, 5053.69677819332, 5082.720450375265, 5094.312267843868, 5097.464766199496, 5100.183970564692, 5102.821401250939, 5146.047981123429, 4352.564743525622, 4374.650027997753, 4376.6498680105515, 4386.978065109654, 4422.0, 3731.7014638828828, 3744.344739670547, 3754.0802503386844, 3756.13608869956, 3763.9059023524082, 4457.77711114443, 4464.30803225494, 4496.820127194876, 4510.030343476168, 4520.570545798144, 5120.8719782005, 5133.101707201225, 5133.153029750124, 5140.254663073908, 5141.074606570778, 4367.65058795302, 4398.582134697199, 4431.667624928144, 4478.395416618715, 4511.187986162522, 4543.318502224693, 4570.54294570547, 4570.9314360284625, 4592.8622141335145, 4607.0785842831565, 4711.81152753886, 4719.551642593948, 4742.668013239109, 4749.335093086971, 4752.738599376929, 4902.411710594752, 4961.0, 5057.039162559249, 5071.746412679425, 5121.487851214849, 4700.271457924027, 4704.247320428715, 4723.291506274087, 4787.257975013878, 4818.915743957581, 5001.349824522788, 5008.649394542347, 5014.247862820606, 5031.773570189277, 5074.6194035448225, 4989.151844186569, 5108.69347839116, 5112.207607820794, 5115.2071428928575, 5154.639175257696, 4888.828890988798, 4893.143699852582, 4935.506449355035, 4956.752162391938, 5037.899242015066, 4968.602511798975, 4971.328870602567, 4973.751312434436, 4975.875603109951, 5040.294358789845, 4754.168020596313, 4846.757662116809, 4885.316055752127, 4934.18585933317, 4942.5304596063315, 5000.749962501933, 5022.096022715946, 5051.2423136529815, 5104.081265372269, 5118.181091025418, 4934.654574179773, 4935.309056731989, 4939.110960027086, 4941.728204948762, 4969.975150124226], "value": 4669.676698805428, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.8219005538116, 530.8964751873385, 554.498179147871, 560.9214709940609, 579.5218944370895, 34955.65044349556, 39194.0, 39202.607973920254, 39226.80386598066, 39254.607453925455, 39284.0, 39674.0, 39736.40395394072, 39794.8010259949, 39854.0, 7523.586202758833, 7750.8449831003345, 7755.612219389036, 9409.0, 9792.608295668164, 9756.268279879003, 9822.557984890696, 9852.704418867446, 9858.950705246463, 9863.802723945517, 9791.16775074116, 9839.508024598741, 9840.95079524605, 9870.309078364517, 9879.259055570861, 9774.462404567746, 9776.608935642565, 9799.804003919882, 9801.117899389017, 9835.704928852147, 9659.275554333453, 9690.079442452956, 9716.465594392377, 9717.271204659608, 9726.513674316328, 34650.30699385998, 35109.29781404357, 35139.12152196216, 35182.648173518195, 35289.117772055906, 3581.8746343877838, 3642.562892452896, 3659.5791483979415, 3686.8340924658455, 3720.069982504374, 25896.48207035849, 26507.072252471266, 26616.73383266162, 26618.0, 26803.597946030826, 3375.763696541243, 3440.449528075521, 3668.0279725872665, 3684.470944558005, 3698.1124530112847, 252045.47954520403, 253127.0, 253845.0, 254009.0, 254337.0, 47832.282515762294, 48051.5194848047, 48186.5181348182, 48354.516454835706, 48393.516064839605, 50909.0, 50978.0, 51004.48995510072, 51061.23408148881, 51154.0, 13182.209067455791, 13315.334233288297, 13344.733105338033, 13360.13159144672, 13390.598282051555, 9929.950350248202, 10114.595416183418, 10479.738006549896, 10716.089132423675, 10718.14254859625, 15882.285297161656, 15892.125933073561, 15938.203089845461, 15943.601409964844, 16185.83814161867, 6580.736770529125, 6582.210134783857, 6612.305707900698, 6653.933460665428, 6799.864002719918, 810.0926961802819, 821.5440430561096, 831.0359982420364, 832.8709050097244, 854.0, 27271.181864544094, 28221.858890705415, 28358.149255522367, 28458.71541284602, 28537.14388568346, 956.3353469338742, 958.3195930889146, 968.840141376665, 983.7983213441228, 991.9355241909253, 13882.583522494342, 14866.554003379915, 14893.0, 15025.173615451255, 15048.172350520608, 332602.0, 336341.0, 337233.0, 337282.0, 343622.0, 50510.0, 51022.48977510251, 51070.23394649083, 51107.0, 51237.48762512327, 1165.8134698448207, 1182.1901997131993, 1199.7240634653904, 1209.7399059202137, 1245.1408528115753, 26002.479950401263, 26826.463470730087, 26958.0, 27445.176644700692, 27605.58591621087, 42350.576494234665, 42747.14505709806, 42764.14471710611, 42935.57064429441, 43069.138617226854, 287324.0, 288048.0, 288267.0, 288633.0, 290252.0, 25866.0, 25905.481890362465, 26049.743782027246, 26135.0, 26206.0, 41327.0, 41689.58310416857, 41773.58226417697, 41935.790321048196, 42622.0, 35380.292394152486, 36019.27961440704, 36187.638123618424, 36609.816950915076, 36867.446988295735, 34674.0, 35300.47049294314, 35354.0, 35393.82303088468, 35493.467597986564, 34022.0, 34981.65018349886, 35047.299054018265, 35062.29875402529, 35259.64740352564, 30549.23626909345, 31634.525482117326, 31834.52248216325, 31925.840370797996, 32050.19874503156, 23552.411189720395, 24554.754452455247, 24613.0, 24863.62704559469, 24868.875655621607], "value": 17554.17054853321, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.42365815789066, 382.3156549775901, 388.8405753641007, 398.583480263125, 406.1551971898451, 16174.999999999985, 17739.290428382883, 18083.909580452095, 18275.45173644791, 18759.624807503842, 10436.791264174712, 10693.0, 10761.30051546649, 17135.400260990868, 17565.0, 4491.528389519102, 4662.696924699892, 4803.3995750531185, 4806.182948898678, 4808.278758186282, 4458.933116003246, 4716.575508204261, 4731.33761273422, 4740.976295118519, 4741.122892264925, 4697.436307643087, 4716.127516409458, 4732.171869922767, 4733.384659994196, 4737.455192652855, 4723.197056500386, 5355.437679043684, 5591.8042868499615, 5604.971975140139, 5702.971485142548, 5550.250716153308, 5582.330120385539, 5588.189712491707, 5592.0773072443, 5594.328680558359, 12377.443015064344, 12425.19236249641, 12501.93749031249, 12542.81185782214, 12576.622701318975, 2198.604251234777, 2199.9560008799895, 2201.4716468047714, 2217.6562632791943, 2241.0475547892243, 9033.864492032624, 9335.859962100574, 9369.76575585609, 9712.562934667956, 10071.194304455626, 1723.9913800431043, 1743.9215235314314, 1755.1224387806096, 1799.478151336111, 1806.1330561330635, 65737.0, 74771.0, 74866.25133748702, 76625.61687191584, 78505.0, 10314.174866010851, 10421.0, 10523.894761052292, 10649.0, 10763.569457221623, 14779.187144707144, 14794.926025369805, 14794.926025369805, 14831.629209269855, 14898.180600066884, 7212.819679508054, 7417.814554636069, 7549.0563679540055, 7689.423293252917, 7824.9608751955875, 7037.788866334018, 7052.576845389191, 7252.347288744038, 7285.526440781332, 7319.121705395387, 4251.128518653669, 4356.520782713899, 4434.711743736647, 4509.661775366861, 4668.11305851887, 1842.309134074722, 1876.1088482970479, 1894.2801735340483, 1902.6480101181048, 1922.3944457495843, 810.3476701255428, 821.6425854753202, 832.7876391520124, 850.3919697416377, 868.4832524647825, 17318.220680069426, 18157.27370905149, 18282.268709251483, 18473.5381615458, 18533.258669653333, 833.4749108062003, 839.1189251286125, 843.9704610338608, 855.8758979947872, 863.5250612163285, 9677.758056048515, 10113.128386983875, 10311.329763565343, 10351.948240258751, 10474.895251047392, 499355.0, 523472.0, 524777.0, 526775.0, 558153.0, 97263.51368243113, 98393.0, 100833.0, 102396.0, 102987.0, 941.1952780372683, 946.1768261612303, 972.5526257921435, 975.9609615615295, 981.1120935553336, 16594.50649441556, 16824.411145609844, 16962.406315778888, 17063.82936170672, 17144.885582437102, 39997.40003899886, 40931.38602921018, 41456.79271603622, 41839.606841281224, 42131.57868421276, 49481.752591238255, 49914.75042624909, 57830.0, 58364.07810672111, 58783.70608146932, 8009.8398032040195, 8074.677012919417, 8183.138886271955, 8248.505089694638, 8313.41806073569, 11680.299182049104, 12044.698882527657, 12641.304728240035, 13166.01254905905, 13630.795538066739, 10355.94822025885, 10570.365778053341, 10687.5190616424, 10909.290896091728, 10969.23215374916, 10220.540075696463, 10546.683599492027, 10943.233973621771, 10998.395088270221, 11179.441027948733, 10416.791664166523, 10754.465263535349, 10896.073833724222, 11058.391788451712, 11590.652280431601, 7089.680964356719, 7527.360174385239, 7604.581748003913, 8041.155678653891, 8267.214614611603, 9217.308701847254, 10835.945820271163, 10942.23404361687, 11203.88796112061, 11472.483738231967], "value": 8410.418456075226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.7644224039673, 1328.780751176056, 1338.759023375792, 1346.5089584269103, 1349.156777014366, 6120.755169793203, 6288.937110628893, 6553.0, 6933.30666933307, 6946.895796563049, 6507.154069970898, 6725.697343619537, 6773.322667733224, 6895.0, 6895.620740859264, 2096.15105882118, 2126.5746850629857, 2131.8507704460694, 2132.402927180392, 2133.925312614059, 2080.3446914222045, 2121.968170477444, 2125.4473836802467, 2127.957440851182, 2218.279059305724, 2098.874067555944, 2122.883241421729, 2124.1397234120204, 2125.043730321354, 2125.51113243954, 2060.6084843879767, 2062.051456330075, 2070.3995841206033, 2072.274703853654, 2081.812636862682, 2099.0338883758855, 2102.075086961732, 2112.387407651779, 2113.2392338758036, 2131.989340053305, 6882.931170688279, 7010.404115650176, 7055.0, 7064.505484616079, 7080.256573059857, 4213.5786421357925, 4324.805383757738, 4339.631131353839, 4340.175366680352, 4342.609165175149, 2697.824641398303, 2864.5273529867545, 2894.3198348388114, 2921.3865088331477, 2967.4955257606257, 1148.0425873885006, 1160.425589333277, 1187.9881201187964, 1190.2560899437851, 1244.3778110944527, 8684.0, 8719.738407847775, 8823.514706691129, 8835.955820220857, 8838.602262898185, 3581.5702115746276, 3680.852765889388, 3686.562240726119, 3788.1855401088897, 3794.354959656865, 7252.057232559733, 7276.854462910712, 7276.890846637305, 7279.090113735783, 7298.0, 4181.498220213533, 4189.162167566499, 4193.203291374629, 4194.224068547267, 4202.201581699467, 3863.4204869269274, 3936.527616685959, 4007.73949693269, 4011.2378648056774, 4016.3172260715164, 3067.8619462124257, 3137.8117312961294, 3198.792078514889, 3199.744020478356, 3203.759718021158, 895.4314010603314, 934.1779234273931, 979.8089372572423, 987.225028352754, 1112.2547892911768, 837.2883049407955, 850.4472093139385, 856.1737922904302, 865.8484765166197, 878.6002368922125, 4617.515160908123, 4676.228422310281, 4743.0988112258565, 4764.38063051808, 4991.550760431579, 873.8470767615769, 907.3622112087745, 915.4827522449795, 917.958691858868, 923.1138107416955, 3297.835108244626, 3421.298633780069, 3421.674940880612, 3452.7583069184916, 3616.9638303617153, 7606.467547271638, 7965.641546130438, 7986.800329991796, 7997.6800927963395, 8053.952986111768, 7463.552186868806, 7805.726799561988, 7842.921570784333, 7983.68065277394, 8051.436399451982, 6297.464715499143, 6411.070394792729, 6422.0, 6422.903656445157, 6441.967790161019, 4572.977135114304, 4805.087033463631, 4833.564979151894, 4913.0, 5143.588512918883, 7308.940203670544, 7359.889601656087, 7427.962860185665, 7460.738874139379, 7491.812704682208, 7001.614911179934, 7569.394448444222, 7669.0, 7687.231276872268, 7690.077190737147, 5788.305403351625, 6015.518758499397, 6021.187139736079, 6029.51763858899, 6047.395260473917, 6350.96824515893, 6430.260520040255, 6444.7744328948265, 6519.967400162969, 6547.9672601638595, 6057.1519987200945, 6075.422834830684, 6112.572119951561, 6139.201903752483, 6149.938500614937, 5929.584929055098, 5937.614055086406, 5969.253843269591, 6073.665948372882, 6101.420365065312, 5402.864928376822, 5438.809641662523, 5441.483059109379, 5465.070937940639, 5524.0, 4115.71190016696, 4163.812628431789, 4257.169851878978, 4288.442502474658, 4314.288142456459, 4063.1670507546473, 4105.630493255621, 4159.6880233981965, 4161.583841615814, 4246.681498887534], "value": 3774.0999551523732, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.53641461478156, 356.44750636513396, 356.7306683453992, 356.7877113117694, 358.9551306086739, 5021.673591216573, 5060.54455099041, 5065.151219804772, 5114.0, 5124.538791508769, 4990.702417371483, 5056.797728090872, 5065.366829146356, 5082.212257100146, 5088.414832294287, 3770.679492243149, 3863.971415007116, 3910.687145028391, 3912.2762288976487, 4079.7348172368847, 3908.335582950891, 3909.6285852843935, 3916.7454115482547, 3918.5101862267215, 3926.5877082906313, 3885.436611691303, 3887.3002859485423, 3895.8831235062994, 3907.7069219808486, 3918.784466854322, 3729.2914346274392, 3901.1027463683513, 3919.412088186766, 3923.411488276767, 3926.528816542019, 3386.305807309496, 3399.354122716676, 3399.9660003399895, 3410.1304167437393, 3412.146963259185, 4826.589739872115, 4932.876678083041, 4940.777665005084, 4947.851564453073, 4984.177610694231, 4423.301785910592, 4434.68957172998, 4449.688521803475, 4455.487618923833, 4465.486469056068, 5042.218456139304, 5249.160134378481, 5270.762815673265, 5291.058161669543, 5321.680699158024, 3674.7978861162624, 3676.3015027145025, 3678.6321367863, 3685.963140368589, 3717.8288839015895, 5347.278117454132, 5484.945150548483, 5492.47821456961, 5507.7246137692955, 5581.74882130301, 3751.868684596026, 3754.192848537523, 3775.6601905828607, 3778.244351129785, 3786.9431958520645, 3833.463315135883, 3852.2295540891932, 3859.903502412406, 3878.301905657009, 3880.5149356330458, 4423.270160423494, 4439.935430025054, 4450.465944086665, 4462.7768611569945, 4466.798994045275, 5182.367554220484, 5311.061462566136, 5313.57491400687, 5357.785688572491, 5418.945810541923, 1289.278004317585, 1289.5164313382481, 1292.7395789105547, 1296.2157894473896, 1307.1438207973792, 848.5969164646743, 878.885744853165, 886.1625763653286, 897.0491279244022, 902.4089221559889, 4495.303227999665, 4512.481064677604, 4544.363789069533, 4568.880624247081, 4573.268277075652, 5199.2201169824075, 5266.3943646480375, 5300.708461034603, 5319.6808191508635, 5341.519263266325, 4323.329883868006, 4478.753668548261, 4479.3057076153245, 4523.185826551186, 4539.72761634303, 2753.5318995770767, 2761.9309517262227, 2798.7061358557467, 2799.972000280012, 2814.32456210508, 4909.165441874889, 4925.359703238628, 4930.4747105819515, 4942.777575009133, 4969.304297398367, 5106.565941894906, 5358.383785864676, 5367.919481207785, 5374.479715786167, 5453.209284653783, 4903.313536104948, 4921.188003979303, 4930.4961986593, 4944.307796908436, 4946.925796113062, 5290.920636190383, 5293.364796224478, 5294.8411547652095, 5302.496262855023, 5309.2301616266195, 5084.6440749147205, 5176.317696748647, 5179.352580927384, 5197.54468748751, 5256.710880901587, 4830.420349558076, 4901.975490122527, 4911.189653707098, 4922.975385123052, 4936.827211047596, 3737.8131093445763, 3789.583145854009, 3795.6394142556414, 3795.829187686616, 3843.5195600549932, 5432.755526001419, 5487.396386397573, 5492.286002819608, 5495.395506494362, 5498.725063746877, 5171.9482805171465, 5318.574514038945, 5326.760295786777, 5328.626996110235, 5346.8395948121615, 5274.947250527445, 5288.360608211467, 5297.152455607084, 5302.310699609026, 5304.124819404755, 5213.556847667991, 5223.973880130575, 5227.372715274191, 5235.633505654568, 5284.180951952453, 5111.79552817898, 5246.009774428691, 5305.946940530545, 5313.256144139901, 5319.281896943863, 5136.2552429896705, 5148.794048238028, 5159.162460646554, 5161.0, 5188.844334669966], "value": 3943.98780697978, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.254444488834, 607.1863702638461, 637.9138816259805, 654.7708302094268, 660.597035808157, 12906.354682265885, 13111.54109606164, 13325.267110308929, 13526.053176277665, 13543.0, 12139.635810925687, 12170.756584868297, 12199.695007624814, 12236.44935977881, 12852.742945141092, 790.7232468635989, 811.3509192645889, 822.4571782623469, 822.4653974916292, 823.2878560045577, 795.2008231727107, 818.1654712193559, 820.7373640435063, 822.1942496353577, 822.8889099971487, 853.9444936079166, 856.4689892266772, 857.2798848966867, 858.5149390594325, 860.8665656823171, 851.2083762101244, 852.1308265569115, 855.9229669329728, 855.9443636163661, 856.6359297298624, 627.1658693937098, 627.3318915355178, 627.645380360095, 629.3926361061598, 631.5484428633503, 12338.444769985372, 12353.567625133168, 12359.134860559765, 12361.258324500559, 13244.47022119114, 12410.193337433127, 13410.061295709304, 13466.326683665875, 13527.458901643922, 13666.18002919818, 10335.586576536929, 10469.267151299413, 10515.474226288656, 10662.0, 10733.355998640107, 3274.7380209583175, 3285.5564498792596, 3289.424350738635, 3304.2400247943106, 3391.355642427931, 64430.3556964429, 65340.0, 65538.0, 66128.6693566534, 66387.0, 10133.290669653054, 10159.796804063877, 10256.974302569683, 10393.9480302598, 10465.0, 18800.62398752045, 18855.90572047131, 19019.42941711751, 19097.0, 19193.712094318595, 6521.543491955613, 6573.244076931119, 6577.408033277028, 6600.075989361493, 6854.794356169323, 3428.5200071989943, 3596.946045809315, 3612.548431446069, 3617.330793803155, 3621.203335266237, 2876.137158852378, 2903.5209190483756, 2927.575501552263, 2933.9413211735646, 2938.4270067336665, 462.23500107322434, 465.1650287733526, 467.04722366372897, 471.62977063005377, 497.99502004979485, 578.4764787866987, 599.3736545310161, 604.1783174882157, 614.7110857896781, 616.2143267334185, 8522.87215691765, 8854.513001784964, 8902.198802107841, 9096.636134554676, 9145.268378529834, 589.3664310865836, 592.7154965616442, 605.5851741557047, 607.6354187487473, 607.957442978996, 3807.2956503047026, 4032.9395059074136, 4039.939400908989, 4080.7959602019782, 4121.52602450722, 57145.42854571484, 68896.0, 69738.0, 71966.64016679987, 73496.63251683707, 61362.38637613567, 61610.38389616046, 61616.0, 61918.69040654768, 65376.0, 52859.735701321246, 52970.47029529655, 53971.0, 54204.18693719598, 54495.45504544983, 7517.586532740752, 7739.7678069658, 7808.726694565663, 7967.721129760431, 7981.800454988672, 33500.49247783807, 36230.818845905604, 37359.25281494409, 38907.41638875363, 40255.0, 47182.0, 47751.52248477471, 48097.519024809306, 48220.27669585029, 49100.75449622872, 11032.0, 11058.949399807005, 11095.611653592085, 11216.775664486828, 11232.269902456314, 11801.645950621494, 12193.756124877631, 12305.507779689071, 12551.686207844878, 12924.806127907901, 11482.220255860355, 11730.88269117298, 11952.521899124285, 12051.457684404048, 12265.938670306949, 11200.372684967333, 11354.943225283821, 11405.087592992706, 11906.107041971714, 11924.284542927453, 11117.16621253393, 11171.0, 11486.368249746343, 11499.310041397543, 11745.882541174478, 8675.30597552207, 8697.869531957153, 9061.864072038792, 9165.129312715548, 9357.298202634965, 8560.529170895661, 9039.502827344559, 9086.182243598108, 9147.313951453802, 9268.443893366419], "value": 6289.331538336561, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 117.0, 115.0, 115.0, 116.0, 114.0, 119.0, 118.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 125.0, 168.0, 127.0, 129.0, 131.0, 125.0, 153.0, 128.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 175.0, 163.0, 163.0, 165.0, 163.0, 165.0, 163.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 111.0, 76.0, 77.0, 76.0, 76.0, 94.0, 78.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 104.0, 85.0, 85.0, 84.0, 109.0, 83.0, 86.0, 115.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 119.0, 122.0, 118.0, 118.0, 120.0, 121.0, 118.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 150.0, 150.0, 150.0, 151.0, 150.0, 150.0, 150.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 98.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 67.0, 67.0, 67.0, 68.0, 65.0, 68.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 70.0, 67.0, 68.0, 67.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 92.0, 87.0, 85.0, 87.0, 92.0, 85.0, 86.0, 84.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 133.0, 145.0, 139.0, 138.0, 132.0, 145.0, 183.0, 141.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 181.0, 177.0, 180.0, 181.0, 179.0, 189.0, 178.0, 177.0, 177.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 67.0, 69.0, 68.0, 71.0], "value": 69.3, "unit": "score"}]}]} 16:27:37 INFO - Return code: 0 16:27:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:27:37 ERROR - # TBPL SUCCESS # 16:27:37 INFO - Running post-action listener: _resource_record_post_action 16:27:37 INFO - [mozharness: 2017-01-07 00:27:37.601341Z] Finished run-tests step (success) 16:27:37 INFO - Running post-run listener: _resource_record_post_run 16:27:37 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 0; Write bytes: 395948032; Read time: 0; Write time: 332664 16:27:37 INFO - TinderboxPrint: CPU usage
13.5% 16:27:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:27:37 INFO - TinderboxPrint: I/O write bytes / time
395,948,032 / 332,664 16:27:37 INFO - TinderboxPrint: CPU idle
8,279.3 (86.5%) 16:27:37 INFO - TinderboxPrint: CPU user
1,235.0 (12.9%) 16:27:37 INFO - TinderboxPrint: Swap in / out
0 / 0 16:27:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99516416; Read time: 0; Write time: 73092 16:27:37 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 0; Write bytes: 296431616; Read time: 0; Write time: 259572 16:27:38 INFO - Running post-run listener: _upload_blobber_files 16:27:38 INFO - Blob upload gear active. 16:27:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:27:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:27:38 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:27:38 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:27:38 INFO - (blobuploader) - INFO - Open directory for files ... 16:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:27:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:39 INFO - (blobuploader) - INFO - Done attempting. 16:27:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:27:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:27:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:40 INFO - (blobuploader) - INFO - Done attempting. 16:27:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:27:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:27:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:41 INFO - (blobuploader) - INFO - Done attempting. 16:27:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:27:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:27:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:44 INFO - (blobuploader) - INFO - Done attempting. 16:27:44 INFO - (blobuploader) - INFO - Iteration through files over. 16:27:44 INFO - Return code: 0 16:27:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:27:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:27:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c16cd1009d7f76ee048569a3402c28e278aea35a057474612c0163501f868a26e1bb14594c293a3734e6f8c9bbf626891604fb184ab9343f247bf1f515dd9135", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7c96f6d5f471d41ed90de97e83461f989afae006149fe426ed3d913f8e4a14b65f2ae4f07c8aa652dd153322b19ca53ce121886b4fca80999d4c5758a1299de5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ebce7454d3752cc8067abd180ad29672b90a0ae84df7d4bc3d995c0d24512e314cdf07c55daeabdc99dfd329ff886553d7f785315391bc5f804e2ae1a7d019da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fdddc47bdcd537164bd0f27831c8ead36dc5510b4be0503165936ca4e38a7ccd4b6d2e6eda190b9e68d40d19bb1d31c4c51c4efce97bda76df1b964d0455d8b3"} 16:27:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:27:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:27:44 INFO - Contents: 16:27:44 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c16cd1009d7f76ee048569a3402c28e278aea35a057474612c0163501f868a26e1bb14594c293a3734e6f8c9bbf626891604fb184ab9343f247bf1f515dd9135", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7c96f6d5f471d41ed90de97e83461f989afae006149fe426ed3d913f8e4a14b65f2ae4f07c8aa652dd153322b19ca53ce121886b4fca80999d4c5758a1299de5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ebce7454d3752cc8067abd180ad29672b90a0ae84df7d4bc3d995c0d24512e314cdf07c55daeabdc99dfd329ff886553d7f785315391bc5f804e2ae1a7d019da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fdddc47bdcd537164bd0f27831c8ead36dc5510b4be0503165936ca4e38a7ccd4b6d2e6eda190b9e68d40d19bb1d31c4c51c4efce97bda76df1b964d0455d8b3"} 16:27:44 INFO - Running post-run listener: copy_logs_to_upload_dir 16:27:44 INFO - Copying logs to upload dir... 16:27:44 INFO - mkdir: /builds/slave/test/build/upload/logs 16:27:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.489795 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-01-06 16:27:44.186703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 16:27:44.190524) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c16cd1009d7f76ee048569a3402c28e278aea35a057474612c0163501f868a26e1bb14594c293a3734e6f8c9bbf626891604fb184ab9343f247bf1f515dd9135", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7c96f6d5f471d41ed90de97e83461f989afae006149fe426ed3d913f8e4a14b65f2ae4f07c8aa652dd153322b19ca53ce121886b4fca80999d4c5758a1299de5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ebce7454d3752cc8067abd180ad29672b90a0ae84df7d4bc3d995c0d24512e314cdf07c55daeabdc99dfd329ff886553d7f785315391bc5f804e2ae1a7d019da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fdddc47bdcd537164bd0f27831c8ead36dc5510b4be0503165936ca4e38a7ccd4b6d2e6eda190b9e68d40d19bb1d31c4c51c4efce97bda76df1b964d0455d8b3"} build_url:https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011812 build_url: 'https://queue.taskcluster.net/v1/task/chkP8OQcSr2zftSlHmkJtA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c16cd1009d7f76ee048569a3402c28e278aea35a057474612c0163501f868a26e1bb14594c293a3734e6f8c9bbf626891604fb184ab9343f247bf1f515dd9135", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7c96f6d5f471d41ed90de97e83461f989afae006149fe426ed3d913f8e4a14b65f2ae4f07c8aa652dd153322b19ca53ce121886b4fca80999d4c5758a1299de5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ebce7454d3752cc8067abd180ad29672b90a0ae84df7d4bc3d995c0d24512e314cdf07c55daeabdc99dfd329ff886553d7f785315391bc5f804e2ae1a7d019da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fdddc47bdcd537164bd0f27831c8ead36dc5510b4be0503165936ca4e38a7ccd4b6d2e6eda190b9e68d40d19bb1d31c4c51c4efce97bda76df1b964d0455d8b3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 16:27:44.216262) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:27:44.216585) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1483747618.341504-1218702565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:27:44.300418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 16:27:44.300814) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 16:27:44.301259) ========= ========= Total master_lag: 0.16 =========