builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0377 starttime: 1472514248.41 results: success (0) buildid: 20160829144430 builduid: d4b0375e1dc2462e84cbe8a82a584158 revision: 29f27e5ab2177d8f4ee0c3c9eb06d8705985b14a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:08.409492) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:08.410481) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:08.411155) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:08.444253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:08.444556) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OgNNvGJhOY/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-29 16:44:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-08-29 16:44:08 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123825 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:08.595447) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:08.595778) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OgNNvGJhOY/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026326 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:08.646700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-29 16:44:08.647515) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 29f27e5ab2177d8f4ee0c3c9eb06d8705985b14a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 29f27e5ab2177d8f4ee0c3c9eb06d8705985b14a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OgNNvGJhOY/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-29 16:44:08,731 truncating revision to first 12 chars 2016-08-29 16:44:08,731 Setting DEBUG logging. 2016-08-29 16:44:08,731 attempt 1/10 2016-08-29 16:44:08,731 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/29f27e5ab217?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 16:44:09,713 unpacking tar archive at: autoland-29f27e5ab217/testing/mozharness/ program finished with exit code 0 elapsedTime=1.240989 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-29 16:44:09.916067) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:09.916816) ========= script_repo_revision: 29f27e5ab2177d8f4ee0c3c9eb06d8705985b14a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:09.917750) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:09.918383) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 16:44:09.939598) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-29 16:44:09.940300) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OgNNvGJhOY/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:44:10 INFO - MultiFileLogger online at 20160829 16:44:10 in /builds/slave/test 16:44:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 16:44:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:44:10 INFO - {'append_to_log': False, 16:44:10 INFO - 'base_work_dir': '/builds/slave/test', 16:44:10 INFO - 'blob_upload_branch': 'Autoland', 16:44:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:44:10 INFO - 'branch': 'Autoland', 16:44:10 INFO - 'buildbot_json_path': 'buildprops.json', 16:44:10 INFO - 'config_files': ('talos/mac_config.py',), 16:44:10 INFO - 'default_actions': ('clobber', 16:44:10 INFO - 'read-buildbot-config', 16:44:10 INFO - 'download-and-extract', 16:44:10 INFO - 'populate-webroot', 16:44:10 INFO - 'create-virtualenv', 16:44:10 INFO - 'install', 16:44:10 INFO - 'run-tests'), 16:44:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:44:10 INFO - 'download_minidump_stackwalk': True, 16:44:10 INFO - 'download_symbols': 'ondemand', 16:44:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:44:10 INFO - 'tooltool.py': '/tools/tooltool.py', 16:44:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:44:10 INFO - '/tools/misc-python/virtualenv.py')}, 16:44:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:44:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:44:10 INFO - 'installer_path': 'installer.exe', 16:44:10 INFO - 'log_level': 'info', 16:44:10 INFO - 'log_name': 'talos', 16:44:10 INFO - 'log_to_console': True, 16:44:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:44:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:44:10 INFO - 'opt_config_files': (), 16:44:10 INFO - 'pip_index': False, 16:44:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:44:10 INFO - 'cmd': ('bash', 16:44:10 INFO - '-c', 16:44:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:44:10 INFO - 'enabled': True, 16:44:10 INFO - 'halt_on_failure': False, 16:44:10 INFO - 'name': 'check_screen_resolution'},), 16:44:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:44:10 INFO - 'cmd': ('bash', 16:44:10 INFO - '-c', 16:44:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:44:10 INFO - 'enabled': True, 16:44:10 INFO - 'halt_on_failure': False, 16:44:10 INFO - 'name': 'check_screen_resolution'},), 16:44:10 INFO - 'run_cmd_checks_enabled': True, 16:44:10 INFO - 'sps_profile': False, 16:44:10 INFO - 'sps_profile_interval': 0, 16:44:10 INFO - 'suite': 'dromaeojs-e10s', 16:44:10 INFO - 'system_bits': '32', 16:44:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:44:10 INFO - 'title': 't-yosemite-r7-0377', 16:44:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:44:10 INFO - 'use_talos_json': True, 16:44:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:44:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:44:10 INFO - 'work_dir': 'build'} 16:44:10 INFO - [mozharness: 2016-08-29 23:44:10.130947Z] Running clobber step. 16:44:10 INFO - Running pre-action listener: _resource_record_pre_action 16:44:10 INFO - Running main action method: clobber 16:44:10 INFO - rmtree: /builds/slave/test/build 16:44:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:44:12 INFO - Running post-action listener: _resource_record_post_action 16:44:12 INFO - [mozharness: 2016-08-29 23:44:12.586643Z] Finished clobber step (success) 16:44:12 INFO - [mozharness: 2016-08-29 23:44:12.586895Z] Running read-buildbot-config step. 16:44:12 INFO - Running pre-action listener: _resource_record_pre_action 16:44:12 INFO - Running main action method: read_buildbot_config 16:44:12 INFO - Using buildbot properties: 16:44:12 INFO - { 16:44:12 INFO - "project": "", 16:44:12 INFO - "product": "firefox", 16:44:12 INFO - "script_repo_revision": "production", 16:44:12 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 16:44:12 INFO - "repository": "", 16:44:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 16:44:12 INFO - "buildid": "20160829144430", 16:44:12 INFO - "pgo_build": "False", 16:44:12 INFO - "basedir": "/builds/slave/test", 16:44:12 INFO - "buildnumber": 154, 16:44:12 INFO - "slavename": "t-yosemite-r7-0377", 16:44:12 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:44:12 INFO - "platform": "yosemite_r7", 16:44:12 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 16:44:12 INFO - "branch": "autoland", 16:44:12 INFO - "repo_path": "integration/autoland", 16:44:12 INFO - "revision": "29f27e5ab2177d8f4ee0c3c9eb06d8705985b14a", 16:44:12 INFO - "stage_platform": "macosx64", 16:44:12 INFO - "builduid": "d4b0375e1dc2462e84cbe8a82a584158", 16:44:12 INFO - "slavebuilddir": "test" 16:44:12 INFO - } 16:44:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:44:12 INFO - Running post-action listener: _resource_record_post_action 16:44:12 INFO - [mozharness: 2016-08-29 23:44:12.592555Z] Finished read-buildbot-config step (success) 16:44:12 INFO - [mozharness: 2016-08-29 23:44:12.592754Z] Running download-and-extract step. 16:44:12 INFO - Running pre-action listener: _resource_record_pre_action 16:44:12 INFO - Running main action method: download_and_extract 16:44:12 INFO - mkdir: /builds/slave/test/build/tests 16:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:12 INFO - trying https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:44:12 INFO - Downloading https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 16:44:13 INFO - Downloaded 1199 bytes. 16:44:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:44:13 INFO - Using the following test package requirements: 16:44:13 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:44:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:44:13 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:44:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:44:13 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:44:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:44:13 INFO - u'jsshell-mac.zip'], 16:44:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:44:13 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:44:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:44:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:44:13 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:44:13 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:44:13 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:44:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:44:13 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:44:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:44:13 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:44:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:44: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:44:13 INFO - trying https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:44:13 INFO - Downloading https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:44:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:44:14 INFO - Downloaded 16372552 bytes. 16:44:14 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:44:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:44:21 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:44:21 INFO - trying https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:44:21 INFO - Downloading https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:44:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:44:22 INFO - Downloaded 16372552 bytes. 16:44:22 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:44: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:44:29 INFO - trying https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:44:29 INFO - Downloading https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:44:30 INFO - Downloaded 14413998 bytes. 16:44:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 16:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:31 INFO - trying https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:44:31 INFO - Downloading https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 16:44:34 INFO - Downloaded 111558230 bytes. 16:44:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:44:34 INFO - mkdir: /builds/slave/test/properties 16:44:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:44:34 INFO - Writing to file /builds/slave/test/properties/build_url 16:44:34 INFO - Contents: 16:44:34 INFO - build_url:https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:44:34 INFO - Running post-action listener: _resource_record_post_action 16:44:34 INFO - Running post-action listener: set_extra_try_arguments 16:44:34 INFO - [mozharness: 2016-08-29 23:44:34.731477Z] Finished download-and-extract step (success) 16:44:34 INFO - [mozharness: 2016-08-29 23:44:34.731609Z] Running populate-webroot step. 16:44:34 INFO - Running pre-action listener: _resource_record_pre_action 16:44:34 INFO - Running main action method: populate_webroot 16:44:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:44:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:44:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:44:34 INFO - '--tppagecycles', 16:44:34 INFO - '7'], 16:44:34 INFO - 'tests': ['tsvgm']}}, 16:44:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:44:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:44:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:44:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:44:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:34 INFO - 'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:34 INFO - 'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['damp', 'tps']}, 16:44:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:34 INFO - 'tests': ['damp', 'tps']}, 16:44:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['dromaeo_dom']}, 16:44:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:44:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['basic_compositor_video']}, 16:44:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:44:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['a11yr', 16:44:34 INFO - 'ts_paint', 16:44:34 INFO - 'tpaint', 16:44:34 INFO - 'sessionrestore', 16:44:34 INFO - 'sessionrestore_no_auto_restore', 16:44:34 INFO - 'tabpaint']}, 16:44:34 INFO - 'other-e10s': {'tests': ['a11yr', 16:44:34 INFO - 'ts_paint', 16:44:34 INFO - 'tpaint', 16:44:34 INFO - 'sessionrestore', 16:44:34 INFO - 'sessionrestore_no_auto_restore', 16:44:34 INFO - 'tabpaint']}, 16:44:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:44:34 INFO - 'ts_paint', 16:44:34 INFO - 'tpaint', 16:44:34 INFO - 'sessionrestore', 16:44:34 INFO - 'sessionrestore_no_auto_restore', 16:44:34 INFO - 'tabpaint']}, 16:44:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:44:34 INFO - 'ts_paint', 16:44:34 INFO - 'tpaint', 16:44:34 INFO - 'sessionrestore', 16:44:34 INFO - 'sessionrestore_no_auto_restore', 16:44:34 INFO - 'tabpaint']}, 16:44:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['a11yr', 16:44:34 INFO - 'ts_paint', 16:44:34 INFO - 'tpaint', 16:44:34 INFO - 'sessionrestore', 16:44:34 INFO - 'sessionrestore_no_auto_restore', 16:44:34 INFO - 'tabpaint']}, 16:44:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['a11yr', 16:44:34 INFO - 'ts_paint', 16:44:34 INFO - 'tpaint', 16:44:34 INFO - 'sessionrestore', 16:44:34 INFO - 'sessionrestore_no_auto_restore', 16:44:34 INFO - 'tabpaint']}, 16:44:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['tsvgx', 16:44:34 INFO - 'tsvgr_opacity', 16:44:34 INFO - 'tart', 16:44:34 INFO - 'tscrollx', 16:44:34 INFO - 'cart']}, 16:44:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:44:34 INFO - 'tsvgr_opacity', 16:44:34 INFO - 'tart', 16:44:34 INFO - 'tscrollx', 16:44:34 INFO - 'cart']}, 16:44:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:34 INFO - 'talos_options': ['--disable-e10s'], 16:44:34 INFO - 'tests': ['tp5o']}, 16:44:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:34 INFO - 'tests': ['tp5o']}, 16:44:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:34 INFO - 'talos_options': ['--disable-e10s', 16:44:34 INFO - '--xperf_path', 16:44:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:34 INFO - 'tests': ['tp5n']}, 16:44:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:34 INFO - 'talos_options': ['--xperf_path', 16:44:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:34 INFO - 'tests': ['tp5n']}}, 16:44:34 INFO - 'talos.zip': {'path': '', 16:44:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:44:34 INFO - Running post-action listener: _resource_record_post_action 16:44:34 INFO - [mozharness: 2016-08-29 23:44:34.750572Z] Finished populate-webroot step (success) 16:44:34 INFO - [mozharness: 2016-08-29 23:44:34.750700Z] Running create-virtualenv step. 16:44:34 INFO - Running pre-action listener: _resource_record_pre_action 16:44:34 INFO - Running main action method: create_virtualenv 16:44:34 INFO - Creating virtualenv /builds/slave/test/build/venv 16:44:34 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:44:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:44:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:44:34 INFO - Using real prefix '/tools/python27' 16:44:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:44:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:44:38 INFO - Installing pip.................done. 16:44:38 INFO - Return code: 0 16:44:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:38 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 0x103779a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10380e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9672d884b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:38 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:44:38 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:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:38 INFO - 'HOME': '/Users/cltbld', 16:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:38 INFO - 'LOGNAME': 'cltbld', 16:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:38 INFO - 'MOZ_NO_REMOTE': '1', 16:44:38 INFO - 'NO_EM_RESTART': '1', 16:44:38 INFO - 'PAGER': '/bin/cat', 16:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:38 INFO - 'PWD': '/builds/slave/test', 16:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:38 INFO - 'SHELL': '/bin/bash', 16:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:44:38 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:38 INFO - 'USER': 'cltbld', 16:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:38 INFO - 'XPC_FLAGS': '0x0', 16:44:38 INFO - 'XPC_SERVICE_NAME': '0', 16:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:38 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:44:38 INFO - Cleaning up... 16:44:38 INFO - Return code: 0 16:44:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:38 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 0x103779a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10380e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9672d884b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:38 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:44:38 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:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:38 INFO - 'HOME': '/Users/cltbld', 16:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:38 INFO - 'LOGNAME': 'cltbld', 16:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:38 INFO - 'MOZ_NO_REMOTE': '1', 16:44:38 INFO - 'NO_EM_RESTART': '1', 16:44:38 INFO - 'PAGER': '/bin/cat', 16:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:38 INFO - 'PWD': '/builds/slave/test', 16:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:38 INFO - 'SHELL': '/bin/bash', 16:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:44:38 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:38 INFO - 'USER': 'cltbld', 16:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:38 INFO - 'XPC_FLAGS': '0x0', 16:44:38 INFO - 'XPC_SERVICE_NAME': '0', 16:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:38 INFO - Downloading/unpacking psutil>=3.1.1 16:44:38 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:44:38 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:44:38 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:44:38 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:44:38 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:44:38 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:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:44:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:42 INFO - Installing collected packages: psutil 16:44:42 INFO - Running setup.py install for psutil 16:44:42 INFO - building 'psutil._psutil_osx' extension 16:44:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:44:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:44:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:44:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:44:43 INFO - building 'psutil._psutil_posix' extension 16:44:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:44:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:44:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:44:43 INFO - ^ 16:44:43 INFO - 1 warning generated. 16:44:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:44:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:43 INFO - Successfully installed psutil 16:44:43 INFO - Cleaning up... 16:44:43 INFO - Return code: 0 16:44:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:43 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 0x103779a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10380e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9672d884b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:43 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:44:43 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:44:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:44:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:43 INFO - 'HOME': '/Users/cltbld', 16:44:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:43 INFO - 'LOGNAME': 'cltbld', 16:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:43 INFO - 'MOZ_NO_REMOTE': '1', 16:44:43 INFO - 'NO_EM_RESTART': '1', 16:44:43 INFO - 'PAGER': '/bin/cat', 16:44:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:43 INFO - 'PWD': '/builds/slave/test', 16:44:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:43 INFO - 'SHELL': '/bin/bash', 16:44:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:44:43 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:44:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:43 INFO - 'USER': 'cltbld', 16:44:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:43 INFO - 'XPC_FLAGS': '0x0', 16:44:43 INFO - 'XPC_SERVICE_NAME': '0', 16:44:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:44:43 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:44:43 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:44:43 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:44:43 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:44:43 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:44:43 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:44:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:44:46 INFO - Installing collected packages: mozsystemmonitor 16:44:46 INFO - Running setup.py install for mozsystemmonitor 16:44:46 INFO - Successfully installed mozsystemmonitor 16:44:46 INFO - Cleaning up... 16:44:46 INFO - Return code: 0 16:44:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:44:46 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:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:46 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:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:46 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 0x103779a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10380e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9672d884b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:46 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:44:46 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:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:46 INFO - 'HOME': '/Users/cltbld', 16:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:46 INFO - 'LOGNAME': 'cltbld', 16:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:46 INFO - 'MOZ_NO_REMOTE': '1', 16:44:46 INFO - 'NO_EM_RESTART': '1', 16:44:46 INFO - 'PAGER': '/bin/cat', 16:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:46 INFO - 'PWD': '/builds/slave/test', 16:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:46 INFO - 'SHELL': '/bin/bash', 16:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:44:46 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:46 INFO - 'USER': 'cltbld', 16:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:46 INFO - 'XPC_FLAGS': '0x0', 16:44:46 INFO - 'XPC_SERVICE_NAME': '0', 16:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:46 INFO - Downloading/unpacking jsonschema==2.5.1 16:44:46 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:44:46 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:44:46 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:44:46 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:44:46 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:44:46 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:44:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:44:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:49 INFO - Downloading functools32-3.2.3-2.tar.gz 16:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:44:50 INFO - warning: no files found matching '*.txt' 16:44:50 INFO - no previously-included directories found matching 'build' 16:44:50 INFO - no previously-included directories found matching 'dist' 16:44:50 INFO - no previously-included directories found matching '.git*' 16:44:50 INFO - Installing collected packages: jsonschema, functools32 16:44:50 INFO - Running setup.py install for functools32 16:44:50 INFO - warning: no files found matching '*.txt' 16:44:50 INFO - no previously-included directories found matching 'build' 16:44:50 INFO - no previously-included directories found matching 'dist' 16:44:50 INFO - no previously-included directories found matching '.git*' 16:44:50 INFO - Successfully installed jsonschema functools32 16:44:50 INFO - Cleaning up... 16:44:50 INFO - Return code: 0 16:44:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:44:50 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:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:50 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:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:50 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 0x103779a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10380e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9672d884b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:50 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:44:50 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:44:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:44:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:50 INFO - 'HOME': '/Users/cltbld', 16:44:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:50 INFO - 'LOGNAME': 'cltbld', 16:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:50 INFO - 'MOZ_NO_REMOTE': '1', 16:44:50 INFO - 'NO_EM_RESTART': '1', 16:44:50 INFO - 'PAGER': '/bin/cat', 16:44:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:50 INFO - 'PWD': '/builds/slave/test', 16:44:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:50 INFO - 'SHELL': '/bin/bash', 16:44:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:44:50 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:44:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:50 INFO - 'USER': 'cltbld', 16:44:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:50 INFO - 'XPC_FLAGS': '0x0', 16:44:50 INFO - 'XPC_SERVICE_NAME': '0', 16:44:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:44:50 INFO - Cleaning up... 16:44:50 INFO - Return code: 0 16:44:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:44:50 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:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:50 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:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:50 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 0x103779a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10380e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9672d884b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:50 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:44:50 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:44:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:44:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:50 INFO - 'HOME': '/Users/cltbld', 16:44:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:50 INFO - 'LOGNAME': 'cltbld', 16:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:50 INFO - 'MOZ_NO_REMOTE': '1', 16:44:50 INFO - 'NO_EM_RESTART': '1', 16:44:50 INFO - 'PAGER': '/bin/cat', 16:44:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:50 INFO - 'PWD': '/builds/slave/test', 16:44:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:50 INFO - 'SHELL': '/bin/bash', 16:44:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:44:50 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:44:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:50 INFO - 'USER': 'cltbld', 16:44:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:50 INFO - 'XPC_FLAGS': '0x0', 16:44:50 INFO - 'XPC_SERVICE_NAME': '0', 16:44:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:50 INFO - Downloading/unpacking blobuploader==1.2.4 16:44:50 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:44:50 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:44:50 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:44:50 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:44:50 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:44:50 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:44:53 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44:53 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:44:53 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:44:53 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:44:53 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:44:53 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:44:53 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:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:44:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:54 INFO - Downloading docopt-0.6.1.tar.gz 16:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:54 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:54 INFO - Running setup.py install for blobuploader 16:44:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:44:54 INFO - Running setup.py install for requests 16:44:55 INFO - Running setup.py install for docopt 16:44:55 INFO - Successfully installed blobuploader requests docopt 16:44:55 INFO - Cleaning up... 16:44:55 INFO - Return code: 0 16:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:55 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:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:55 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:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:55 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 0x103779a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10380e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9672d884b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:55 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:44:55 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:44:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:44:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:55 INFO - 'HOME': '/Users/cltbld', 16:44:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:55 INFO - 'LOGNAME': 'cltbld', 16:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:55 INFO - 'MOZ_NO_REMOTE': '1', 16:44:55 INFO - 'NO_EM_RESTART': '1', 16:44:55 INFO - 'PAGER': '/bin/cat', 16:44:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:55 INFO - 'PWD': '/builds/slave/test', 16:44:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:55 INFO - 'SHELL': '/bin/bash', 16:44:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:44:55 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:44:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:55 INFO - 'USER': 'cltbld', 16:44:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:55 INFO - 'XPC_FLAGS': '0x0', 16:44:55 INFO - 'XPC_SERVICE_NAME': '0', 16:44:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:55 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-I7sv4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:55 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-dhTRqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:55 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-tHOGBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:55 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Ut0STR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:56 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-6TIc8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:56 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-22gaP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:56 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-DdZr9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:56 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-EEbdw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:56 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-tRu5mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:56 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-PPghF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:56 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-trRe6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:56 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-rCmAjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:56 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-DTXZqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-7OFtc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-aHsD_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-m5LXws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ho5fbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:44:57 INFO - Running setup.py install for manifestparser 16:44:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:44:57 INFO - Running setup.py install for mozcrash 16:44:57 INFO - Running setup.py install for mozdebug 16:44:57 INFO - Running setup.py install for mozdevice 16:44:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:44:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:44:58 INFO - Running setup.py install for mozfile 16:44:58 INFO - Running setup.py install for mozhttpd 16:44:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:44:58 INFO - Running setup.py install for mozinfo 16:44:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:44:58 INFO - Running setup.py install for mozInstall 16:44:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:44:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:44:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:44:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:44:58 INFO - Running setup.py install for mozleak 16:44:58 INFO - Running setup.py install for mozlog 16:44:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:44:58 INFO - Running setup.py install for moznetwork 16:44:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:44:59 INFO - Running setup.py install for mozprocess 16:44:59 INFO - Running setup.py install for mozprofile 16:44:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:44:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:44:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:44:59 INFO - Running setup.py install for mozrunner 16:44:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:44:59 INFO - Running setup.py install for mozscreenshot 16:44:59 INFO - Running setup.py install for moztest 16:44:59 INFO - Running setup.py install for mozversion 16:44:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:44:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:59 INFO - Cleaning up... 16:45:00 INFO - Return code: 0 16:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:00 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 0x103779a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10380e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9672d884b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:45:00 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:45:00 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:45:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:45:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:45:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:45:00 INFO - 'HOME': '/Users/cltbld', 16:45:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:45:00 INFO - 'LOGNAME': 'cltbld', 16:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:00 INFO - 'MOZ_NO_REMOTE': '1', 16:45:00 INFO - 'NO_EM_RESTART': '1', 16:45:00 INFO - 'PAGER': '/bin/cat', 16:45:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:00 INFO - 'PWD': '/builds/slave/test', 16:45:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:45:00 INFO - 'SHELL': '/bin/bash', 16:45:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:45:00 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:45:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:45:00 INFO - 'USER': 'cltbld', 16:45:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:45:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:00 INFO - 'XPC_FLAGS': '0x0', 16:45:00 INFO - 'XPC_SERVICE_NAME': '0', 16:45:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:00 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-fZo68i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:00 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:00 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-QJlOLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:00 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-HImDO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:00 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:00 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-d5h9Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:00 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-I_bQAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:00 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:00 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-IPsMz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:00 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:00 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-VzLyhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:01 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-xmr5NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:01 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-r8ZDsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:01 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-5aaCyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:01 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-d6XuUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:01 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-vcX9Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:01 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-zRwOi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:01 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-bdripb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:01 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-lh35rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:01 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-cMf3_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:01 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Ey5aLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:02 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:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:45:02 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:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:45:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:04 INFO - Downloading blessings-1.6.tar.gz 16:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:45:04 INFO - Installing collected packages: blessings 16:45:04 INFO - Running setup.py install for blessings 16:45:04 INFO - Successfully installed blessings 16:45:04 INFO - Cleaning up... 16:45:04 INFO - Return code: 0 16:45:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:45:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:05 INFO - Reading from file tmpfile_stdout 16:45:05 INFO - Current package versions: 16:45:05 INFO - blessings == 1.6 16:45:05 INFO - blobuploader == 1.2.4 16:45:05 INFO - docopt == 0.6.1 16:45:05 INFO - functools32 == 3.2.3-2 16:45:05 INFO - jsonschema == 2.5.1 16:45:05 INFO - manifestparser == 1.1 16:45:05 INFO - mozInstall == 1.12 16:45:05 INFO - mozcrash == 0.17 16:45:05 INFO - mozdebug == 0.1 16:45:05 INFO - mozdevice == 0.48 16:45:05 INFO - mozfile == 1.2 16:45:05 INFO - mozhttpd == 0.7 16:45:05 INFO - mozinfo == 0.9 16:45:05 INFO - mozleak == 0.1 16:45:05 INFO - mozlog == 3.3 16:45:05 INFO - moznetwork == 0.27 16:45:05 INFO - mozprocess == 0.23 16:45:05 INFO - mozprofile == 0.28 16:45:05 INFO - mozrunner == 6.12 16:45:05 INFO - mozscreenshot == 0.1 16:45:05 INFO - mozsystemmonitor == 0.3 16:45:05 INFO - moztest == 0.7 16:45:05 INFO - mozversion == 1.4 16:45:05 INFO - psutil == 3.1.1 16:45:05 INFO - requests == 1.2.3 16:45:05 INFO - wsgiref == 0.1.2 16:45:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:05 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 0x103779a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10380e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9672d884b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:45:05 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:45:05 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:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:45:05 INFO - 'HOME': '/Users/cltbld', 16:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:45:05 INFO - 'LOGNAME': 'cltbld', 16:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:05 INFO - 'MOZ_NO_REMOTE': '1', 16:45:05 INFO - 'NO_EM_RESTART': '1', 16:45:05 INFO - 'PAGER': '/bin/cat', 16:45:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:05 INFO - 'PWD': '/builds/slave/test', 16:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:45:05 INFO - 'SHELL': '/bin/bash', 16:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:45:05 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:45:05 INFO - 'USER': 'cltbld', 16:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:05 INFO - 'XPC_FLAGS': '0x0', 16:45:05 INFO - 'XPC_SERVICE_NAME': '0', 16:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 INFO - Cleaning up... 16:45:05 INFO - Return code: 0 16:45:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:05 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 0x103779a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10380e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9672d884b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:45:05 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:45:05 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:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:45:05 INFO - 'HOME': '/Users/cltbld', 16:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:45:05 INFO - 'LOGNAME': 'cltbld', 16:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:05 INFO - 'MOZ_NO_REMOTE': '1', 16:45:05 INFO - 'NO_EM_RESTART': '1', 16:45:05 INFO - 'PAGER': '/bin/cat', 16:45:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:05 INFO - 'PWD': '/builds/slave/test', 16:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:45:05 INFO - 'SHELL': '/bin/bash', 16:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:45:05 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:45:05 INFO - 'USER': 'cltbld', 16:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:05 INFO - 'XPC_FLAGS': '0x0', 16:45:05 INFO - 'XPC_SERVICE_NAME': '0', 16:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:45:06 INFO - Cleaning up... 16:45:06 INFO - Return code: 0 16:45:06 INFO - Running post-action listener: _resource_record_post_action 16:45:06 INFO - Running post-action listener: _start_resource_monitoring 16:45:06 INFO - Starting resource monitoring. 16:45:06 INFO - [mozharness: 2016-08-29 23:45:06.209847Z] Finished create-virtualenv step (success) 16:45:06 INFO - [mozharness: 2016-08-29 23:45:06.210795Z] Running install step. 16:45:06 INFO - Running pre-action listener: _resource_record_pre_action 16:45:06 INFO - Running main action method: install 16:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:06 INFO - Reading from file tmpfile_stdout 16:45:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:45:06 INFO - Reading from file tmpfile_stdout 16:45:06 INFO - Output received: 16:45:06 INFO - Usage: mozinstall [options] installer 16:45:06 INFO - Options: 16:45:06 INFO - -h, --help show this help message and exit 16:45:06 INFO - -d DEST, --destination=DEST 16:45:06 INFO - Directory to install application into. [default: 16:45:06 INFO - "/builds/slave/test"] 16:45:06 INFO - --app=APP Application being installed. [default: firefox] 16:45:06 INFO - mkdir: /builds/slave/test/build/application 16:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:45:40 INFO - Reading from file tmpfile_stdout 16:45:40 INFO - Output received: 16:45:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:45:40 INFO - Running post-action listener: _resource_record_post_action 16:45:40 INFO - [mozharness: 2016-08-29 23:45:40.764735Z] Finished install step (success) 16:45:40 INFO - [mozharness: 2016-08-29 23:45:40.764869Z] Running run-tests step. 16:45:40 INFO - Running pre-action listener: _resource_record_pre_action 16:45:40 INFO - Running main action method: run_tests 16:45:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:45:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:45:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:45:40 INFO - 2016-08-29 16:45:40.779 screenresolution[1630:7451] starting screenresolution argv=screenresolution get 16:45:40 INFO - 2016-08-29 16:45:40.781 screenresolution[1630:7451] Display 0: 1600x1200x32@60 16:45:40 INFO - 2016-08-29 16:45:40.787 screenresolution[1631:7453] starting screenresolution argv=screenresolution list 16:45:40 INFO - Available Modes on Display 0 16:45:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:45:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:45:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:45:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:45:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:45:41 INFO - Intel Iris: 16:45:41 INFO - Chipset Model: Intel Iris 16:45:41 INFO - Type: GPU 16:45:41 INFO - Bus: Built-In 16:45:41 INFO - VRAM (Dynamic, Max): 1536 MB 16:45:41 INFO - Vendor: Intel (0x8086) 16:45:41 INFO - Device ID: 0x0a2e 16:45:41 INFO - Revision ID: 0x0009 16:45:41 INFO - Displays: 16:45:41 INFO - Display: 16:45:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:45:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:45:41 INFO - Display Serial Number: 1600x1200 60 16:45:41 INFO - Main Display: Yes 16:45:41 INFO - Mirror: Off 16:45:41 INFO - Online: Yes 16:45:41 INFO - Rotation: Supported 16:45:41 INFO - Return code: 0 16:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:45:41 INFO - Python 2.7.3 16:45:41 INFO - Return code: 0 16:45:41 INFO - grabbing minidump binary from tooltool 16:45:41 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:45:41 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/macosx64/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 0x1036ddd30>, '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 0x103442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036d5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:45:41 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:45:41 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:45:41 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:45:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:45:41 INFO - Return code: 0 16:45:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:45:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:45:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:45:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:45:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0377 --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:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgNNvGJhOY/Render', 16:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:45:41 INFO - 'HOME': '/Users/cltbld', 16:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:45:41 INFO - 'LOGNAME': 'cltbld', 16:45:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:45:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:41 INFO - 'MOZ_NO_REMOTE': '1', 16:45:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:45:41 INFO - 'NO_EM_RESTART': '1', 16:45:41 INFO - 'PAGER': '/bin/cat', 16:45:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:41 INFO - 'PWD': '/builds/slave/test', 16:45:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:45:41 INFO - 'SHELL': '/bin/bash', 16:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners', 16:45:41 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:45:41 INFO - 'USER': 'cltbld', 16:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:41 INFO - 'XPC_FLAGS': '0x0', 16:45:41 INFO - 'XPC_SERVICE_NAME': '0', 16:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:45:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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:45:41 INFO - mozversion application_buildid: 20160829144430 16:45:41 INFO - mozversion application_changeset: 29f27e5ab2177d8f4ee0c3c9eb06d8705985b14a 16:45:41 INFO - mozversion application_display_name: Nightly 16:45:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:45:41 INFO - mozversion application_name: Firefox 16:45:41 INFO - mozversion application_remotingname: firefox 16:45:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:45:41 INFO - mozversion application_vendor: Mozilla 16:45:41 INFO - mozversion application_version: 51.0a1 16:45:41 INFO - mozversion platform_buildid: 20160829144430 16:45:41 INFO - mozversion platform_changeset: 29f27e5ab2177d8f4ee0c3c9eb06d8705985b14a 16:45:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:45:41 INFO - mozversion platform_version: 51.0a1 16:45:41 INFO - using testdate: 1472514341 16:45:41 INFO - actual date: 1472514341 16:45:41 INFO - starting webserver on 'localhost:49265' 16:45:41 INFO - SUITE-START | Running 2 tests 16:45:41 INFO - TEST-START | dromaeo_css 16:45:41 INFO - operating with platform_type : mac_ 16:45:41 INFO - Initialising browser for dromaeo_css test... 16:45:41 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpqYWBbN/profile http://localhost:49265/getInfo.html) 16:45:44 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 16:45:44 INFO - PROCESS | 1641 | colorDepth:24 16:45:44 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 16:45:44 INFO - PROCESS | 1641 | __metrics 16:45:44 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 16:45:44 INFO - TEST-INFO | 1641: exit 0 16:45:44 INFO - Browser initialized. 16:45:44 INFO - Running cycle 1/1 for dromaeo_css test... 16:45:44 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpqYWBbN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:56 INFO - PROCESS | 1644 | RSS: Main: 244199424 16:45:56 INFO - PROCESS | 1644 | 16:46:46 INFO - PROCESS | 1644 | 1472514406566 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:48:59 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 16:49:00 INFO - PROCESS | 1644 | RSS: Main: 263655424 16:49:00 INFO - PROCESS | 1644 | 16:52:02 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 16:52:03 INFO - PROCESS | 1644 | RSS: Main: 268705792 16:52:03 INFO - PROCESS | 1644 | 16:55:05 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 16:55:05 INFO - PROCESS | 1644 | RSS: Main: 268984320 16:55:05 INFO - PROCESS | 1644 | 16:58:07 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 16:58:08 INFO - PROCESS | 1644 | RSS: Main: 268779520 16:58:08 INFO - PROCESS | 1644 | 17:01:11 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 17:01:11 INFO - PROCESS | 1644 | RSS: Main: 275910656 17:01:11 INFO - PROCESS | 1644 | 17:04:14 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 17:04:15 INFO - PROCESS | 1644 | RSS: Main: 279539712 17:04:15 INFO - PROCESS | 1644 | 17:04:15 INFO - PROCESS | 1644 | __start_tp_report 17:04:15 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 17:04:15 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 17:04:15 INFO - PROCESS | 1644 | |i|pagename|runs| 17:04:15 INFO - PROCESS | 1644 | |0;dojo.html;3295.868165273389;3313.734901207903;3361.8151001694896;3364.394409006378;3385.6952874241315;5445.482679145484;5452.482014208649;5464.453554644533;5500.20247064176;5536.197251398545;4083.795810209485;4105.630493255607;5401.108817045193;5501.752421141048;5510.476504732054;4990.1516742153735;5031;5051.343325367697;5087.491250874901;5200.973995130019;4187.695474683377;5163.173892177252;5213.113770658997;5223.164293713006;5234.764435600388;4034.8184331705143;4102.815373308208;5008.54923056923;5039.6700726578365;5115.846524604268;4739.909820741249;4991.176455884774;5009.874753131201;5048.343715317022;5074.9342638046055;3661.9267614647824;4754.310624959396;5029.346184995927;5081.974590127063;5090.083784918713;5348.197770334442;5459.617826752129;5484.945150548523;5575.219469274305;5653;4895.437024742165;5951.434613711691;5996.610220335708;6013.579049466539;6029.397060293935;6045.60703554272;6089.634621922654;6103.816885493442;6127.387261273837;6142.04798256271;5539.362973258087;5572.414896435897;5602.747876345574;5605.729679479818;5609.074502707008;6134.631922084689;6135.569531795964;6138.539609529304;6149.262088549313;6153.507719382439;5936.5250779937505;5952.910706339322;5956.583039187215;5985.401459854067;5985.760569577255;5973;5990.760369585168;6014.548908831855;6018.368071352533;6074.42292982166;5843.824685259449;5941.792037278675;5943.970280148572;6011.759529618854;6042.758289668364;5918.763249470059;6023.427774361428;6031.155638210654;6057;6065.696715164312;4795.112904112751;4823.662343635982;4858.416989961227;4881.267809828483;4894.975525122423;4310.89222769427;4312.849050283225;4324.870253892388;4378.927162845123;4399.5820397062225;4249.426327445817;5504.0643090674685;5532.30846144232;5536.307961504812;5554.50009499147;5955.493783028404;6023.66869822164;6065.878682426327;6066.211392519032;6067.575269731076;5490.780368785284;5540.667559946416;5571.13647384656;5578.107502799533;5601.271834661549;5266.7366631668265;5285.735713214324;5300.840974770763;5304.098303288373;5331.44019877915;6104.633721976696;6157.784477543264;6277.121203031579;6277.995520716663;6296.968515157395;6085;6113.902014424272;6114.71942267015;6123.923256659856;6129.740518962076;6247.468965138014;6254.3745625437095;6260.74957001733;6264.655443950626;6303.117563541016;5814.94185058144;5925.7925972592475;5960.284765828128;5986.88026239464;5992.161097446274;6037.396260374103;6088;6117.675163990694;6131.988406491147;6160.568760186744;5881.852953676193;5937.673427961504;5954.37479064692;5957.821265362046;5962.4633782959745;4310.331898555729;5756.913646295393;5931.970340148272;5936.109583562327;5938.228030356199;5113.974430127825;5204.947950520446;5365.973170134124;5444.863878403072;5827.825165245049;4919.188333925005;5862.560307976833;5864.912026319694;5894.469497745224;5921.822345329647;5628.887422251614;5670.886582268414;5679.290088738908;5696.515796157373;5797.101449275369 17:04:15 INFO - PROCESS | 1644 | |1;ext.html;473.313695142044;475.60287160221225;538.1550964984971;558.7876606889381;571.6627189957924;36787.264254714886;38774.80612596933;38842.22315553687;38864.99999999993;38873;34441.62233510663;39855.80072099643;40365.798171009104;40510;40545.189096218055;9435.198008169296;9715.174210192143;9719.56261968213;9722.465264410455;9730.075642813958;8364.498130112213;9653.034696530325;9657.855132172988;9743.51282435879;9743.805123897553;9731.902680973206;9750.414975101481;9755.365901216433;9769.413835169913;9774.218062554979;9656.662016829378;9732.513374331254;9732.805343893082;9751.073648003428;9751.804963900753;9617.422954622674;9701.611935522571;9729.173020293212;9732.562034708384;9742.610295588169;38169;38426.423603645686;38569.807150964065;38708.41937370942;38760.80619596912;3264.67353264674;3291.6050073991037;3311.2384151645015;3367.764256502046;3392.2028323343993;29892.252693682833;30374.84812575923;30869.845650771604;31429.74281028756;31640.208994775083;3215.8713651453913;3219.840857291373;3241.7082462578246;3256.234784825564;3283.96716032839;351160;354480;354598;354787;356867.9999999974;55482.342118945984;55896;55902.881942360924;56061.07572469888;56137.438625614035;33097;34057.659423405945;34197.65802341945;57777.71111144417;57807.42192578105;16021.359145634044;16172.676546469005;16176.919115404347;16218.432354867524;16226.837731622532;12275.877241227474;12351.444185011696;12365.876341236652;12367.69080772988;12372.690682732824;18861;18881.055947202585;18897.622047558973;18908.149133289036;18923.43229703111;6845.589264644137;7958;8086.7169649062;8175.264226219669;8203.876941845878;877.7542288159326;929.9256059515222;953.6743925942944;976.584951395654;1006.1699098243978;28797.424051518854;29841;29929.802807887878;29932.251693707396;30168.09495715132;918.5499105438421;1021.2544842265188;1091.3397394576168;1093.147345070846;1226.6749311432477;13277.535286264934;15169.620759481102;15187.924060379848;15445.996010259298;15540.145292009049;638536;888297;910470;910709;913291;56005.1599226012;56290.718546407006;56626.150607740914;56781.14828277579;56926.43073569211;1235.6293112066344;1315.81578578999;1371.766799644063;1390.3395886953817;1396.0437100585928;29917.21665201691;30333.696663033086;30467.085987420414;30534.236644083187;30821.22946926345;37407.81296093502;40562.594374057066;48684;49168;49168.01663966629;503416;542436;592838;609900;610144;26060.609090864033;26417.735822642295;26448.20655380342;26479.470410592065;26500.469990599693;38168.80915595404;43455.348169776844;44079.77960110179;44972.10055798931;45260;36942.63057369392;37466;38116.809415952746;38354;38403.42394864135;32549;33204.83783067581;34576.65423345835;37389;38322.041948950384;32373.866914657872;36547.81726091352;36859.89420317395;37544.87365379043;38173.80913095417;32436.83781581077;33607;34030;34099.829500852335;34171.80398686034;25100.49799003973;25273.87363063173;25446.74553254444;25890.611640825027;25954 17:04:15 INFO - PROCESS | 1644 | |2;jquery.html;311.5420332111795;361.82270687363194;368.4602057985052;382.64414094891737;395.12085609518823;19985.60028799425;20340.08469618867;21237.256696015644;21724.456888577773;21986.89006554969;17684.11579421027;20895.164193432283;21215.893920530376;21668.724783897702;21709.782902170973;5779.537636989052;5844.2402487676545;6002.339742628307;6022.307434645006;6099.268087829467;5089.287499750038;5577.358603760558;5712.429082002441;6112.602680825755;6122.0816877468515;5634.4928956393915;6521.836954076139;6784.626845523494;6788.864222715542;6830.965845170767;6054.576179667425;6162.722677479502;6211.596246243979;6387.233531976146;6972.1284839395075;5844.824655260349;5957.523398128139;6056.909146362764;6064.483879030243;6077.665728384937;12986.935065324707;13378.39797209128;13427;13428.93285533566;13489.932550337284;1707.513358692779;2099.6745504446835;2160.2439146298825;2312.9306120816404;2349.3304408243566;9991.050850169222;10134.391936483835;10223.182145428422;13349;15457.995230309994;1677.9161041947855;1806.2955447375534;1877.558773688182;1892.9053547322578;1910.4268719384268;113292.30061549084;119477;126032.99999999908;127727;130480;9528.333016688905;10794.838077428845;11323;11398.544058237743;11659.825102623467;14464.27678616065;14485.275736213147;14490.058146220672;14495;14507.057041292283;8141.715039973573;8375.790605234795;8402.915970840213;8438.620262088221;8576.571171441403;7143.785686429312;8308.210719981593;8368.539730314891;8391.622376992927;8533.487990720576;4480.775961201927;4499.212637788374;4542.068875880503;4556.72659640416;4616.653750968623;1908.4656296237076;1918.194358369488;1932.8743631664179;1943.65014297425;1971.3888694504749;825.471698113208;858.7895965488495;921;996.2528103922059;1012.8126296635146;21475.355739327846;21978.670319945213;22025.559488810133;22063.889680551496;22181.223657171922;920.6501529418778;922.1608336413965;930.9115634014757;968.1915600473543;1003.8694969653898;9716.514174291256;10237.641682541076;10587.311824731521;11106.889311068828;11445.713857153638;504561;567341;571423.285767137;587981;588733;89477.55261223653;123004.99999999821;127189.32651849034;129806;136979;958.6405098088356;966.8308046091905;1006.5219020965129;1008.1884083312857;1020.9540570674337;19485.51286217856;19861.702074469184;19985.800141998974;20135.899320503304;20139.69790453174;40637.79681101575;54462.91074178574;54721.72639136779;56499;57001.429985699615;79317.60341198256;80438.59780701059;82027;82309.58845205736;84001;7977.242161994601;8020.919790802017;8041.718539851077;8243.340532757486;8251.917480825115;11189.496472658588;12998.350082495648;13085.542006029744;13279;13305.135166214164;9305.627774888928;9493.525323733924;11257.71855703614;11304.717382065513;11356.602518911799;8058.8314694370165;10201.38791672502;10600.522976465923;10770.461476925966;10879.401632910265;6687.598744075371;9231.123043310874;11239.943800280946;11580.6525804226;11716.882831171579;6763.458923286224;6823.931760682528;7886.132525422085;7980.640871160927;8279.62741676614;9488.33581649278;11306.547738090385;11567;11575.13186511032;11649.41752912334 17:04:15 INFO - PROCESS | 1644 | |3;mootools.html;1348.6089034180088;1521.634807646165;1707.120832771123;1839.6504664113825;1867.3744295660945;7590.58251796151;7912.723054693087;8381.91618083819;8547.444416112949;8929.1517305856;7869.055713314396;8396;8550.91449085509;8742.256908162797;8760.474371537712;2355.646653002046;2385.33210701004;2387.140629373424;2388.984681510351;2399.36416849535;2371.6561098640686;2389.9761002390014;2419.3104965084954;2424.284835973392;2425.333033415816;2367.360812580602;2378.9762102379013;2385.9642105368434;2390.8206884483648;2402.4714562796157;2344.730356009047;2353.52929414117;2359.752226016269;2370.8103351731907;2380.27401642499;2353.3528279723214;2366.408397900525;2368.4907744834945;2375.0737212487143;2375.358653163636;8532.82934341316;8597.312215022783;8686.218240358397;8693.391462597621;8705.129487051308;5157.896842063175;5301.257823904656;5310.309659744208;5314.362276526842;5322.680639161624;3604.2431089471243;3633.1643721943838;3663.084228942764;3682.5396825396824;3695.150115473429;1094.162965331522;1095.7917995580895;1101.24014430043;1114.6433141394757;1117.357519426325;11320.49057792393;11409;11410.20128590999;11410.771784564346;11432.485538150886;4526.909461810746;4676.018036212366;4803.903921921612;4860.441049279378;4866.659333846667;9715;9796.167325777245;9828.606855725833;9829.21366290695;9845.064718851841;5258.368995720538;5265.552428043659;5282.6302158849285;5286.444923283077;5296.708681022581;4369.3227549729845;4566.20091483989;4617.030423611012;4635.907281854344;4838.564529192319;3862.5364956205435;3969.464122343447;3973.980130099389;4000.7199496035;4069.7558146511305;1296.7113045474744;1302.257713103541;1306.7059911520023;1314.90795644304;1315.8486774020919;902.7111324376136;922.31748506105;929.688554334292;934;944.9763755906157;5720.2849643794525;5988.4909782668965;5995.980683283852;6060.939390606126;6175.166352542439;355.88077993872344;416.8728537795941;423.26985949237934;433.81996471463987;435.0906605195094;3957.3866050762176;3986.740861844029;4031.4355990161403;4033.233685599727;4090.9795451022555;10284.691459256233;10512.3692578444;10623.256372053882;10649.988251116132;10669.51987160564;10542.947285263677;10609.73475663099;10620.415877126678;10634.89365106339;10690.625828096136;7390.704371825174;7497.362724168398;7787.338076263468;8116.310113640288;8270.172982701803;5797.159411885337;5801.941980580309;5851.356350801323;5898.911516327173;5992.161097446448;9651.951740241253;9820.950895245478;9938.552765125442;9948.651797187063;9972.351797133164;7444.962775186089;8095.959520202361;8937.508437036025;10034;10053.095221430107;6628.972509261072;6663.067170596023;6904.896426553505;7275.927240727737;7421.740239091606;8291.212334828182;8317.251447369767;8401.579921004048;8413.3269338454;8421.95789021051;7281.235470275757;7389.261073892568;7402.29678180572;7447.292507211806;7514.286142816423;7073.151221853411;7444.553326800409;7511.098668159637;7528.284812942762;7582.090149182133;6801.931980680328;6877.140357455318;6900.689468974008;6964.6517674115075;6980.267071957372;4889.755512224303;4949.183384741621;5086.872828179326;5206.713630750345;5251.186066159751;4969.875753106201;5038.168702164102;5106;5181.896362072813;5308.46915308466 17:04:15 INFO - PROCESS | 1644 | |4;prototype.html;294.939537394834;297.4155783884666;302.2805722380734;309.6856690459183;312.2739630359415;4865.829695960642;5209.609279304048;5417.91873121903;5530.834074977747;5551.6668999859985;5263.736813159337;5343.625946183769;5430.185472179165;5456.590755693319;5463.180522921563;3709.312262920365;4031.879043628696;4174.749515029092;4194.266003449384;4195.202911446823;3490.7381946354;3842.7886466244345;3994.460747799039;4151.605597468236;4217.36739489076;3378.2061215614312;3681.852725890961;3995.5405128410316;4051.635352818246;4069.2268468990947;3266.4936934775146;3443.6039855416698;3693.409054551272;4077.8980525486804;4082.4896887889013;3342.6490218526947;3549.6450354964554;3550.6271841456532;3554.2003049313957;3565.7682250653884;5112.514311140473;5282.10204265272;5294.814681486168;5328.733563321818;5406;4625.560571745713;4626;4629.884252893671;4645.187092258841;4657.182404645208;4852.344933433977;5687.374388817227;5762.423757624246;5791.160281759121;5798.825440459827;3354.26206234628;3717.832697528591;3800.1639639279592;3851.84592616295;3861.9806900965596;4916.598769350718;5305.549028332558;5313.495217954288;5600.6079574429805;6047.485963693091;3922.725409221327;3928.1145050375408;3930;3935.5277366715604;3963.286608410456;3639.7998110103667;3641.7268704847243;3802.524684414448;3994.881433198709;4088.6115818997146;4380.014496738208;4484.955150448519;4735.171345014609;4753.809847606057;4804.159272127364;5811.27359080115;5820.941790582125;5825.2135961644635;5831.183634291203;5893;1294.695746499572;1368.9931550342185;1382.903196776216;1412.8587141285789;1423.3381477612752;946.8911075226437;947.7298969793576;967.1537404770826;975.1077763846143;978.6476868327396;4197.979010104991;5291.523762861361;5311.867203319871;5319.6808191508635;5340.359156901197;5595.664260144405;5751.1373294006235;5849.221619730679;5859.1797148399255;5921.348651648315;4476.843310484118;4583.885402864955;4939.986608169014;5267.815626453055;5369.704666243394;2732.726727327291;2909.9815064727177;3138.4507711150914;3165.841707914595;3176.2059485128716;5611.831645050655;5836.803455291655;6120.540959428061;6227.314995350508;6248.969249913788;5186.784193799793;5261.932018098152;5499.790046189832;5853.765849366063;5945.970270148708;4590.272019819591;6016.42843929826;6158.291796443376;6167.660778657217;6221.2845522764555;5553.556794787258;5931.673757943355;5973.55198360116;6017.68319197121;6042.305134909541;4552.817887284472;5313.442088580643;5779.739911703899;5939.762409503572;5953.583249172516;6154.876902462015;6233.563650544418;6241.095041218907;6257.311695713377;6276.403741644536;2946.705329467122;2974.509205980989;3744.6255374462335;3883.165119499321;3942.4677668515533;5380.946190538045;5933.970330148494;5938.881222375615;6011.819645410645;6018.759249629966;5592.189132575672;5767;5828.76684932598;5829.446202610745;5875.294964604275;5238.921416178684;5373.650712703662;5789.205346342647;5801.419858014165;5807.709614519342;4476.955230447654;5361.678299302054;5686;5686.317641883001;5701.116326969326;4560.452745670408;5774.249347584955;5804.593678442468;5847.251791657914;5920.822375328747;5734.942650573441;5750.9712451439145;5763.4812866842185;5769;5804.1874137619925 17:04:15 INFO - PROCESS | 1644 | |5;yui.html;678.3894494954541;704.6124631452703;724.807925899637;769.3883362726632;828.8590939540278;14968;15439.382424702999;15723.292451839667;15862.682746345066;15918;12998.41507132179;14559.27203639819;14664.780028299583;14715.926420367883;14738.852611473882;846.1707526623912;874.7419511244167;880.3881302494768;880.5861245214738;881.0968757024037;669.6752075243503;838.5597561280316;865.7186414415308;871.5075982070142;879.9120087991182;877.4910551879926;892.4466830565026;922.4972390047441;924.9260059195282;926.4302453990814;912.8037471943497;916.7341470973442;918.6233644205877;919.8758167647416;921.5438358012759;648.6691787188521;664.315754772585;683.8871586188322;684.4763755726823;687.3092541995263;14000.509982150576;14084.225367604779;14214.289285535682;14338.068025578305;14572;13928.860711392857;14007.089539180022;14183.43266269348;14191.716165676731;14291.285435728172;10072.546735396925;11928.46321915516;11949.940250298692;12012.399380030964;12047.6385708428;3324.4514655081884;3798.392257238856;3806.619338066199;3818.2363527294374;3949.921001579981;97144.51427742887;97791;102275;117765.23352149638;118846.81153188444;8926.509042002752;10908.945455272831;11149.21955463126;11239.55041798319;11302.208845380908;21430;21777.34667959932;21778.34664960054;21779.346619601438;22020.009099590556;7895.855101010321;7949.125596184415;8087.353011759045;8168.469049511763;8298.21166989135;4511.481179664381;4571.268597024527;4617.422822147231;4642.744649044335;4714.717116972924;3555.7333200010103;3674.283514714605;3693.649103335179;3701.3152566775234;3707.3882809336155;664.2858926653867;669.1568623534382;673.1215763428675;683.1153656015472;695.5166159519187;560.8850185712001;618.848382146377;667.8230268978724;690.5532908556565;695.384584642595;9405.90594094064;9533.52332383378;9555.092266234697;9641;9770.609175632895;565.1423000598764;607.1348328631682;667.3560014585947;674.4402146218627;676.8307923019245;4490.101979604092;4664.533546645308;4677.906441871211;4690.835820746258;4713.717176969393;157103.21448392686;159441;159855.40144598638;161395;163653.18173409055;136063.31968340094;140772.257525835;141607.29196353952;142679;143294;75388;110200.69397918075;118602.40698796623;120525;126508;7066.505344625827;9568.808623827623;9724.659636912675;9791.902080979098;10039.397636141855;51621;59665.70167149136;59717.701411492664;60934.69532652486;65651.01523477056;65772.67113664401;67453.66273168602;72304;86870;89319;10023.448710321003;11355.37545434976;11381.886181138083;12620.801023902715;12879.35603219854;12794.68013299675;13301.933490332873;14436.855631443552;14621.63445913818;15462.675270873115;9705.6603018894;13858.514951976633;14192.929035354757;14251.714965700836;14406.351714173097;11259.437028148395;13756.587302380945;13819;14428.278586070865;14434.494792682206;13550.39023243976;13869;14229.288535572972;14238.501652442115;14365.92817035908;10487.108595769445;11342.319460832376;11581.536738530365;11594.768104637691;11604.245724027911;9572.61392244757;11518.408039480155;11675.766484670428;11736.530538778354;11836.230645008047 17:04:15 INFO - PROCESS | 1644 | __end_tp_report 17:04:15 INFO - PROCESS | 1644 | __start_cc_report 17:04:15 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,382 17:04:15 INFO - PROCESS | 1644 | __end_cc_report 17:04:15 INFO - PROCESS | 1644 | __startTimestamp1472515455120__endTimestamp 17:04:15 INFO - PROCESS | 1644 | 17:04:15 INFO - PROCESS | 1644 | ------- Summary: start ------- 17:04:15 INFO - PROCESS | 1644 | Number of tests: 6 17:04:15 INFO - PROCESS | 1644 | 17:04:15 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5501.27 Median:5653.00 stddev:689.10 (12.2%) stddev-sans-first:669.15 17:04:15 INFO - PROCESS | 1644 | Values: 3295.9 3313.7 3361.8 3364.4 3385.7 5445.5 5452.5 5464.5 5500.2 5536.2 4083.8 4105.6 5401.1 5501.8 5510.5 4990.2 5031.0 5051.3 5087.5 5201.0 4187.7 5163.2 5213.1 5223.2 5234.8 4034.8 4102.8 5008.5 5039.7 5115.8 4739.9 4991.2 5009.9 5048.3 5074.9 3661.9 4754.3 5029.3 5082.0 5090.1 5348.2 5459.6 5484.9 5575.2 5653.0 4895.4 5951.4 5996.6 6013.6 6029.4 6045.6 6089.6 6103.8 6127.4 6142.0 5539.4 5572.4 5602.7 5605.7 5609.1 6134.6 6135.6 6138.5 6149.3 6153.5 5936.5 5952.9 5956.6 5985.4 5985.8 5973.0 5990.8 6014.5 6018.4 6074.4 5843.8 5941.8 5944.0 6011.8 6042.8 5918.8 6023.4 6031.2 6057.0 6065.7 4795.1 4823.7 4858.4 4881.3 4895.0 4310.9 4312.8 4324.9 4378.9 4399.6 4249.4 5504.1 5532.3 5536.3 5554.5 5955.5 6023.7 6065.9 6066.2 6067.6 5490.8 5540.7 5571.1 5578.1 5601.3 5266.7 5285.7 5300.8 5304.1 5331.4 6104.6 6157.8 6277.1 6278.0 6297.0 6085.0 6113.9 6114.7 6123.9 6129.7 6247.5 6254.4 6260.7 6264.7 6303.1 5814.9 5925.8 5960.3 5986.9 5992.2 6037.4 6088.0 6117.7 6132.0 6160.6 5881.9 5937.7 5954.4 5957.8 5962.5 4310.3 5756.9 5932.0 5936.1 5938.2 5114.0 5204.9 5366.0 5444.9 5827.8 4919.2 5862.6 5864.9 5894.5 5921.8 5628.9 5670.9 5679.3 5696.5 5797.1 17:04:15 INFO - PROCESS | 1644 | 17:04:15 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:70926.02 Median:37830.84 stddev:170324.01 (450.2%) stddev-sans-first:170719.67 17:04:15 INFO - PROCESS | 1644 | Values: 473.3 475.6 538.2 558.8 571.7 36787.3 38774.8 38842.2 38865.0 38873.0 34441.6 39855.8 40365.8 40510.0 40545.2 9435.2 9715.2 9719.6 9722.5 9730.1 8364.5 9653.0 9657.9 9743.5 9743.8 9731.9 9750.4 9755.4 9769.4 9774.2 9656.7 9732.5 9732.8 9751.1 9751.8 9617.4 9701.6 9729.2 9732.6 9742.6 38169.0 38426.4 38569.8 38708.4 38760.8 3264.7 3291.6 3311.2 3367.8 3392.2 29892.3 30374.8 30869.8 31429.7 31640.2 3215.9 3219.8 3241.7 3256.2 3284.0 351160.0 354480.0 354598.0 354787.0 356868.0 55482.3 55896.0 55902.9 56061.1 56137.4 33097.0 34057.7 34197.7 57777.7 57807.4 16021.4 16172.7 16176.9 16218.4 16226.8 12275.9 12351.4 12365.9 12367.7 12372.7 18861.0 18881.1 18897.6 18908.1 18923.4 6845.6 7958.0 8086.7 8175.3 8203.9 877.8 929.9 953.7 976.6 1006.2 28797.4 29841.0 29929.8 29932.3 30168.1 918.5 1021.3 1091.3 1093.1 1226.7 13277.5 15169.6 15187.9 15446.0 15540.1 638536.0 888297.0 910470.0 910709.0 913291.0 56005.2 56290.7 56626.2 56781.1 56926.4 1235.6 1315.8 1371.8 1390.3 1396.0 29917.2 30333.7 30467.1 30534.2 30821.2 37407.8 40562.6 48684.0 49168.0 49168.0 503416.0 542436.0 592838.0 609900.0 610144.0 26060.6 26417.7 26448.2 26479.5 26500.5 38168.8 43455.3 44079.8 44972.1 45260.0 36942.6 37466.0 38116.8 38354.0 38403.4 32549.0 33204.8 34576.7 37389.0 38322.0 32373.9 36547.8 36859.9 37544.9 38173.8 32436.8 33607.0 34030.0 34099.8 34171.8 25100.5 25273.9 25446.7 25890.6 25954.0 17:04:15 INFO - PROCESS | 1644 | 17:04:15 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:33855.04 Median:336.68 stddev:94711.46 (28130.8%) stddev-sans-first:94943.66 17:04:15 INFO - PROCESS | 1644 | Values: 311.5 361.8 368.5 382.6 395.1 19985.6 20340.1 21237.3 21724.5 21986.9 17684.1 20895.2 21215.9 21668.7 21709.8 5779.5 5844.2 6002.3 6022.3 6099.3 5089.3 5577.4 5712.4 6112.6 6122.1 5634.5 6521.8 6784.6 6788.9 6831.0 6054.6 6162.7 6211.6 6387.2 6972.1 5844.8 5957.5 6056.9 6064.5 6077.7 12986.9 13378.4 13427.0 13428.9 13489.9 1707.5 2099.7 2160.2 2312.9 2349.3 9991.1 10134.4 10223.2 13349.0 15458.0 1677.9 1806.3 1877.6 1892.9 1910.4 113292.3 119477.0 126033.0 127727.0 130480.0 9528.3 10794.8 11323.0 11398.5 11659.8 14464.3 14485.3 14490.1 14495.0 14507.1 8141.7 8375.8 8402.9 8438.6 8576.6 7143.8 8308.2 8368.5 8391.6 8533.5 4480.8 4499.2 4542.1 4556.7 4616.7 1908.5 1918.2 1932.9 1943.7 1971.4 825.5 858.8 921.0 996.3 1012.8 21475.4 21978.7 22025.6 22063.9 22181.2 920.7 922.2 930.9 968.2 1003.9 9716.5 10237.6 10587.3 11106.9 11445.7 504561.0 567341.0 571423.3 587981.0 588733.0 89477.6 123005.0 127189.3 129806.0 136979.0 958.6 966.8 1006.5 1008.2 1021.0 19485.5 19861.7 19985.8 20135.9 20139.7 40637.8 54462.9 54721.7 56499.0 57001.4 79317.6 80438.6 82027.0 82309.6 84001.0 7977.2 8020.9 8041.7 8243.3 8251.9 11189.5 12998.4 13085.5 13279.0 13305.1 9305.6 9493.5 11257.7 11304.7 11356.6 8058.8 10201.4 10600.5 10770.5 10879.4 6687.6 9231.1 11239.9 11580.7 11716.9 6763.5 6823.9 7886.1 7980.6 8279.6 9488.3 11306.5 11567.0 11575.1 11649.4 17:04:15 INFO - PROCESS | 1644 | 17:04:15 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5620.97 Median:5062.52 stddev:3107.30 (61.4%) stddev-sans-first:3099.43 17:04:15 INFO - PROCESS | 1644 | Values: 1348.6 1521.6 1707.1 1839.7 1867.4 7590.6 7912.7 8381.9 8547.4 8929.2 7869.1 8396.0 8550.9 8742.3 8760.5 2355.6 2385.3 2387.1 2389.0 2399.4 2371.7 2390.0 2419.3 2424.3 2425.3 2367.4 2379.0 2386.0 2390.8 2402.5 2344.7 2353.5 2359.8 2370.8 2380.3 2353.4 2366.4 2368.5 2375.1 2375.4 8532.8 8597.3 8686.2 8693.4 8705.1 5157.9 5301.3 5310.3 5314.4 5322.7 3604.2 3633.2 3663.1 3682.5 3695.2 1094.2 1095.8 1101.2 1114.6 1117.4 11320.5 11409.0 11410.2 11410.8 11432.5 4526.9 4676.0 4803.9 4860.4 4866.7 9715.0 9796.2 9828.6 9829.2 9845.1 5258.4 5265.6 5282.6 5286.4 5296.7 4369.3 4566.2 4617.0 4635.9 4838.6 3862.5 3969.5 3974.0 4000.7 4069.8 1296.7 1302.3 1306.7 1314.9 1315.8 902.7 922.3 929.7 934.0 945.0 5720.3 5988.5 5996.0 6060.9 6175.2 355.9 416.9 423.3 433.8 435.1 3957.4 3986.7 4031.4 4033.2 4091.0 10284.7 10512.4 10623.3 10650.0 10669.5 10542.9 10609.7 10620.4 10634.9 10690.6 7390.7 7497.4 7787.3 8116.3 8270.2 5797.2 5801.9 5851.4 5898.9 5992.2 9652.0 9821.0 9938.6 9948.7 9972.4 7445.0 8096.0 8937.5 10034.0 10053.1 6629.0 6663.1 6904.9 7275.9 7421.7 8291.2 8317.3 8401.6 8413.3 8422.0 7281.2 7389.3 7402.3 7447.3 7514.3 7073.2 7444.6 7511.1 7528.3 7582.1 6801.9 6877.1 6900.7 6964.7 6980.3 4889.8 4949.2 5086.9 5206.7 5251.2 4969.9 5038.2 5106.0 5181.9 5308.5 17:04:15 INFO - PROCESS | 1644 | 17:04:15 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4628.89 Median:5300.18 stddev:1463.59 (27.6%) stddev-sans-first:1431.09 17:04:15 INFO - PROCESS | 1644 | Values: 294.9 297.4 302.3 309.7 312.3 4865.8 5209.6 5417.9 5530.8 5551.7 5263.7 5343.6 5430.2 5456.6 5463.2 3709.3 4031.9 4174.7 4194.3 4195.2 3490.7 3842.8 3994.5 4151.6 4217.4 3378.2 3681.9 3995.5 4051.6 4069.2 3266.5 3443.6 3693.4 4077.9 4082.5 3342.6 3549.6 3550.6 3554.2 3565.8 5112.5 5282.1 5294.8 5328.7 5406.0 4625.6 4626.0 4629.9 4645.2 4657.2 4852.3 5687.4 5762.4 5791.2 5798.8 3354.3 3717.8 3800.2 3851.8 3862.0 4916.6 5305.5 5313.5 5600.6 6047.5 3922.7 3928.1 3930.0 3935.5 3963.3 3639.8 3641.7 3802.5 3994.9 4088.6 4380.0 4485.0 4735.2 4753.8 4804.2 5811.3 5820.9 5825.2 5831.2 5893.0 1294.7 1369.0 1382.9 1412.9 1423.3 946.9 947.7 967.2 975.1 978.6 4198.0 5291.5 5311.9 5319.7 5340.4 5595.7 5751.1 5849.2 5859.2 5921.3 4476.8 4583.9 4940.0 5267.8 5369.7 2732.7 2910.0 3138.5 3165.8 3176.2 5611.8 5836.8 6120.5 6227.3 6249.0 5186.8 5261.9 5499.8 5853.8 5946.0 4590.3 6016.4 6158.3 6167.7 6221.3 5553.6 5931.7 5973.6 6017.7 6042.3 4552.8 5313.4 5779.7 5939.8 5953.6 6154.9 6233.6 6241.1 6257.3 6276.4 2946.7 2974.5 3744.6 3883.2 3942.5 5380.9 5934.0 5938.9 6011.8 6018.8 5592.2 5767.0 5828.8 5829.4 5875.3 5238.9 5373.7 5789.2 5801.4 5807.7 4477.0 5361.7 5686.0 5686.3 5701.1 4560.5 5774.2 5804.6 5847.3 5920.8 5734.9 5751.0 5763.5 5769.0 5804.2 17:04:15 INFO - PROCESS | 1644 | 17:04:15 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:24891.47 Median:3752.89 stddev:40857.04 (1088.7%) stddev-sans-first:40931.21 17:04:15 INFO - PROCESS | 1644 | Values: 678.4 704.6 724.8 769.4 828.9 14968.0 15439.4 15723.3 15862.7 15918.0 12998.4 14559.3 14664.8 14715.9 14738.9 846.2 874.7 880.4 880.6 881.1 669.7 838.6 865.7 871.5 879.9 877.5 892.4 922.5 924.9 926.4 912.8 916.7 918.6 919.9 921.5 648.7 664.3 683.9 684.5 687.3 14000.5 14084.2 14214.3 14338.1 14572.0 13928.9 14007.1 14183.4 14191.7 14291.3 10072.5 11928.5 11949.9 12012.4 12047.6 3324.5 3798.4 3806.6 3818.2 3949.9 97144.5 97791.0 102275.0 117765.2 118846.8 8926.5 10908.9 11149.2 11239.6 11302.2 21430.0 21777.3 21778.3 21779.3 22020.0 7895.9 7949.1 8087.4 8168.5 8298.2 4511.5 4571.3 4617.4 4642.7 4714.7 3555.7 3674.3 3693.6 3701.3 3707.4 664.3 669.2 673.1 683.1 695.5 560.9 618.8 667.8 690.6 695.4 9405.9 9533.5 9555.1 9641.0 9770.6 565.1 607.1 667.4 674.4 676.8 4490.1 4664.5 4677.9 4690.8 4713.7 157103.2 159441.0 159855.4 161395.0 163653.2 136063.3 140772.3 141607.3 142679.0 143294.0 75388.0 110200.7 118602.4 120525.0 126508.0 7066.5 9568.8 9724.7 9791.9 10039.4 51621.0 59665.7 59717.7 60934.7 65651.0 65772.7 67453.7 72304.0 86870.0 89319.0 10023.4 11355.4 11381.9 12620.8 12879.4 12794.7 13301.9 14436.9 14621.6 15462.7 9705.7 13858.5 14192.9 14251.7 14406.4 11259.4 13756.6 13819.0 14428.3 14434.5 13550.4 13869.0 14229.3 14238.5 14365.9 10487.1 11342.3 11581.5 11594.8 11604.2 9572.6 11518.4 11675.8 11736.5 11836.2 17:04:15 INFO - PROCESS | 1644 | -------- Summary: end -------- 17:04:15 INFO - PROCESS | 1644 | 17:04:15 INFO - TEST-INFO | 1644: exit 0 17:04:15 INFO - TEST-OK | dromaeo_css | took 1114355ms 17:04:15 INFO - TEST-START | kraken 17:04:15 INFO - operating with platform_type : mac_ 17:04:15 INFO - Initialising browser for kraken test... 17:04:15 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpZQIWEL/profile http://localhost:49265/getInfo.html) 17:04:18 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 17:04:18 INFO - PROCESS | 1655 | colorDepth:24 17:04:18 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 17:04:18 INFO - PROCESS | 1655 | __metrics 17:04:18 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 17:04:19 INFO - TEST-INFO | 1655: exit 0 17:04:19 INFO - Browser initialized. 17:04:19 INFO - Running cycle 1/1 for kraken test... 17:04:19 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpZQIWEL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:31 INFO - PROCESS | 1657 | RSS: Main: 244367360 17:04:31 INFO - PROCESS | 1657 | 17:04:34 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 17:04:35 INFO - PROCESS | 1657 | RSS: Main: 257396736 17:04:35 INFO - PROCESS | 1657 | 17:04:37 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 17:04:38 INFO - PROCESS | 1657 | RSS: Main: 265994240 17:04:38 INFO - PROCESS | 1657 | 17:04:42 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 17:04:42 INFO - PROCESS | 1657 | RSS: Main: 262438912 17:04:42 INFO - PROCESS | 1657 | 17:04:44 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 17:04:45 INFO - PROCESS | 1657 | RSS: Main: 263876608 17:04:45 INFO - PROCESS | 1657 | 17:04:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:04:48 INFO - PROCESS | 1657 | RSS: Main: 264253440 17:04:48 INFO - PROCESS | 1657 | 17:04:50 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 17:04:51 INFO - PROCESS | 1657 | RSS: Main: 265801728 17:04:51 INFO - PROCESS | 1657 | 17:04:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 17:04:55 INFO - PROCESS | 1657 | RSS: Main: 266108928 17:04:55 INFO - PROCESS | 1657 | 17:04:58 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 17:04:59 INFO - PROCESS | 1657 | RSS: Main: 266412032 17:04:59 INFO - PROCESS | 1657 | 17:05:00 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:05:01 INFO - PROCESS | 1657 | RSS: Main: 265945088 17:05:01 INFO - PROCESS | 1657 | 17:05:03 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:05:03 INFO - PROCESS | 1657 | RSS: Main: 265961472 17:05:03 INFO - PROCESS | 1657 | 17:05:06 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:06 INFO - PROCESS | 1657 | RSS: Main: 266276864 17:05:06 INFO - PROCESS | 1657 | 17:05:09 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:05:10 INFO - PROCESS | 1657 | RSS: Main: 266297344 17:05:10 INFO - PROCESS | 1657 | 17:05:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:05:14 INFO - PROCESS | 1657 | RSS: Main: 266211328 17:05:14 INFO - PROCESS | 1657 | 17:05:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 17:05:16 INFO - PROCESS | 1657 | RSS: Main: 268292096 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | __start_tp_report 17:05:16 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 17:05:16 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 17:05:16 INFO - PROCESS | 1657 | |i|pagename|runs| 17:05:16 INFO - PROCESS | 1657 | |0;ai-astar;115;120;108;117;149;171;102;116;116;114 17:05:16 INFO - PROCESS | 1657 | |1;audio-beat-detection;144;115;166;158;109;131;129;106;156;112 17:05:16 INFO - PROCESS | 1657 | |2;audio-dft;199;210;211;231;275;204;198;199;200;241 17:05:16 INFO - PROCESS | 1657 | |3;audio-fft;68;86;77;140;65;84;83;87;132;59 17:05:16 INFO - PROCESS | 1657 | |4;audio-oscillator;69;70;115;72;68;77;110;91;105;148 17:05:16 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;99;88;89;87;89;86;90;86;103;114 17:05:16 INFO - PROCESS | 1657 | |6;imaging-darkroom;152;151;97;97;125;106;97;133;107;132 17:05:16 INFO - PROCESS | 1657 | |7;imaging-desaturate;130;95;144;94;78;74;132;145;152;92 17:05:16 INFO - PROCESS | 1657 | |8;json-parse-financial;57;59;58;50;54;60;79;49;49;58 17:05:16 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;67;72;73;71;88;110;66;96;64;70 17:05:16 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;93;89;88;99;109;93;92;86;103;90 17:05:16 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;163;134;149;150;159;151;138;144;180;176 17:05:16 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;172;176;173;173;170;170;173;174;172;172 17:05:16 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;68;68;67;68;67;69;80;88;90;79 17:05:16 INFO - PROCESS | 1657 | __end_tp_report 17:05:16 INFO - PROCESS | 1657 | __start_cc_report 17:05:16 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,966 17:05:16 INFO - PROCESS | 1657 | __end_cc_report 17:05:16 INFO - PROCESS | 1657 | __startTimestamp1472515516131__endTimestamp 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | ------- Summary: start ------- 17:05:16 INFO - PROCESS | 1657 | Number of tests: 14 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:122.80 Median:116.50 stddev:20.91 (17.9%) stddev-sans-first:21.98 17:05:16 INFO - PROCESS | 1657 | Values: 115.0 120.0 108.0 117.0 149.0 171.0 102.0 116.0 116.0 114.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:137.50 stddev:22.24 (16.2%) stddev-sans-first:23.21 17:05:16 INFO - PROCESS | 1657 | Values: 144.0 115.0 166.0 158.0 109.0 131.0 129.0 106.0 156.0 112.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:216.80 Median:210.50 stddev:25.14 (11.9%) stddev-sans-first:25.83 17:05:16 INFO - PROCESS | 1657 | Values: 199.0 210.0 211.0 231.0 275.0 204.0 198.0 199.0 200.0 241.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:88.10 Median:80.00 stddev:27.03 (33.8%) stddev-sans-first:27.68 17:05:16 INFO - PROCESS | 1657 | Values: 68.0 86.0 77.0 140.0 65.0 84.0 83.0 87.0 132.0 59.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:69.50 stddev:26.61 (38.3%) stddev-sans-first:26.83 17:05:16 INFO - PROCESS | 1657 | Values: 69.0 70.0 115.0 72.0 68.0 77.0 110.0 91.0 105.0 148.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:88.50 stddev:9.29 (10.5%) stddev-sans-first:9.61 17:05:16 INFO - PROCESS | 1657 | Values: 99.0 88.0 89.0 87.0 89.0 86.0 90.0 86.0 103.0 114.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:119.70 Median:151.50 stddev:21.79 (14.4%) stddev-sans-first:19.73 17:05:16 INFO - PROCESS | 1657 | Values: 152.0 151.0 97.0 97.0 125.0 106.0 97.0 133.0 107.0 132.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:113.60 Median:76.00 stddev:29.86 (39.3%) stddev-sans-first:31.08 17:05:16 INFO - PROCESS | 1657 | Values: 130.0 95.0 144.0 94.0 78.0 74.0 132.0 145.0 152.0 92.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:8.72 (15.0%) stddev-sans-first:9.25 17:05:16 INFO - PROCESS | 1657 | Values: 57.0 59.0 58.0 50.0 54.0 60.0 79.0 49.0 49.0 58.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:71.50 stddev:15.21 (21.3%) stddev-sans-first:15.63 17:05:16 INFO - PROCESS | 1657 | Values: 67.0 72.0 73.0 71.0 88.0 110.0 66.0 96.0 64.0 70.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:94.20 Median:91.00 stddev:7.28 (8.0%) stddev-sans-first:7.71 17:05:16 INFO - PROCESS | 1657 | Values: 93.0 89.0 88.0 99.0 109.0 93.0 92.0 86.0 103.0 90.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:154.40 Median:155.00 stddev:15.17 (9.8%) stddev-sans-first:15.76 17:05:16 INFO - PROCESS | 1657 | Values: 163.0 134.0 149.0 150.0 159.0 151.0 138.0 144.0 180.0 176.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:1.78 (1.0%) stddev-sans-first:1.88 17:05:16 INFO - PROCESS | 1657 | Values: 172.0 176.0 173.0 173.0 170.0 170.0 173.0 174.0 172.0 172.0 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:74.00 stddev:9.08 (12.3%) stddev-sans-first:9.33 17:05:16 INFO - PROCESS | 1657 | Values: 68.0 68.0 67.0 68.0 67.0 69.0 80.0 88.0 90.0 79.0 17:05:16 INFO - PROCESS | 1657 | -------- Summary: end -------- 17:05:16 INFO - PROCESS | 1657 | 17:05:16 INFO - TEST-INFO | 1657: exit 0 17:05:16 INFO - TEST-OK | kraken | took 61198ms 17:05:16 INFO - SUITE-END | took 1175s 17:05:17 INFO - Completed test suite (00:19:35) 17:05:17 INFO - javascript benchmark 17:05:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7249.015590728197, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.868165273389, 3313.734901207903, 3361.8151001694896, 3364.394409006378, 3385.6952874241315, 5445.482679145484, 5452.482014208649, 5464.453554644533, 5500.20247064176, 5536.197251398545, 4083.795810209485, 4105.630493255607, 5401.108817045193, 5501.752421141048, 5510.476504732054, 4990.1516742153735, 5031.0, 5051.343325367697, 5087.491250874901, 5200.973995130019, 4187.695474683377, 5163.173892177252, 5213.113770658997, 5223.164293713006, 5234.764435600388, 4034.8184331705143, 4102.815373308208, 5008.54923056923, 5039.6700726578365, 5115.846524604268, 4739.909820741249, 4991.176455884774, 5009.874753131201, 5048.343715317022, 5074.9342638046055, 3661.9267614647824, 4754.310624959396, 5029.346184995927, 5081.974590127063, 5090.083784918713, 5348.197770334442, 5459.617826752129, 5484.945150548523, 5575.219469274305, 5653.0, 4895.437024742165, 5951.434613711691, 5996.610220335708, 6013.579049466539, 6029.397060293935, 6045.60703554272, 6089.634621922654, 6103.816885493442, 6127.387261273837, 6142.04798256271, 5539.362973258087, 5572.414896435897, 5602.747876345574, 5605.729679479818, 5609.074502707008, 6134.631922084689, 6135.569531795964, 6138.539609529304, 6149.262088549313, 6153.507719382439, 5936.5250779937505, 5952.910706339322, 5956.583039187215, 5985.401459854067, 5985.760569577255, 5973.0, 5990.760369585168, 6014.548908831855, 6018.368071352533, 6074.42292982166, 5843.824685259449, 5941.792037278675, 5943.970280148572, 6011.759529618854, 6042.758289668364, 5918.763249470059, 6023.427774361428, 6031.155638210654, 6057.0, 6065.696715164312, 4795.112904112751, 4823.662343635982, 4858.416989961227, 4881.267809828483, 4894.975525122423, 4310.89222769427, 4312.849050283225, 4324.870253892388, 4378.927162845123, 4399.5820397062225, 4249.426327445817, 5504.0643090674685, 5532.30846144232, 5536.307961504812, 5554.50009499147, 5955.493783028404, 6023.66869822164, 6065.878682426327, 6066.211392519032, 6067.575269731076, 5490.780368785284, 5540.667559946416, 5571.13647384656, 5578.107502799533, 5601.271834661549, 5266.7366631668265, 5285.735713214324, 5300.840974770763, 5304.098303288373, 5331.44019877915, 6104.633721976696, 6157.784477543264, 6277.121203031579, 6277.995520716663, 6296.968515157395, 6085.0, 6113.902014424272, 6114.71942267015, 6123.923256659856, 6129.740518962076, 6247.468965138014, 6254.3745625437095, 6260.74957001733, 6264.655443950626, 6303.117563541016, 5814.94185058144, 5925.7925972592475, 5960.284765828128, 5986.88026239464, 5992.161097446274, 6037.396260374103, 6088.0, 6117.675163990694, 6131.988406491147, 6160.568760186744, 5881.852953676193, 5937.673427961504, 5954.37479064692, 5957.821265362046, 5962.4633782959745, 4310.331898555729, 5756.913646295393, 5931.970340148272, 5936.109583562327, 5938.228030356199, 5113.974430127825, 5204.947950520446, 5365.973170134124, 5444.863878403072, 5827.825165245049, 4919.188333925005, 5862.560307976833, 5864.912026319694, 5894.469497745224, 5921.822345329647, 5628.887422251614, 5670.886582268414, 5679.290088738908, 5696.515796157373, 5797.101449275369], "value": 5459.548929711871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.313695142044, 475.60287160221225, 538.1550964984971, 558.7876606889381, 571.6627189957924, 36787.264254714886, 38774.80612596933, 38842.22315553687, 38864.99999999993, 38873.0, 34441.62233510663, 39855.80072099643, 40365.798171009104, 40510.0, 40545.189096218055, 9435.198008169296, 9715.174210192143, 9719.56261968213, 9722.465264410455, 9730.075642813958, 8364.498130112213, 9653.034696530325, 9657.855132172988, 9743.51282435879, 9743.805123897553, 9731.902680973206, 9750.414975101481, 9755.365901216433, 9769.413835169913, 9774.218062554979, 9656.662016829378, 9732.513374331254, 9732.805343893082, 9751.073648003428, 9751.804963900753, 9617.422954622674, 9701.611935522571, 9729.173020293212, 9732.562034708384, 9742.610295588169, 38169.0, 38426.423603645686, 38569.807150964065, 38708.41937370942, 38760.80619596912, 3264.67353264674, 3291.6050073991037, 3311.2384151645015, 3367.764256502046, 3392.2028323343993, 29892.252693682833, 30374.84812575923, 30869.845650771604, 31429.74281028756, 31640.208994775083, 3215.8713651453913, 3219.840857291373, 3241.7082462578246, 3256.234784825564, 3283.96716032839, 351160.0, 354480.0, 354598.0, 354787.0, 356867.9999999974, 55482.342118945984, 55896.0, 55902.881942360924, 56061.07572469888, 56137.438625614035, 33097.0, 34057.659423405945, 34197.65802341945, 57777.71111144417, 57807.42192578105, 16021.359145634044, 16172.676546469005, 16176.919115404347, 16218.432354867524, 16226.837731622532, 12275.877241227474, 12351.444185011696, 12365.876341236652, 12367.69080772988, 12372.690682732824, 18861.0, 18881.055947202585, 18897.622047558973, 18908.149133289036, 18923.43229703111, 6845.589264644137, 7958.0, 8086.7169649062, 8175.264226219669, 8203.876941845878, 877.7542288159326, 929.9256059515222, 953.6743925942944, 976.584951395654, 1006.1699098243978, 28797.424051518854, 29841.0, 29929.802807887878, 29932.251693707396, 30168.09495715132, 918.5499105438421, 1021.2544842265188, 1091.3397394576168, 1093.147345070846, 1226.6749311432477, 13277.535286264934, 15169.620759481102, 15187.924060379848, 15445.996010259298, 15540.145292009049, 638536.0, 888297.0, 910470.0, 910709.0, 913291.0, 56005.1599226012, 56290.718546407006, 56626.150607740914, 56781.14828277579, 56926.43073569211, 1235.6293112066344, 1315.81578578999, 1371.766799644063, 1390.3395886953817, 1396.0437100585928, 29917.21665201691, 30333.696663033086, 30467.085987420414, 30534.236644083187, 30821.22946926345, 37407.81296093502, 40562.594374057066, 48684.0, 49168.0, 49168.01663966629, 503416.0, 542436.0, 592838.0, 609900.0, 610144.0, 26060.609090864033, 26417.735822642295, 26448.20655380342, 26479.470410592065, 26500.469990599693, 38168.80915595404, 43455.348169776844, 44079.77960110179, 44972.10055798931, 45260.0, 36942.63057369392, 37466.0, 38116.809415952746, 38354.0, 38403.42394864135, 32549.0, 33204.83783067581, 34576.65423345835, 37389.0, 38322.041948950384, 32373.866914657872, 36547.81726091352, 36859.89420317395, 37544.87365379043, 38173.80913095417, 32436.83781581077, 33607.0, 34030.0, 34099.829500852335, 34171.80398686034, 25100.49799003973, 25273.87363063173, 25446.74553254444, 25890.611640825027, 25954.0], "value": 19410.405581132985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.5420332111795, 361.82270687363194, 368.4602057985052, 382.64414094891737, 395.12085609518823, 19985.60028799425, 20340.08469618867, 21237.256696015644, 21724.456888577773, 21986.89006554969, 17684.11579421027, 20895.164193432283, 21215.893920530376, 21668.724783897702, 21709.782902170973, 5779.537636989052, 5844.2402487676545, 6002.339742628307, 6022.307434645006, 6099.268087829467, 5089.287499750038, 5577.358603760558, 5712.429082002441, 6112.602680825755, 6122.0816877468515, 5634.4928956393915, 6521.836954076139, 6784.626845523494, 6788.864222715542, 6830.965845170767, 6054.576179667425, 6162.722677479502, 6211.596246243979, 6387.233531976146, 6972.1284839395075, 5844.824655260349, 5957.523398128139, 6056.909146362764, 6064.483879030243, 6077.665728384937, 12986.935065324707, 13378.39797209128, 13427.0, 13428.93285533566, 13489.932550337284, 1707.513358692779, 2099.6745504446835, 2160.2439146298825, 2312.9306120816404, 2349.3304408243566, 9991.050850169222, 10134.391936483835, 10223.182145428422, 13349.0, 15457.995230309994, 1677.9161041947855, 1806.2955447375534, 1877.558773688182, 1892.9053547322578, 1910.4268719384268, 113292.30061549084, 119477.0, 126032.99999999908, 127727.0, 130480.0, 9528.333016688905, 10794.838077428845, 11323.0, 11398.544058237743, 11659.825102623467, 14464.27678616065, 14485.275736213147, 14490.058146220672, 14495.0, 14507.057041292283, 8141.715039973573, 8375.790605234795, 8402.915970840213, 8438.620262088221, 8576.571171441403, 7143.785686429312, 8308.210719981593, 8368.539730314891, 8391.622376992927, 8533.487990720576, 4480.775961201927, 4499.212637788374, 4542.068875880503, 4556.72659640416, 4616.653750968623, 1908.4656296237076, 1918.194358369488, 1932.8743631664179, 1943.65014297425, 1971.3888694504749, 825.471698113208, 858.7895965488495, 921.0, 996.2528103922059, 1012.8126296635146, 21475.355739327846, 21978.670319945213, 22025.559488810133, 22063.889680551496, 22181.223657171922, 920.6501529418778, 922.1608336413965, 930.9115634014757, 968.1915600473543, 1003.8694969653898, 9716.514174291256, 10237.641682541076, 10587.311824731521, 11106.889311068828, 11445.713857153638, 504561.0, 567341.0, 571423.285767137, 587981.0, 588733.0, 89477.55261223653, 123004.99999999821, 127189.32651849034, 129806.0, 136979.0, 958.6405098088356, 966.8308046091905, 1006.5219020965129, 1008.1884083312857, 1020.9540570674337, 19485.51286217856, 19861.702074469184, 19985.800141998974, 20135.899320503304, 20139.69790453174, 40637.79681101575, 54462.91074178574, 54721.72639136779, 56499.0, 57001.429985699615, 79317.60341198256, 80438.59780701059, 82027.0, 82309.58845205736, 84001.0, 7977.242161994601, 8020.919790802017, 8041.718539851077, 8243.340532757486, 8251.917480825115, 11189.496472658588, 12998.350082495648, 13085.542006029744, 13279.0, 13305.135166214164, 9305.627774888928, 9493.525323733924, 11257.71855703614, 11304.717382065513, 11356.602518911799, 8058.8314694370165, 10201.38791672502, 10600.522976465923, 10770.461476925966, 10879.401632910265, 6687.598744075371, 9231.123043310874, 11239.943800280946, 11580.6525804226, 11716.882831171579, 6763.458923286224, 6823.931760682528, 7886.132525422085, 7980.640871160927, 8279.62741676614, 9488.33581649278, 11306.547738090385, 11567.0, 11575.13186511032, 11649.41752912334], "value": 9399.71456001959, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.6089034180088, 1521.634807646165, 1707.120832771123, 1839.6504664113825, 1867.3744295660945, 7590.58251796151, 7912.723054693087, 8381.91618083819, 8547.444416112949, 8929.1517305856, 7869.055713314396, 8396.0, 8550.91449085509, 8742.256908162797, 8760.474371537712, 2355.646653002046, 2385.33210701004, 2387.140629373424, 2388.984681510351, 2399.36416849535, 2371.6561098640686, 2389.9761002390014, 2419.3104965084954, 2424.284835973392, 2425.333033415816, 2367.360812580602, 2378.9762102379013, 2385.9642105368434, 2390.8206884483648, 2402.4714562796157, 2344.730356009047, 2353.52929414117, 2359.752226016269, 2370.8103351731907, 2380.27401642499, 2353.3528279723214, 2366.408397900525, 2368.4907744834945, 2375.0737212487143, 2375.358653163636, 8532.82934341316, 8597.312215022783, 8686.218240358397, 8693.391462597621, 8705.129487051308, 5157.896842063175, 5301.257823904656, 5310.309659744208, 5314.362276526842, 5322.680639161624, 3604.2431089471243, 3633.1643721943838, 3663.084228942764, 3682.5396825396824, 3695.150115473429, 1094.162965331522, 1095.7917995580895, 1101.24014430043, 1114.6433141394757, 1117.357519426325, 11320.49057792393, 11409.0, 11410.20128590999, 11410.771784564346, 11432.485538150886, 4526.909461810746, 4676.018036212366, 4803.903921921612, 4860.441049279378, 4866.659333846667, 9715.0, 9796.167325777245, 9828.606855725833, 9829.21366290695, 9845.064718851841, 5258.368995720538, 5265.552428043659, 5282.6302158849285, 5286.444923283077, 5296.708681022581, 4369.3227549729845, 4566.20091483989, 4617.030423611012, 4635.907281854344, 4838.564529192319, 3862.5364956205435, 3969.464122343447, 3973.980130099389, 4000.7199496035, 4069.7558146511305, 1296.7113045474744, 1302.257713103541, 1306.7059911520023, 1314.90795644304, 1315.8486774020919, 902.7111324376136, 922.31748506105, 929.688554334292, 934.0, 944.9763755906157, 5720.2849643794525, 5988.4909782668965, 5995.980683283852, 6060.939390606126, 6175.166352542439, 355.88077993872344, 416.8728537795941, 423.26985949237934, 433.81996471463987, 435.0906605195094, 3957.3866050762176, 3986.740861844029, 4031.4355990161403, 4033.233685599727, 4090.9795451022555, 10284.691459256233, 10512.3692578444, 10623.256372053882, 10649.988251116132, 10669.51987160564, 10542.947285263677, 10609.73475663099, 10620.415877126678, 10634.89365106339, 10690.625828096136, 7390.704371825174, 7497.362724168398, 7787.338076263468, 8116.310113640288, 8270.172982701803, 5797.159411885337, 5801.941980580309, 5851.356350801323, 5898.911516327173, 5992.161097446448, 9651.951740241253, 9820.950895245478, 9938.552765125442, 9948.651797187063, 9972.351797133164, 7444.962775186089, 8095.959520202361, 8937.508437036025, 10034.0, 10053.095221430107, 6628.972509261072, 6663.067170596023, 6904.896426553505, 7275.927240727737, 7421.740239091606, 8291.212334828182, 8317.251447369767, 8401.579921004048, 8413.3269338454, 8421.95789021051, 7281.235470275757, 7389.261073892568, 7402.29678180572, 7447.292507211806, 7514.286142816423, 7073.151221853411, 7444.553326800409, 7511.098668159637, 7528.284812942762, 7582.090149182133, 6801.931980680328, 6877.140357455318, 6900.689468974008, 6964.6517674115075, 6980.267071957372, 4889.755512224303, 4949.183384741621, 5086.872828179326, 5206.713630750345, 5251.186066159751, 4969.875753106201, 5038.168702164102, 5106.0, 5181.896362072813, 5308.46915308466], "value": 4473.002349442356, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.939537394834, 297.4155783884666, 302.2805722380734, 309.6856690459183, 312.2739630359415, 4865.829695960642, 5209.609279304048, 5417.91873121903, 5530.834074977747, 5551.6668999859985, 5263.736813159337, 5343.625946183769, 5430.185472179165, 5456.590755693319, 5463.180522921563, 3709.312262920365, 4031.879043628696, 4174.749515029092, 4194.266003449384, 4195.202911446823, 3490.7381946354, 3842.7886466244345, 3994.460747799039, 4151.605597468236, 4217.36739489076, 3378.2061215614312, 3681.852725890961, 3995.5405128410316, 4051.635352818246, 4069.2268468990947, 3266.4936934775146, 3443.6039855416698, 3693.409054551272, 4077.8980525486804, 4082.4896887889013, 3342.6490218526947, 3549.6450354964554, 3550.6271841456532, 3554.2003049313957, 3565.7682250653884, 5112.514311140473, 5282.10204265272, 5294.814681486168, 5328.733563321818, 5406.0, 4625.560571745713, 4626.0, 4629.884252893671, 4645.187092258841, 4657.182404645208, 4852.344933433977, 5687.374388817227, 5762.423757624246, 5791.160281759121, 5798.825440459827, 3354.26206234628, 3717.832697528591, 3800.1639639279592, 3851.84592616295, 3861.9806900965596, 4916.598769350718, 5305.549028332558, 5313.495217954288, 5600.6079574429805, 6047.485963693091, 3922.725409221327, 3928.1145050375408, 3930.0, 3935.5277366715604, 3963.286608410456, 3639.7998110103667, 3641.7268704847243, 3802.524684414448, 3994.881433198709, 4088.6115818997146, 4380.014496738208, 4484.955150448519, 4735.171345014609, 4753.809847606057, 4804.159272127364, 5811.27359080115, 5820.941790582125, 5825.2135961644635, 5831.183634291203, 5893.0, 1294.695746499572, 1368.9931550342185, 1382.903196776216, 1412.8587141285789, 1423.3381477612752, 946.8911075226437, 947.7298969793576, 967.1537404770826, 975.1077763846143, 978.6476868327396, 4197.979010104991, 5291.523762861361, 5311.867203319871, 5319.6808191508635, 5340.359156901197, 5595.664260144405, 5751.1373294006235, 5849.221619730679, 5859.1797148399255, 5921.348651648315, 4476.843310484118, 4583.885402864955, 4939.986608169014, 5267.815626453055, 5369.704666243394, 2732.726727327291, 2909.9815064727177, 3138.4507711150914, 3165.841707914595, 3176.2059485128716, 5611.831645050655, 5836.803455291655, 6120.540959428061, 6227.314995350508, 6248.969249913788, 5186.784193799793, 5261.932018098152, 5499.790046189832, 5853.765849366063, 5945.970270148708, 4590.272019819591, 6016.42843929826, 6158.291796443376, 6167.660778657217, 6221.2845522764555, 5553.556794787258, 5931.673757943355, 5973.55198360116, 6017.68319197121, 6042.305134909541, 4552.817887284472, 5313.442088580643, 5779.739911703899, 5939.762409503572, 5953.583249172516, 6154.876902462015, 6233.563650544418, 6241.095041218907, 6257.311695713377, 6276.403741644536, 2946.705329467122, 2974.509205980989, 3744.6255374462335, 3883.165119499321, 3942.4677668515533, 5380.946190538045, 5933.970330148494, 5938.881222375615, 6011.819645410645, 6018.759249629966, 5592.189132575672, 5767.0, 5828.76684932598, 5829.446202610745, 5875.294964604275, 5238.921416178684, 5373.650712703662, 5789.205346342647, 5801.419858014165, 5807.709614519342, 4476.955230447654, 5361.678299302054, 5686.0, 5686.317641883001, 5701.116326969326, 4560.452745670408, 5774.249347584955, 5804.593678442468, 5847.251791657914, 5920.822375328747, 5734.942650573441, 5750.9712451439145, 5763.4812866842185, 5769.0, 5804.1874137619925], "value": 4167.930557545425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.3894494954541, 704.6124631452703, 724.807925899637, 769.3883362726632, 828.8590939540278, 14968.0, 15439.382424702999, 15723.292451839667, 15862.682746345066, 15918.0, 12998.41507132179, 14559.27203639819, 14664.780028299583, 14715.926420367883, 14738.852611473882, 846.1707526623912, 874.7419511244167, 880.3881302494768, 880.5861245214738, 881.0968757024037, 669.6752075243503, 838.5597561280316, 865.7186414415308, 871.5075982070142, 879.9120087991182, 877.4910551879926, 892.4466830565026, 922.4972390047441, 924.9260059195282, 926.4302453990814, 912.8037471943497, 916.7341470973442, 918.6233644205877, 919.8758167647416, 921.5438358012759, 648.6691787188521, 664.315754772585, 683.8871586188322, 684.4763755726823, 687.3092541995263, 14000.509982150576, 14084.225367604779, 14214.289285535682, 14338.068025578305, 14572.0, 13928.860711392857, 14007.089539180022, 14183.43266269348, 14191.716165676731, 14291.285435728172, 10072.546735396925, 11928.46321915516, 11949.940250298692, 12012.399380030964, 12047.6385708428, 3324.4514655081884, 3798.392257238856, 3806.619338066199, 3818.2363527294374, 3949.921001579981, 97144.51427742887, 97791.0, 102275.0, 117765.23352149638, 118846.81153188444, 8926.509042002752, 10908.945455272831, 11149.21955463126, 11239.55041798319, 11302.208845380908, 21430.0, 21777.34667959932, 21778.34664960054, 21779.346619601438, 22020.009099590556, 7895.855101010321, 7949.125596184415, 8087.353011759045, 8168.469049511763, 8298.21166989135, 4511.481179664381, 4571.268597024527, 4617.422822147231, 4642.744649044335, 4714.717116972924, 3555.7333200010103, 3674.283514714605, 3693.649103335179, 3701.3152566775234, 3707.3882809336155, 664.2858926653867, 669.1568623534382, 673.1215763428675, 683.1153656015472, 695.5166159519187, 560.8850185712001, 618.848382146377, 667.8230268978724, 690.5532908556565, 695.384584642595, 9405.90594094064, 9533.52332383378, 9555.092266234697, 9641.0, 9770.609175632895, 565.1423000598764, 607.1348328631682, 667.3560014585947, 674.4402146218627, 676.8307923019245, 4490.101979604092, 4664.533546645308, 4677.906441871211, 4690.835820746258, 4713.717176969393, 157103.21448392686, 159441.0, 159855.40144598638, 161395.0, 163653.18173409055, 136063.31968340094, 140772.257525835, 141607.29196353952, 142679.0, 143294.0, 75388.0, 110200.69397918075, 118602.40698796623, 120525.0, 126508.0, 7066.505344625827, 9568.808623827623, 9724.659636912675, 9791.902080979098, 10039.397636141855, 51621.0, 59665.70167149136, 59717.701411492664, 60934.69532652486, 65651.01523477056, 65772.67113664401, 67453.66273168602, 72304.0, 86870.0, 89319.0, 10023.448710321003, 11355.37545434976, 11381.886181138083, 12620.801023902715, 12879.35603219854, 12794.68013299675, 13301.933490332873, 14436.855631443552, 14621.63445913818, 15462.675270873115, 9705.6603018894, 13858.514951976633, 14192.929035354757, 14251.714965700836, 14406.351714173097, 11259.437028148395, 13756.587302380945, 13819.0, 14428.278586070865, 14434.494792682206, 13550.39023243976, 13869.0, 14229.288535572972, 14238.501652442115, 14365.92817035908, 10487.108595769445, 11342.319460832376, 11581.536738530365, 11594.768104637691, 11604.245724027911, 9572.61392244757, 11518.408039480155, 11675.766484670428, 11736.530538778354, 11836.230645008047], "value": 7812.733973518133, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 120.0, 108.0, 117.0, 149.0, 171.0, 102.0, 116.0, 116.0, 114.0], "value": 122.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 166.0, 158.0, 109.0, 131.0, 129.0, 106.0, 156.0, 112.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 210.0, 211.0, 231.0, 275.0, 204.0, 198.0, 199.0, 200.0, 241.0], "value": 216.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 86.0, 77.0, 140.0, 65.0, 84.0, 83.0, 87.0, 132.0, 59.0], "value": 88.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 115.0, 72.0, 68.0, 77.0, 110.0, 91.0, 105.0, 148.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 88.0, 89.0, 87.0, 89.0, 86.0, 90.0, 86.0, 103.0, 114.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 97.0, 97.0, 125.0, 106.0, 97.0, 133.0, 107.0, 132.0], "value": 119.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 95.0, 144.0, 94.0, 78.0, 74.0, 132.0, 145.0, 152.0, 92.0], "value": 113.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 50.0, 54.0, 60.0, 79.0, 49.0, 49.0, 58.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 73.0, 71.0, 88.0, 110.0, 66.0, 96.0, 64.0, 70.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 89.0, 88.0, 99.0, 109.0, 93.0, 92.0, 86.0, 103.0, 90.0], "value": 94.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 134.0, 149.0, 150.0, 159.0, 151.0, 138.0, 144.0, 180.0, 176.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 173.0, 173.0, 170.0, 170.0, 173.0, 174.0, 172.0, 172.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 67.0, 69.0, 80.0, 88.0, 90.0, 79.0], "value": 74.4, "unit": "score"}]}]} 17:05:17 INFO - Return code: 0 17:05:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:05:17 ERROR - # TBPL SUCCESS # 17:05:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:05:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:05:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:05:17 INFO - 2016-08-29 17:05:17.447 screenresolution[1662:10672] starting screenresolution argv=screenresolution get 17:05:17 INFO - 2016-08-29 17:05:17.450 screenresolution[1662:10672] Display 0: 1600x1200x32@60 17:05:17 INFO - 2016-08-29 17:05:17.456 screenresolution[1663:10675] starting screenresolution argv=screenresolution list 17:05:17 INFO - Available Modes on Display 0 17:05:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:05:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:05:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:05:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:05:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:05:17 INFO - Intel Iris: 17:05:17 INFO - Chipset Model: Intel Iris 17:05:17 INFO - Type: GPU 17:05:17 INFO - Bus: Built-In 17:05:17 INFO - VRAM (Dynamic, Max): 1536 MB 17:05:17 INFO - Vendor: Intel (0x8086) 17:05:17 INFO - Device ID: 0x0a2e 17:05:17 INFO - Revision ID: 0x0009 17:05:17 INFO - Displays: 17:05:17 INFO - Display: 17:05:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:05:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:05:17 INFO - Display Serial Number: 1600x1200 60 17:05:17 INFO - Main Display: Yes 17:05:17 INFO - Mirror: Off 17:05:17 INFO - Online: Yes 17:05:17 INFO - Rotation: Supported 17:05:17 INFO - Return code: 0 17:05:17 INFO - Running post-action listener: _resource_record_post_action 17:05:17 INFO - [mozharness: 2016-08-30 00:05:17.690875Z] Finished run-tests step (success) 17:05:17 INFO - Running post-run listener: _resource_record_post_run 17:05:17 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 37229568; Write bytes: 706912768; Read time: 236; Write time: 1985 17:05:17 INFO - TinderboxPrint: CPU usage
54.3% 17:05:17 INFO - TinderboxPrint: I/O read bytes / time
37,229,568 / 236 17:05:17 INFO - TinderboxPrint: I/O write bytes / time
706,912,768 / 1,985 17:05:17 INFO - TinderboxPrint: CPU idle
2,214.8 (45.7%) 17:05:17 INFO - TinderboxPrint: CPU system
979.3 (20.2%) 17:05:17 INFO - TinderboxPrint: CPU user
1,651.7 (34.1%) 17:05:17 INFO - TinderboxPrint: Swap in / out
443,039,744 / 0 17:05:17 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 396761600; Write bytes: 390608384; Read time: 29420; Write time: 772 17:05:17 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35320832; Write bytes: 297634816; Read time: 219; Write time: 1166 17:05:18 INFO - Running post-run listener: _upload_blobber_files 17:05:18 INFO - Blob upload gear active. 17:05:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:05:18 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 17:05:18 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:05:18 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:05:18 INFO - (blobuploader) - INFO - Open directory for files ... 17:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:05:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:20 INFO - (blobuploader) - INFO - Done attempting. 17:05:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:05:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:05:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:21 INFO - (blobuploader) - INFO - Done attempting. 17:05:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:05:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:05:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:24 INFO - (blobuploader) - INFO - Done attempting. 17:05:24 INFO - (blobuploader) - INFO - Iteration through files over. 17:05:24 INFO - Return code: 0 17:05:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:05:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:05:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cbf06b15a3bb1089217ac0496f656df50bc167788a4cf27ddedbd4e0601673730d3d401c3a1a9a4ead9c8847a0e9ac55dbbc4caacde922c462416284e5222355", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/72fc9e3975dc9a7ab23be4b0bd354795ebd3f2c9c50c262f6638cc5bb7e20fe07c2ffb7b0150fec73d92252273a97d38f77d7eca78e2df831197f24a5cc95913", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44b30c558b8f5d1f004c0b7085d37510ff1bb0bf1fe66d8d6f61388cec6af09ea462f22607f2301fb927319058b9edcbe508b7435de44c00f631ff80df9d752f"} 17:05:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:05:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:05:24 INFO - Contents: 17:05:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cbf06b15a3bb1089217ac0496f656df50bc167788a4cf27ddedbd4e0601673730d3d401c3a1a9a4ead9c8847a0e9ac55dbbc4caacde922c462416284e5222355", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/72fc9e3975dc9a7ab23be4b0bd354795ebd3f2c9c50c262f6638cc5bb7e20fe07c2ffb7b0150fec73d92252273a97d38f77d7eca78e2df831197f24a5cc95913", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44b30c558b8f5d1f004c0b7085d37510ff1bb0bf1fe66d8d6f61388cec6af09ea462f22607f2301fb927319058b9edcbe508b7435de44c00f631ff80df9d752f"} 17:05:24 INFO - Running post-run listener: copy_logs_to_upload_dir 17:05:24 INFO - Copying logs to upload dir... 17:05:24 INFO - mkdir: /builds/slave/test/build/upload/logs 17:05:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.933310 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-29 17:05:24.917018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 17:05:24.920597) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OgNNvGJhOY/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cbf06b15a3bb1089217ac0496f656df50bc167788a4cf27ddedbd4e0601673730d3d401c3a1a9a4ead9c8847a0e9ac55dbbc4caacde922c462416284e5222355", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/72fc9e3975dc9a7ab23be4b0bd354795ebd3f2c9c50c262f6638cc5bb7e20fe07c2ffb7b0150fec73d92252273a97d38f77d7eca78e2df831197f24a5cc95913", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44b30c558b8f5d1f004c0b7085d37510ff1bb0bf1fe66d8d6f61388cec6af09ea462f22607f2301fb927319058b9edcbe508b7435de44c00f631ff80df9d752f"} build_url:https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/T76tALmdQ_elNG_bXgmgpg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cbf06b15a3bb1089217ac0496f656df50bc167788a4cf27ddedbd4e0601673730d3d401c3a1a9a4ead9c8847a0e9ac55dbbc4caacde922c462416284e5222355", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/72fc9e3975dc9a7ab23be4b0bd354795ebd3f2c9c50c262f6638cc5bb7e20fe07c2ffb7b0150fec73d92252273a97d38f77d7eca78e2df831197f24a5cc95913", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44b30c558b8f5d1f004c0b7085d37510ff1bb0bf1fe66d8d6f61388cec6af09ea462f22607f2301fb927319058b9edcbe508b7435de44c00f631ff80df9d752f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 17:05:24.958269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 17:05:24.959023) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OgNNvGJhOY/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cpCMHO9C2J/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005132 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 17:05:25.011781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 17:05:25.012518) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 17:05:25.013233) ========= ========= Total master_lag: 0.20 =========