builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0244 starttime: 1471611175.07 results: success (0) buildid: 20160819033756 builduid: 7640b614f2c04a4ebb12ecb88bb74fed revision: b4a5ab92903593cb47d8f8d2155f724b4527d16d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:55.068210) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:55.068694) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:55.069028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:55.094461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:55.094813) ========= 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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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-19 05:52:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 43.9M=0s 2016-08-19 05:52:55 (43.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:55.240274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:55.240656) ========= 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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.026264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:55.292619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 05:52:55.293437) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4a5ab92903593cb47d8f8d2155f724b4527d16d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b4a5ab92903593cb47d8f8d2155f724b4527d16d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UyF3XX9h1m/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.KM2zH0H6oS/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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-19 05:52:55,377 truncating revision to first 12 chars 2016-08-19 05:52:55,377 Setting DEBUG logging. 2016-08-19 05:52:55,377 attempt 1/10 2016-08-19 05:52:55,377 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4a5ab929035?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 05:52:56,241 unpacking tar archive at: mozilla-central-b4a5ab929035/testing/mozharness/ program finished with exit code 0 elapsedTime=1.133599 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 05:52:56.494181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:56.494555) ========= script_repo_revision: b4a5ab92903593cb47d8f8d2155f724b4527d16d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:56.495032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:56.495365) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:56.516085) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-19 05:52:56.516507) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UyF3XX9h1m/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.KM2zH0H6oS/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:52:56 INFO - MultiFileLogger online at 20160819 05:52:56 in /builds/slave/test 05:52:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:52:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:56 INFO - {'append_to_log': False, 05:52:56 INFO - 'base_work_dir': '/builds/slave/test', 05:52:56 INFO - 'blob_upload_branch': 'Firefox', 05:52:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:56 INFO - 'branch': 'Firefox', 05:52:56 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:56 INFO - 'config_files': ('talos/mac_config.py',), 05:52:56 INFO - 'default_actions': ('clobber', 05:52:56 INFO - 'read-buildbot-config', 05:52:56 INFO - 'download-and-extract', 05:52:56 INFO - 'populate-webroot', 05:52:56 INFO - 'create-virtualenv', 05:52:56 INFO - 'install', 05:52:56 INFO - 'run-tests'), 05:52:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:56 INFO - 'download_minidump_stackwalk': True, 05:52:56 INFO - 'download_symbols': 'ondemand', 05:52:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:56 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:56 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:56 INFO - 'installer_path': 'installer.exe', 05:52:56 INFO - 'log_level': 'info', 05:52:56 INFO - 'log_name': 'talos', 05:52:56 INFO - 'log_to_console': True, 05:52:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:52:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:52:56 INFO - 'opt_config_files': (), 05:52:56 INFO - 'pip_index': False, 05:52:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:56 INFO - 'cmd': ('bash', 05:52:56 INFO - '-c', 05:52:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:56 INFO - 'enabled': True, 05:52:56 INFO - 'halt_on_failure': False, 05:52:56 INFO - 'name': 'check_screen_resolution'},), 05:52:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:56 INFO - 'cmd': ('bash', 05:52:56 INFO - '-c', 05:52:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:56 INFO - 'enabled': True, 05:52:56 INFO - 'halt_on_failure': False, 05:52:56 INFO - 'name': 'check_screen_resolution'},), 05:52:56 INFO - 'run_cmd_checks_enabled': True, 05:52:56 INFO - 'sps_profile': False, 05:52:56 INFO - 'sps_profile_interval': 0, 05:52:56 INFO - 'suite': 'dromaeojs', 05:52:56 INFO - 'system_bits': '32', 05:52:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:56 INFO - 'title': 't-yosemite-r7-0244', 05:52:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:56 INFO - 'use_talos_json': True, 05:52:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:56 INFO - 'work_dir': 'build'} 05:52:56 INFO - [mozharness: 2016-08-19 12:52:56.715465Z] Running clobber step. 05:52:56 INFO - Running pre-action listener: _resource_record_pre_action 05:52:56 INFO - Running main action method: clobber 05:52:56 INFO - rmtree: /builds/slave/test/build 05:52:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:58 INFO - Running post-action listener: _resource_record_post_action 05:52:58 INFO - [mozharness: 2016-08-19 12:52:58.891180Z] Finished clobber step (success) 05:52:58 INFO - [mozharness: 2016-08-19 12:52:58.891378Z] Running read-buildbot-config step. 05:52:58 INFO - Running pre-action listener: _resource_record_pre_action 05:52:58 INFO - Running main action method: read_buildbot_config 05:52:58 INFO - Using buildbot properties: 05:52:58 INFO - { 05:52:58 INFO - "project": "", 05:52:58 INFO - "product": "firefox", 05:52:58 INFO - "script_repo_revision": "production", 05:52:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:52:58 INFO - "repository": "", 05:52:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:52:58 INFO - "buildid": "20160819033756", 05:52:58 INFO - "pgo_build": "False", 05:52:58 INFO - "basedir": "/builds/slave/test", 05:52:58 INFO - "buildnumber": 66, 05:52:58 INFO - "slavename": "t-yosemite-r7-0244", 05:52:58 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:52:58 INFO - "platform": "yosemite_r7", 05:52:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:52:58 INFO - "branch": "mozilla-central", 05:52:58 INFO - "repo_path": "mozilla-central", 05:52:58 INFO - "revision": "b4a5ab92903593cb47d8f8d2155f724b4527d16d", 05:52:58 INFO - "stage_platform": "macosx64", 05:52:58 INFO - "builduid": "7640b614f2c04a4ebb12ecb88bb74fed", 05:52:58 INFO - "slavebuilddir": "test" 05:52:58 INFO - } 05:52:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:52:58 INFO - Running post-action listener: _resource_record_post_action 05:52:58 INFO - [mozharness: 2016-08-19 12:52:58.897220Z] Finished read-buildbot-config step (success) 05:52:58 INFO - [mozharness: 2016-08-19 12:52:58.897386Z] Running download-and-extract step. 05:52:58 INFO - Running pre-action listener: _resource_record_pre_action 05:52:58 INFO - Running main action method: download_and_extract 05:52:58 INFO - mkdir: /builds/slave/test/build/tests 05:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:58 INFO - trying https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:52:58 INFO - Downloading https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/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 05:52:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/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 05:52:59 INFO - Downloaded 1199 bytes. 05:52:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:52:59 INFO - Using the following test package requirements: 05:52:59 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:52:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:59 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:52:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:59 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:52:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:59 INFO - u'jsshell-mac.zip'], 05:52:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:59 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:52:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:52:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:59 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:52:59 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:59 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:52:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:59 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:52:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:59 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:52:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:59 INFO - trying https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:52:59 INFO - Downloading https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/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 05:52:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/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 05:53:00 INFO - Downloaded 16339496 bytes. 05:53:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:53:07 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 05:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:07 INFO - trying https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:53:07 INFO - Downloading https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/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 05:53:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/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 05:53:08 INFO - Downloaded 16339496 bytes. 05:53:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:14 INFO - trying https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:53:14 INFO - Downloading https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/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 05:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/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 05:53:15 INFO - Downloaded 14413981 bytes. 05:53:15 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:53:16 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')]} 05:53:16 INFO - trying https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:53:16 INFO - Downloading https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:53:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/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 05:53:18 INFO - Downloaded 111251202 bytes. 05:53:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:53:18 INFO - mkdir: /builds/slave/test/properties 05:53:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:53:18 INFO - Writing to file /builds/slave/test/properties/build_url 05:53:18 INFO - Contents: 05:53:18 INFO - build_url:https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:53:19 INFO - Running post-action listener: _resource_record_post_action 05:53:19 INFO - Running post-action listener: set_extra_try_arguments 05:53:19 INFO - [mozharness: 2016-08-19 12:53:19.637865Z] Finished download-and-extract step (success) 05:53:19 INFO - [mozharness: 2016-08-19 12:53:19.638011Z] Running populate-webroot step. 05:53:19 INFO - Running pre-action listener: _resource_record_pre_action 05:53:19 INFO - Running main action method: populate_webroot 05:53:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:19 INFO - '--tppagecycles', 05:53:19 INFO - '7'], 05:53:19 INFO - 'tests': ['tsvgm']}}, 05:53:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:53:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:53:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:53:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:53:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:19 INFO - 'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:19 INFO - 'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['damp', 'tps']}, 05:53:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:19 INFO - 'tests': ['damp', 'tps']}, 05:53:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['dromaeo_dom']}, 05:53:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:53:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['basic_compositor_video']}, 05:53:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:53:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['a11yr', 05:53:19 INFO - 'ts_paint', 05:53:19 INFO - 'tpaint', 05:53:19 INFO - 'sessionrestore', 05:53:19 INFO - 'sessionrestore_no_auto_restore', 05:53:19 INFO - 'tabpaint']}, 05:53:19 INFO - 'other-e10s': {'tests': ['a11yr', 05:53:19 INFO - 'ts_paint', 05:53:19 INFO - 'tpaint', 05:53:19 INFO - 'sessionrestore', 05:53:19 INFO - 'sessionrestore_no_auto_restore', 05:53:19 INFO - 'tabpaint']}, 05:53:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:53:19 INFO - 'ts_paint', 05:53:19 INFO - 'tpaint', 05:53:19 INFO - 'sessionrestore', 05:53:19 INFO - 'sessionrestore_no_auto_restore', 05:53:19 INFO - 'tabpaint']}, 05:53:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:53:19 INFO - 'ts_paint', 05:53:19 INFO - 'tpaint', 05:53:19 INFO - 'sessionrestore', 05:53:19 INFO - 'sessionrestore_no_auto_restore', 05:53:19 INFO - 'tabpaint']}, 05:53:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['a11yr', 05:53:19 INFO - 'ts_paint', 05:53:19 INFO - 'tpaint', 05:53:19 INFO - 'sessionrestore', 05:53:19 INFO - 'sessionrestore_no_auto_restore', 05:53:19 INFO - 'tabpaint']}, 05:53:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['a11yr', 05:53:19 INFO - 'ts_paint', 05:53:19 INFO - 'tpaint', 05:53:19 INFO - 'sessionrestore', 05:53:19 INFO - 'sessionrestore_no_auto_restore', 05:53:19 INFO - 'tabpaint']}, 05:53:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['tsvgx', 05:53:19 INFO - 'tsvgr_opacity', 05:53:19 INFO - 'tart', 05:53:19 INFO - 'tscrollx', 05:53:19 INFO - 'cart']}, 05:53:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:53:19 INFO - 'tsvgr_opacity', 05:53:19 INFO - 'tart', 05:53:19 INFO - 'tscrollx', 05:53:19 INFO - 'cart']}, 05:53:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:19 INFO - 'talos_options': ['--disable-e10s'], 05:53:19 INFO - 'tests': ['tp5o']}, 05:53:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:19 INFO - 'tests': ['tp5o']}, 05:53:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:19 INFO - 'talos_options': ['--disable-e10s', 05:53:19 INFO - '--xperf_path', 05:53:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:19 INFO - 'tests': ['tp5n']}, 05:53:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:19 INFO - 'talos_options': ['--xperf_path', 05:53:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:19 INFO - 'tests': ['tp5n']}}, 05:53:19 INFO - 'talos.zip': {'path': '', 05:53:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:19 INFO - Running post-action listener: _resource_record_post_action 05:53:19 INFO - [mozharness: 2016-08-19 12:53:19.657011Z] Finished populate-webroot step (success) 05:53:19 INFO - [mozharness: 2016-08-19 12:53:19.657142Z] Running create-virtualenv step. 05:53:19 INFO - Running pre-action listener: _resource_record_pre_action 05:53:19 INFO - Running main action method: create_virtualenv 05:53:19 INFO - Creating virtualenv /builds/slave/test/build/venv 05:53:19 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 05:53:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:53:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:19 INFO - Using real prefix '/tools/python27' 05:53:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:53:20 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:23 INFO - Installing pip.................done. 05:53:23 INFO - Return code: 0 05:53:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11012ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b22db0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, '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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:53:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:53:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:23 INFO - 'HOME': '/Users/cltbld', 05:53:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:23 INFO - 'LOGNAME': 'cltbld', 05:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:23 INFO - 'MOZ_NO_REMOTE': '1', 05:53:23 INFO - 'NO_EM_RESTART': '1', 05:53:23 INFO - 'PAGER': '/bin/cat', 05:53:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:23 INFO - 'PWD': '/builds/slave/test', 05:53:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:23 INFO - 'SHELL': '/bin/bash', 05:53:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:53:23 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:23 INFO - 'USER': 'cltbld', 05:53:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:23 INFO - 'XPC_FLAGS': '0x0', 05:53:23 INFO - 'XPC_SERVICE_NAME': '0', 05:53:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:23 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 05:53:23 INFO - Cleaning up... 05:53:23 INFO - Return code: 0 05:53:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11012ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b22db0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, '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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:53:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:53:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:23 INFO - 'HOME': '/Users/cltbld', 05:53:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:23 INFO - 'LOGNAME': 'cltbld', 05:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:23 INFO - 'MOZ_NO_REMOTE': '1', 05:53:23 INFO - 'NO_EM_RESTART': '1', 05:53:23 INFO - 'PAGER': '/bin/cat', 05:53:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:23 INFO - 'PWD': '/builds/slave/test', 05:53:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:23 INFO - 'SHELL': '/bin/bash', 05:53:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:53:23 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:23 INFO - 'USER': 'cltbld', 05:53:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:23 INFO - 'XPC_FLAGS': '0x0', 05:53:23 INFO - 'XPC_SERVICE_NAME': '0', 05:53:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:23 INFO - Downloading/unpacking psutil>=3.1.1 05:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:27 INFO - Installing collected packages: psutil 05:53:27 INFO - Running setup.py install for psutil 05:53:27 INFO - building 'psutil._psutil_osx' extension 05:53:27 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 05:53:27 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 05:53:27 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 05:53:28 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 05:53:28 INFO - building 'psutil._psutil_posix' extension 05:53:28 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 05:53:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:53:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:53:28 INFO - ^ 05:53:28 INFO - 1 warning generated. 05:53:28 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 05:53:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:28 INFO - Successfully installed psutil 05:53:28 INFO - Cleaning up... 05:53:28 INFO - Return code: 0 05:53:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:53:28 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')]} 05:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:28 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')]} 05:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:28 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 0x11012ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b22db0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, '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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:53:28 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 05:53:28 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 05:53:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:53:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:28 INFO - 'HOME': '/Users/cltbld', 05:53:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:28 INFO - 'LOGNAME': 'cltbld', 05:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:28 INFO - 'MOZ_NO_REMOTE': '1', 05:53:28 INFO - 'NO_EM_RESTART': '1', 05:53:28 INFO - 'PAGER': '/bin/cat', 05:53:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:28 INFO - 'PWD': '/builds/slave/test', 05:53:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:28 INFO - 'SHELL': '/bin/bash', 05:53:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:53:28 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:28 INFO - 'USER': 'cltbld', 05:53:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:28 INFO - 'XPC_FLAGS': '0x0', 05:53:28 INFO - 'XPC_SERVICE_NAME': '0', 05:53:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:53:31 INFO - Installing collected packages: mozsystemmonitor 05:53:31 INFO - Running setup.py install for mozsystemmonitor 05:53:31 INFO - Successfully installed mozsystemmonitor 05:53:31 INFO - Cleaning up... 05:53:31 INFO - Return code: 0 05:53:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:31 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 0x11012ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b22db0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, '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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:53:31 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 05:53:31 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 05:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:31 INFO - 'HOME': '/Users/cltbld', 05:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:31 INFO - 'LOGNAME': 'cltbld', 05:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:31 INFO - 'MOZ_NO_REMOTE': '1', 05:53:31 INFO - 'NO_EM_RESTART': '1', 05:53:31 INFO - 'PAGER': '/bin/cat', 05:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:31 INFO - 'PWD': '/builds/slave/test', 05:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:31 INFO - 'SHELL': '/bin/bash', 05:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:53:31 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:31 INFO - 'USER': 'cltbld', 05:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:31 INFO - 'XPC_FLAGS': '0x0', 05:53:31 INFO - 'XPC_SERVICE_NAME': '0', 05:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:31 INFO - Downloading/unpacking jsonschema==2.5.1 05:53:31 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 05:53:31 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 05:53:31 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 05:53:31 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 05:53:31 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 05:53:31 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 05:53:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:34 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:34 INFO - warning: no files found matching '*.txt' 05:53:34 INFO - no previously-included directories found matching 'build' 05:53:34 INFO - no previously-included directories found matching 'dist' 05:53:34 INFO - no previously-included directories found matching '.git*' 05:53:34 INFO - Installing collected packages: jsonschema, functools32 05:53:34 INFO - Running setup.py install for functools32 05:53:34 INFO - warning: no files found matching '*.txt' 05:53:34 INFO - no previously-included directories found matching 'build' 05:53:34 INFO - no previously-included directories found matching 'dist' 05:53:34 INFO - no previously-included directories found matching '.git*' 05:53:34 INFO - Successfully installed jsonschema functools32 05:53:34 INFO - Cleaning up... 05:53:34 INFO - Return code: 0 05:53:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53:34 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')]} 05:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:34 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')]} 05:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:34 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 0x11012ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b22db0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, '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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:53:34 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 05:53:34 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 05:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:34 INFO - 'HOME': '/Users/cltbld', 05:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:34 INFO - 'LOGNAME': 'cltbld', 05:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:34 INFO - 'MOZ_NO_REMOTE': '1', 05:53:34 INFO - 'NO_EM_RESTART': '1', 05:53:34 INFO - 'PAGER': '/bin/cat', 05:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:34 INFO - 'PWD': '/builds/slave/test', 05:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:34 INFO - 'SHELL': '/bin/bash', 05:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:53:34 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:34 INFO - 'USER': 'cltbld', 05:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:34 INFO - 'XPC_FLAGS': '0x0', 05:53:34 INFO - 'XPC_SERVICE_NAME': '0', 05:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:35 INFO - Cleaning up... 05:53:35 INFO - Return code: 0 05:53:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:35 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')]} 05:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:35 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')]} 05:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:35 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 0x11012ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b22db0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, '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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:53:35 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 05:53:35 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 05:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:35 INFO - 'HOME': '/Users/cltbld', 05:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:35 INFO - 'LOGNAME': 'cltbld', 05:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:35 INFO - 'MOZ_NO_REMOTE': '1', 05:53:35 INFO - 'NO_EM_RESTART': '1', 05:53:35 INFO - 'PAGER': '/bin/cat', 05:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:35 INFO - 'PWD': '/builds/slave/test', 05:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:35 INFO - 'SHELL': '/bin/bash', 05:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:53:35 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:35 INFO - 'USER': 'cltbld', 05:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:35 INFO - 'XPC_FLAGS': '0x0', 05:53:35 INFO - 'XPC_SERVICE_NAME': '0', 05:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:35 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 05:53:35 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 05:53:35 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 05:53:35 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 05:53:35 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 05:53:35 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 05:53:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:37 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 05:53:37 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 05:53:37 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 05:53:37 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 05:53:37 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 05:53:37 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 05:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:39 INFO - Downloading docopt-0.6.1.tar.gz 05:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:39 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:39 INFO - Running setup.py install for blobuploader 05:53:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:39 INFO - Running setup.py install for requests 05:53:39 INFO - Running setup.py install for docopt 05:53:39 INFO - Successfully installed blobuploader requests docopt 05:53:39 INFO - Cleaning up... 05:53:40 INFO - Return code: 0 05:53:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:40 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')]} 05:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:40 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')]} 05:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:40 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 0x11012ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b22db0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, '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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:53:40 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 05:53:40 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 05:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:40 INFO - 'HOME': '/Users/cltbld', 05:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:40 INFO - 'LOGNAME': 'cltbld', 05:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:40 INFO - 'MOZ_NO_REMOTE': '1', 05:53:40 INFO - 'NO_EM_RESTART': '1', 05:53:40 INFO - 'PAGER': '/bin/cat', 05:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:40 INFO - 'PWD': '/builds/slave/test', 05:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:40 INFO - 'SHELL': '/bin/bash', 05:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:53:40 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:40 INFO - 'USER': 'cltbld', 05:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:40 INFO - 'XPC_FLAGS': '0x0', 05:53:40 INFO - 'XPC_SERVICE_NAME': '0', 05:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:40 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-g9lWAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:40 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-6pX0is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:40 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-qpUa4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:40 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-2nT3Zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:40 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-klAbDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:40 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-EDhn1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:40 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ORmpI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-VtSCIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-0p00ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-gQ4bWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-hTCX89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ZGSvWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ja33EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-1NoYLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-mhZjGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-9_y4Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:42 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-748xBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:42 INFO - Running setup.py install for manifestparser 05:53:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:42 INFO - Running setup.py install for mozcrash 05:53:42 INFO - Running setup.py install for mozdebug 05:53:42 INFO - Running setup.py install for mozdevice 05:53:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:42 INFO - Running setup.py install for mozfile 05:53:42 INFO - Running setup.py install for mozhttpd 05:53:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:42 INFO - Running setup.py install for mozinfo 05:53:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:43 INFO - Running setup.py install for mozInstall 05:53:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:43 INFO - Running setup.py install for mozleak 05:53:43 INFO - Running setup.py install for mozlog 05:53:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:43 INFO - Running setup.py install for moznetwork 05:53:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:43 INFO - Running setup.py install for mozprocess 05:53:43 INFO - Running setup.py install for mozprofile 05:53:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:44 INFO - Running setup.py install for mozrunner 05:53:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:44 INFO - Running setup.py install for mozscreenshot 05:53:44 INFO - Running setup.py install for moztest 05:53:44 INFO - Running setup.py install for mozversion 05:53:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:44 INFO - Cleaning up... 05:53:44 INFO - Return code: 0 05:53:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:44 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')]} 05:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:44 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')]} 05:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:44 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 0x11012ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b22db0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, '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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:53:44 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 05:53:44 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 05:53:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:53:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:44 INFO - 'HOME': '/Users/cltbld', 05:53:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:44 INFO - 'LOGNAME': 'cltbld', 05:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:44 INFO - 'MOZ_NO_REMOTE': '1', 05:53:44 INFO - 'NO_EM_RESTART': '1', 05:53:44 INFO - 'PAGER': '/bin/cat', 05:53:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:44 INFO - 'PWD': '/builds/slave/test', 05:53:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:44 INFO - 'SHELL': '/bin/bash', 05:53:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:53:44 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:44 INFO - 'USER': 'cltbld', 05:53:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:44 INFO - 'XPC_FLAGS': '0x0', 05:53:44 INFO - 'XPC_SERVICE_NAME': '0', 05:53:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:44 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-1M2jej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:45 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)) 05:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:45 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-RYLDR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:45 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)) 05:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:45 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-kbfISx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:45 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)) 05:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:45 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-UeQLhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:45 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)) 05:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:45 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-1aU0_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:45 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)) 05:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:45 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-AIoo4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:45 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)) 05:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:45 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-zYkMdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:45 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)) 05:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:45 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-STkZde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:45 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)) 05:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:45 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-bvJnGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:45 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)) 05:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:45 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-mgp4QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:46 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)) 05:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:46 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-IaJKA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:46 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)) 05:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:46 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-cunPkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:46 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)) 05:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:46 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-nQ5Gqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:46 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)) 05:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:46 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ztkQIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:46 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)) 05:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:46 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-vJAV1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:46 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)) 05:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:46 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-DgJJTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:46 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)) 05:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:46 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-gF_JA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:46 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)) 05:53:46 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)) 05:53:46 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)) 05:53:46 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)) 05:53:46 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)) 05:53:46 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)) 05:53:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:49 INFO - Downloading blessings-1.6.tar.gz 05:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:49 INFO - Installing collected packages: blessings 05:53:49 INFO - Running setup.py install for blessings 05:53:49 INFO - Successfully installed blessings 05:53:49 INFO - Cleaning up... 05:53:49 INFO - Return code: 0 05:53:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:49 INFO - Reading from file tmpfile_stdout 05:53:49 INFO - Current package versions: 05:53:49 INFO - blessings == 1.6 05:53:49 INFO - blobuploader == 1.2.4 05:53:49 INFO - docopt == 0.6.1 05:53:49 INFO - functools32 == 3.2.3-2 05:53:49 INFO - jsonschema == 2.5.1 05:53:49 INFO - manifestparser == 1.1 05:53:49 INFO - mozInstall == 1.12 05:53:49 INFO - mozcrash == 0.17 05:53:49 INFO - mozdebug == 0.1 05:53:49 INFO - mozdevice == 0.48 05:53:49 INFO - mozfile == 1.2 05:53:49 INFO - mozhttpd == 0.7 05:53:49 INFO - mozinfo == 0.9 05:53:49 INFO - mozleak == 0.1 05:53:49 INFO - mozlog == 3.3 05:53:49 INFO - moznetwork == 0.27 05:53:49 INFO - mozprocess == 0.23 05:53:49 INFO - mozprofile == 0.28 05:53:49 INFO - mozrunner == 6.12 05:53:49 INFO - mozscreenshot == 0.1 05:53:49 INFO - mozsystemmonitor == 0.3 05:53:49 INFO - moztest == 0.7 05:53:49 INFO - mozversion == 1.4 05:53:49 INFO - psutil == 3.1.1 05:53:49 INFO - requests == 1.2.3 05:53:49 INFO - wsgiref == 0.1.2 05:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:49 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 0x11012ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b22db0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, '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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:53:49 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 05:53:49 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 05:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:49 INFO - 'HOME': '/Users/cltbld', 05:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:49 INFO - 'LOGNAME': 'cltbld', 05:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:49 INFO - 'MOZ_NO_REMOTE': '1', 05:53:49 INFO - 'NO_EM_RESTART': '1', 05:53:49 INFO - 'PAGER': '/bin/cat', 05:53:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:49 INFO - 'PWD': '/builds/slave/test', 05:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:49 INFO - 'SHELL': '/bin/bash', 05:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:53:49 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:49 INFO - 'USER': 'cltbld', 05:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:49 INFO - 'XPC_FLAGS': '0x0', 05:53:49 INFO - 'XPC_SERVICE_NAME': '0', 05:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:50 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)) 05:53:50 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)) 05:53:50 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)) 05:53:50 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)) 05:53:50 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)) 05:53:50 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)) 05:53:50 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)) 05:53:50 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)) 05:53:50 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)) 05:53:50 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)) 05:53:50 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)) 05:53:50 INFO - Cleaning up... 05:53:50 INFO - Return code: 0 05:53:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11012ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101c0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b22db0340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, '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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 05:53: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', 'jsonschema'] in /builds/slave/test/build 05:53: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 jsonschema 05:53:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:53:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:50 INFO - 'HOME': '/Users/cltbld', 05:53:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:50 INFO - 'LOGNAME': 'cltbld', 05:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:50 INFO - 'MOZ_NO_REMOTE': '1', 05:53:50 INFO - 'NO_EM_RESTART': '1', 05:53:50 INFO - 'PAGER': '/bin/cat', 05:53:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:50 INFO - 'PWD': '/builds/slave/test', 05:53:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:50 INFO - 'SHELL': '/bin/bash', 05:53:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:53:50 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:50 INFO - 'USER': 'cltbld', 05:53:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:50 INFO - 'XPC_FLAGS': '0x0', 05:53:50 INFO - 'XPC_SERVICE_NAME': '0', 05:53:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:53:50 INFO - Cleaning up... 05:53:50 INFO - Return code: 0 05:53:50 INFO - Running post-action listener: _resource_record_post_action 05:53:50 INFO - Running post-action listener: _start_resource_monitoring 05:53:50 INFO - Starting resource monitoring. 05:53:50 INFO - [mozharness: 2016-08-19 12:53:50.398821Z] Finished create-virtualenv step (success) 05:53:50 INFO - [mozharness: 2016-08-19 12:53:50.399843Z] Running install step. 05:53:50 INFO - Running pre-action listener: _resource_record_pre_action 05:53:50 INFO - Running main action method: install 05:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:50 INFO - Reading from file tmpfile_stdout 05:53:50 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:50 INFO - Reading from file tmpfile_stdout 05:53:50 INFO - Output received: 05:53:50 INFO - Usage: mozinstall [options] installer 05:53:50 INFO - Options: 05:53:50 INFO - -h, --help show this help message and exit 05:53:50 INFO - -d DEST, --destination=DEST 05:53:50 INFO - Directory to install application into. [default: 05:53:50 INFO - "/builds/slave/test"] 05:53:50 INFO - --app=APP Application being installed. [default: firefox] 05:53:50 INFO - mkdir: /builds/slave/test/build/application 05:53:50 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'] 05:53:50 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 05:54:25 INFO - Reading from file tmpfile_stdout 05:54:25 INFO - Output received: 05:54:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:54:25 INFO - Running post-action listener: _resource_record_post_action 05:54:25 INFO - [mozharness: 2016-08-19 12:54:25.383633Z] Finished install step (success) 05:54:25 INFO - [mozharness: 2016-08-19 12:54:25.383768Z] Running run-tests step. 05:54:25 INFO - Running pre-action listener: _resource_record_pre_action 05:54:25 INFO - Running main action method: run_tests 05:54:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:54:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:54:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:54:25 INFO - 2016-08-19 05:54:25.396 screenresolution[1633:7350] starting screenresolution argv=screenresolution get 05:54:25 INFO - 2016-08-19 05:54:25.398 screenresolution[1633:7350] Display 0: 1600x1200x32@60 05:54:25 INFO - 2016-08-19 05:54:25.403 screenresolution[1634:7352] starting screenresolution argv=screenresolution list 05:54:25 INFO - Available Modes on Display 0 05:54:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:54:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:54:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:54:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:54:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:54:25 INFO - Intel Iris: 05:54:25 INFO - Chipset Model: Intel Iris 05:54:25 INFO - Type: GPU 05:54:25 INFO - Bus: Built-In 05:54:25 INFO - VRAM (Dynamic, Max): 1536 MB 05:54:25 INFO - Vendor: Intel (0x8086) 05:54:25 INFO - Device ID: 0x0a2e 05:54:25 INFO - Revision ID: 0x0009 05:54:25 INFO - Displays: 05:54:25 INFO - Display: 05:54:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:54:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:54:25 INFO - Display Serial Number: 1600x1200 60 05:54:25 INFO - Main Display: Yes 05:54:25 INFO - Mirror: Off 05:54:25 INFO - Online: Yes 05:54:25 INFO - Rotation: Supported 05:54:25 INFO - Return code: 0 05:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:54:25 INFO - Python 2.7.3 05:54:25 INFO - Return code: 0 05:54:25 INFO - grabbing minidump binary from tooltool 05:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0x11008fd30>, '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 0x10fdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110087b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:54:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:54:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:54:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:54:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:54:25 INFO - Return code: 0 05:54:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:54:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:54:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:54:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:54:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0244 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:54:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UyF3XX9h1m/Render', 05:54:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:25 INFO - 'HOME': '/Users/cltbld', 05:54:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:25 INFO - 'LOGNAME': 'cltbld', 05:54:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:54:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:25 INFO - 'MOZ_NO_REMOTE': '1', 05:54:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:54:25 INFO - 'NO_EM_RESTART': '1', 05:54:25 INFO - 'PAGER': '/bin/cat', 05:54:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:25 INFO - 'PWD': '/builds/slave/test', 05:54:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:54:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:25 INFO - 'SHELL': '/bin/bash', 05:54:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM2zH0H6oS/Listeners', 05:54:25 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:54:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:25 INFO - 'USER': 'cltbld', 05:54:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:25 INFO - 'XPC_FLAGS': '0x0', 05:54:25 INFO - 'XPC_SERVICE_NAME': '0', 05:54:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:54:25 INFO - mozversion application_buildid: 20160819033756 05:54:25 INFO - mozversion application_changeset: b4a5ab92903593cb47d8f8d2155f724b4527d16d 05:54:25 INFO - mozversion application_display_name: Nightly 05:54:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:54:25 INFO - mozversion application_name: Firefox 05:54:25 INFO - mozversion application_remotingname: firefox 05:54:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:54:25 INFO - mozversion application_vendor: Mozilla 05:54:25 INFO - mozversion application_version: 51.0a1 05:54:25 INFO - mozversion platform_buildid: 20160819033756 05:54:25 INFO - mozversion platform_changeset: b4a5ab92903593cb47d8f8d2155f724b4527d16d 05:54:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:54:25 INFO - mozversion platform_version: 51.0a1 05:54:25 INFO - using testdate: 1471611265 05:54:25 INFO - actual date: 1471611265 05:54:25 INFO - starting webserver on 'localhost:49263' 05:54:25 INFO - SUITE-START | Running 2 tests 05:54:25 INFO - TEST-START | dromaeo_css 05:54:25 INFO - operating with platform_type : mac_ 05:54:25 INFO - Initialising browser for dromaeo_css test... 05:54:25 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpwQFnET/profile http://localhost:49263/getInfo.html) 05:54:28 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 05:54:28 INFO - PROCESS | 1644 | colorDepth:24 05:54:28 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 05:54:28 INFO - PROCESS | 1644 | __metrics 05:54:28 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:54:28 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:54:29 INFO - TEST-INFO | 1644: exit 0 05:54:29 INFO - Browser initialized. 05:54:29 INFO - Running cycle 1/1 for dromaeo_css test... 05:54:29 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpwQFnET/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:41 INFO - PROCESS | 1649 | RSS: Main: 228315136 05:54:41 INFO - PROCESS | 1649 | 05:55:33 INFO - PROCESS | 1649 | 1471611333418 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] 05:57:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49263/tests/dromaeo/cssquery-ext.html) 05:57:46 INFO - PROCESS | 1649 | RSS: Main: 355635200 05:57:46 INFO - PROCESS | 1649 | 06:00:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-ext.html (next: http://localhost:49263/tests/dromaeo/cssquery-jquery.html) 06:00:50 INFO - PROCESS | 1649 | RSS: Main: 375033856 06:00:50 INFO - PROCESS | 1649 | 06:03:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49263/tests/dromaeo/cssquery-mootools.html) 06:03:53 INFO - PROCESS | 1649 | RSS: Main: 363110400 06:03:53 INFO - PROCESS | 1649 | 06:06:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49263/tests/dromaeo/cssquery-prototype.html) 06:06:56 INFO - PROCESS | 1649 | RSS: Main: 341229568 06:06:56 INFO - PROCESS | 1649 | 06:10:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49263/tests/dromaeo/cssquery-yui.html) 06:10:01 INFO - PROCESS | 1649 | RSS: Main: 338132992 06:10:01 INFO - PROCESS | 1649 | 06:13:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-yui.html (next: http://localhost:49263/tests/dromaeo/cssquery-dojo.html) 06:13:04 INFO - PROCESS | 1649 | RSS: Main: 388251648 06:13:04 INFO - PROCESS | 1649 | 06:13:04 INFO - PROCESS | 1649 | __start_tp_report 06:13:04 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 06:13:04 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 06:13:04 INFO - PROCESS | 1649 | |i|pagename|runs| 06:13:04 INFO - PROCESS | 1649 | |0;dojo.html;3308.768386212965;3337.149026998115;3351.6716038933564;3368.848401821918;3369.6461871503507;5529.778808847641;5596.16057591361;5646.74589643466;5683.886322273557;5686.687232202227;4633.49031606523;5684.204211410406;5691.9146212806845;5694.145878118274;5699.971500142494;5102.36220472441;5151.304573882534;5176.55999240065;5187.507186817265;5264.42091369949;5131.1277082895995;5199.272101905736;5203.427622961472;5246.2917506136755;5247.86880327991;5149.691018538881;5156.948430515685;5186.0665080285535;5203.1414816555225;5242.449542798008;5237.1882358234725;5246.842594722164;5264.8683782905355;5283.762230699628;5314.92027619586;5049.141645920203;5086.92369614456;5137.74311284438;5172.6379153459275;5186.0665080285535;5578.776848926038;5592.664440133605;5605.159226116074;5605.943940560583;5697.800576979827;6159.3224745277985;6228.626282423069;6230.813075607739;6242.094896240065;6245.500359971192;6141.24053858259;6220.973539366045;6226.906596401058;6283.403076707706;6292.056191571255;5070.721110338966;5784.884302314014;5841.649501029867;5858.238429004202;5917.55618328627;6300.684965751694;6308.905366419507;6312.053192021233;6317.810465686037;6335.841603959846;5921.644701317935;5974.940250597525;6050;6137.877242455126;6169.56813023093;6167.136600875881;6268.655223962634;6273.435390814849;6274.1843560337775;6284.4344009039405;6147.192603087036;6194.690265486708;6212.161358216583;6212.937870621236;6222.973209420486;6103.701349646901;6133.304060594526;6261.279952805395;6285.151504546919;6288.465480434214;4901.166801643729;4905.779239934212;4934.481879402683;4938.4320803107385;4940.011997600494;4397.8240870364825;4414.889627759268;4417.116576684676;4423.248047831877;4460.174867649495;5610.354809196913;5670.036093864053;5783.219265399117;5826.329972053183;5849.736761845727;6154.630722156685;6166.475849552839;6211.16149319845;6218.160548326008;6235.501159907197;5692.089265717465;5744.080947048536;5768.3366412862215;5768.423157684198;5770;5360.410354860962;5365.168398898177;5370.9731451342495;5391.05656510117;5391.083515802323;6254.28075771274;6267.341929097379;6269.937300627026;6281.12064311006;6295.150154729053;6191.504679625529;6241.032639940817;6251.812445626639;6278.277998030285;6308.116863639002;6290.370962903673;6301.8109456716375;6311.24265088174;6317.4630156437215;6344.460720838781;6093.903097442326;6167.599106058092;6247.781327653511;6265.655388953469;6273;5165.509276618715;6202.069689546423;6206.410391012847;6301.558890877594;6311.179546658905;6133.26400831903;6163.3528479509005;6164.568480206342;6172.814815555541;6174.320824709368;5062.594992400673;6033.728482218223;6137.41694539018;6147.415995480422;6148.44663980244;5884.941150588439;5910.261217347832;5924.6149000314845;6001.729922153426;6037.245344331958;6115.785947491817;6143.139960405636;6144.754209831557;6149.815505534841;6158.538109641705;5733.684647344436;5940.495057919952;5963.73163207648;5995.370486098896;6001.279846418458 06:13:04 INFO - PROCESS | 1649 | |1;ext.html;499.5329367041816;519.8414483582508;525.4194115502371;529.1427886823346;556.7967691792492;22677.773222267773;32525.186870328253;40547;41798;41840.163196736044;42872;43161.568384316146;43204;43241.13517729643;43272.35091473623;9725.221982241404;9904.55429505674;9904.603815847357;9908.306418550705;9933.801323973516;8690.869636955451;8902.599383027778;11983.520659173622;12306.507739690402;12335.629931102036;12157.817632735516;12185.20796148252;12264.448099835528;12284.75430491394;12325.753484930341;8679.479231246145;12114.394280285995;12177.391130443442;12203.694907627292;12251.019918406506;8673.262772664331;8794.86807697885;8805.339599529996;11677.240979336317;12046.397680115959;40963;41318;41371.7931410344;41472.792636036625;41491.96270093242;3213.903582892517;3425.2635683327953;3508;3543.6102028776813;3939.960600393988;27463.313417164532;30011.69988300133;31832;32215.355692886013;32572;2729.9044533441233;3231.353729254135;3294.061192560109;3317;3352.7485438592203;500186.499067506;504727;506892;507645;512435;49790;53647;58727.11909321364;60526;61865.38134618686;61733;61862;62040.379596203464;62143;62178;14703.897207709251;15911;16059.277332520065;16239;16266.75599866003;11291.096712262999;11768.352740599177;12590.24458532491;12706.682332941751;12733.617991460085;15397.23013849303;15546.611334716723;15732.60668483297;16058.357665693242;16079.678406431805;6435.876160866903;6489;6564.179477565304;6582.144321238304;6588.868222635616;865.1564724393666;885.4465958775766;913.5660561233494;947.3889341374775;1020.3622735790132;25093.749062509505;29868.40263194724;30470.238244044078;31253.218669532987;31258.68741312558;1035.3632516002604;1048.7849990751877;1099.4173088263233;1113.9387333696725;1119.9720006999728;12631.93684031574;15569.299381527859;15725.977811442219;15873.365065397255;16149.426429948737;631240;638093;639140;639151;640325;59329.70335148297;59395.703021484616;59505.214843554764;59597.44428112904;59808;1224.1920332580455;1264.8608653048157;1346.279740338914;1371.5131128449257;1396.532161725813;29023.564646529896;31420.586073626284;31496.37007259796;31817.706491915567;32167.678323216467;49135.75432122817;49886;50088.248676269155;50106.99786004187;50253.24113656004;488871.1128887083;491762;492406.53796730784;492437;492601;30489.54265686061;33861.153471163416;34790.82604586961;39834.2033159341;40002;37740.62259377371;44410.777946110065;47545.28682069702;48459.75770121127;48984.75507622439;31250.531242030935;39776.403353949136;39958.40062399124;40313.59686403216;40710.59289407068;38601.560820506;39699.60300397075;39781.60218397779;40637.79681101575;40865.38701919414;27648;31043.84478077595;38335.61664383432;39000;39443.80278098591;30901.381972360876;32964.50553241751;34914.82542587271;35253.942381728586;35393;21732.565348693253;24543.159263054986;24718.505629887663;25948;26053.64747084767 06:13:04 INFO - PROCESS | 1649 | |2;jquery.html;342.20608189001524;365.26581571042203;365.51021631014453;367.90802299425144;390.02299240402806;14145.84304661383;15525.990810597303;20922.267720629763;22228.444288892784;22247.22134725285;20007.699884501744;20700.068496917636;20769.896150519264;20874.851883146457;20924.58150836982;3591.2278860045085;5297.655652382602;5473.589480788937;5487;5506.972465137669;4075.9796201019103;6664.233613134503;6665.900011499832;6694.899576506356;6734.326567343275;6020;6105.32841387447;6637.269900310962;6642.800715978528;6669.366410191048;6052;6072.301685306202;6085.756569737206;6086.6348019119;6087.847803804896;5602.38373778884;5828.358880523139;5872.765089396419;5882.882342353129;5888.705564721747;13278.734425311537;13335.133216340906;13382.732345353039;13501.054926155173;13513.797293040612;1915.9137838797287;2118.4597927528534;2187.0814258011515;2467.543504451682;2935.6623988241413;9856.310058295921;9952.502374881227;10311.48442577868;10371.429571373572;10461.476926153662;1840.5214644192472;1842.1710230396375;1891.8675692701515;1949.4151754473744;1953.7264782930401;104591.47704261506;127094;128652;130229.99999999905;130324.96750324986;10306.156106629873;10420.374777513221;10828.891711082946;11201.047910927662;11366.261193022592;14225.933055020914;14293.499727509487;14302.642433939234;14304.28478576067;14306.141631502143;8165.877511837327;8492.891369077006;8517.148285171434;8598.957005214934;8654.524001179869;8456.704015359555;8458.238758511763;8461.873071903927;8637.309015278763;8657.826843463095;4353.542877997828;4449.7330160190495;4497.234200966447;4517.81928722854;4567.132244873464;1832.4777438429983;1900.6863867461714;1914.4830895658095;1919.500929758245;1926.566522532419;789.6486063701713;830.4519017448455;911.3392790227032;946.5314669238634;976.4483067067084;16848.494545163663;20746;20768.68846967297;21815;21817;846.9915300846912;939.2908354192541;940.219617717293;940.2431043010442;1022.616518805448;8803.603837827184;11294.887051129384;11421.771564568662;11476.13928955315;11483.483243254073;448632;470849;597424;618736;619668.9016554889;91326;117980.41009794896;121176.78823211831;133483;138425.61574384128;411.53907623461913;430.4941693510113;432.9199098166786;435.4730775761301;436.2561832076366;10454.790904181722;11041.00630943219;11062.668119956414;11192;11385.804490528375;53010;55740;55934.16098758441;56426.71786641041;57365.13952290636;58695;76005.61997189978;76134.23865761493;76848.6157569231;78170.6091469539;6387.393197646216;7910.841783164419;7916.762497125095;8048.678052877819;8136.918630813616;11220.607278745205;12158.574449894211;12870.09909306377;12980.935095324463;13200.603981880558;10887;11209.879012098725;11371.896199203175;11509.884901151216;11711.824322634997;11070.059044981266;11098.778024439627;11150.442477876237;11463.885361146615;11485.310881347146;10087.940766219735;11206.263029230482;11389.259698119597;11470.197086203885;11504.94247528757;7932.682692692459;7957.045154581488;7975.003124609424;8053.718119866011;8071.757847264592;8088.676452941816;10727.946360268461;11297.943510282395;11402.82895756581;11899.524019039141 06:13:04 INFO - PROCESS | 1649 | |3;mootools.html;1473.4032716749714;1518.9696206075878;1644.2354305248057;1761.9911900440495;1807.4035568262466;8363.665453381866;8835.469871807696;8838.91161088389;8840.204381605654;8857.645694172234;7784.221577842227;7995.040595128578;8404.537750423724;8631.180037896389;8648.654053837854;2308.1921327535356;2337.6610391493223;2343.1915988983774;2345.1909091363455;2348.154664320843;2317.79139877411;2330.0330362899376;2365.136725095345;2368.8460250083776;2368.8578685278853;2326.7440581536016;2332.323626148415;2349.682792822964;2357.4342157882156;2362.3149286706835;2307.573098976695;2321.245595181564;2328.976710232893;2329.9301020969315;2340.4850932794757;2312.838101332907;2318.466752646884;2318.8029017533363;2319.5940710375617;2322.5587138443643;7932.08780990182;8384.119667434954;8739.60671769772;8786.60460279289;8866.733997980007;5096;5271.736413179326;5281.234221037928;5281.9207711884355;5293.9735301323635;3455.274392377579;3518.2259902821593;3672.6694597486353;3681.067439594208;3684.6683798458266;1061.7664113895007;1089.760252744395;1097.939613321267;1102.6306187427222;1116.972075698114;11433.885661143448;11542.59600913964;11545.01867341277;11551.826722599168;11552.6534203974;4429.09203613265;4515.412996310459;4656.394668693116;4689.968206994456;4695.3426520287185;9829.346076559288;9834.360766550151;9852.162566181954;9860;9929.950350248202;4625.074985003012;5265.78936842522;5267.525922666979;5278.709670968057;5283.498067683564;4294.463192100988;4359.411479450234;4473.418455600751;4489.034857505652;4671.8364857229835;3907.6873850092493;3989.8204580793936;4006.5192176938954;4008.378701301303;4013.4180543821567;1237.4926280225066;1272.211229037984;1275.5216793702361;1281.5450515067016;1288.1626942487271;903.7379160043514;923.215267023025;930.2418429168877;939.9295052871062;969.1035791892472;5882.176495290662;5935.436133567304;6034.185384972972;6145.661988590581;6172.099712368176;430.9612134907873;436.7401396169274;437.14319932931176;441.98453054143596;444.63539897283914;3987.641112299849;4011.13760541485;4058.370952502367;4097.85657501986;4101.200265948171;10212;10618.256722029384;10655.946720266349;10700.839487407695;10730.444085607543;10639.414832184304;10655.30740501865;10689.251752377259;10700.732481688021;10769.407682577377;7989.56057416836;8177;8184.468009579358;8197.098319184885;8200.753977380688;5720.542356611544;6005.549583781147;6082.635041897501;6163.291221509584;6182.690865456799;9582.856257156009;9895.50522473859;9988.650397236062;10005.549750261402;10049.547770350206;9060.728178154666;9550.713478595653;10037.74905627336;10138.03688649577;10157.54291056919;7017.543859649107;7154.03264102376;7170;7176.677049532679;7352.779416617296;6781.355771201728;8129.670373233284;8235.423520353517;8279.95860020696;8355;7431.591262480615;7514.774556763306;7611.771646850603;7621;7626.351760100231;6105.786297479567;6193.977993631001;7310.451716121206;7312.707491700486;7380.225076366904;6847.315268473113;6975.907227831732;6986.764235444813;6998.580085194904;7012.544184627983;4930.901381972412;5033.513728215989;5057.949420505895;5058.3929928408825;5248.291480650063;5025.321581586585;5117.1045067113855;5180.378354597472;5214.739263036909;5284.524392804666 06:13:04 INFO - PROCESS | 1649 | |4;prototype.html;249.7739545711131;300.92476880779805;306.02683466576286;310.456700773646;312.9561861339412;4931.506849315071;5106.463821298761;5490.917636235455;5520.972395138018;5526;4381.466486729643;5428.972855135728;5487.533559647435;5494.340679118512;5505.064139096353;3457.5159477673146;3910.863119790815;3911.902202444933;3991.1219531703123;4071.803634147195;3136.541508198687;3247.33429646923;4130.380442933554;4136.490181083897;4136.627703506684;3556.590992035923;4059.2490389278078;4060.4315395844606;4083.1629515949307;4115.238680844039;3466.324066806974;3667.636650411534;3861.4014827701753;4103.537877273627;4114.403411505345;2896.420715856816;3053.6869146267095;3412.941987983733;3526.4710293455933;3536.5756109266795;4589.79345929434;4767;5240.973795131038;5289.841304760864;5320.441353657849;4540.296254080623;4661.160991021615;4731.503192164808;4732.574068333866;4738.549837765407;5043.722595257259;5394.676319420847;5649.124385720179;5668.206451096849;5693.373728889819;3584.4085725855202;3960.3663413853646;3962.1679447316096;3965.4448377227213;3970.086880017612;5140.021091879653;5751.25233719618;5759.654420734728;5927.2590926134235;5946.970265148733;3975.131688106643;3987.521497420328;4011.7592944423427;4013.618706222904;4015.5382131055303;3552.4316109422884;3556.484309775068;3800.973737091025;4012;4110.938335924963;3818.9497888081;4068.931068931069;4308.965848196411;4702.858914232578;4728.668993170514;4800.183968725325;5531.142672885629;5648.971755141198;5681.909025501633;5713;1108.4402376799826;1292.0748085352757;1362.4073528015344;1384.2870921475449;1389.4997800791707;776.6311002273875;796.2873228460495;856.8329175810782;860.7675927499665;863.4948555095214;5023.79904803811;5040.974795126001;5141.331626888481;5161.122609156452;5395.514403703607;5123.949590333973;5375.569954403716;5880.618054757128;5897.994681808206;5959.374265702126;4302.526722060571;4862.350019239523;5037.345145131183;5376.542993845489;5380.542653874386;2646.4839356325715;3029.409265193266;3034.893778717734;3066.3254084101463;3077.691980908105;4897.41231052276;5554.833354999357;5841.795537156179;5977.641341519523;6089.219962329638;4702.835400761025;5519.834404967857;5962.3927523848315;5968.045112782021;6119;5129.923051154161;5312.787488500494;5959.927213101683;6120.969395153084;6136.956717358149;5272.736363181903;5751.53335899343;5939.792107276225;5948.434898684618;5986.700664966821;5255.1081610619385;5786.6528008317955;5818;5819.836032793373;5827.825165245049;5252.868678282921;5604.131359639263;6048.427408873813;6148.938510614837;6211.9068213977735;3728.496652951925;3843.2889915365745;3909.143157000402;3909.7849618271266;3930.973150673908;5877.825204674298;5883.676397797991;5887.499562537232;5898.852528686645;5911.290645122613;4925.408950925768;5823.679697616672;5840.795572154954;5846.1815345852465;5856.677882716321;5170.71561064145;5588.524975377139;5729.455701708331;5758.62568933018;5772.5959182856795;5618.410066942912;5621.8594535136945;5638.85902852432;5690.800821971211;5736.368999410145;4101.815418306123;4770.833020844392;5521.978433989564;5597.776088956396;5616.494515493625;4922.532359425849;5531.474509921551;5574.219609254626;5582.246396736551;5599.944000560105 06:13:04 INFO - PROCESS | 1649 | |5;yui.html;670.9295523969982;702.3012102957555;704.9753258635945;716.9533980291284;799.9040115186177;15688.843111568882;16048.35806567736;16799.824012319143;17059.65880682389;17077.487675369728;15076.6984660307;15167.1658058807;15355.539333819976;15377.769333459979;15426.922865385686;842.9747107586767;858.0432817408607;860.2343913916619;861.2421069458867;863.3007264116055;673.6833688166579;694.6978064541916;836.7196989008689;866.5970323799432;868;903.8192361527688;920.0707285641516;923.8891333040044;923.9676611318605;929.0338048429625;909.6725178935578;911.1480765484293;911.4303560274828;913.392593925039;916.9128932751378;523.4451481429696;649.405793698765;672.6434989455596;679.8232459560501;680;15265.23673816316;15329.616759580987;15334.616634584114;15347;15376.692466150615;13898.93050534751;14275.643108922257;14322;14367.856321436757;14661.34023968924;12895.871041289562;13040.413181406859;13205.20768753878;13317.067805253637;13616.251106189156;4581;4589.908201835978;4673.112108699336;4702.764861756898;4786.066716990188;121083;121145;122723;123484;123775;10464.895351046393;10627.519797968715;10765.677029689123;11005.449727513753;11018.757778255269;20125.194992200442;22728.431789205402;22948.770512294665;23051.308460746204;23116.075356985868;7981.321587665114;8046.114927357986;8084.636191371403;8116.2695357418115;8178.96224671741;4325.7188282762145;4408.9559104408545;4450.2434586120435;4576.473705523841;4675.29870519418;3400.59192896854;3536.1159710072484;3537.7169826413824;3538.062413460435;3542.3977923753023;626.4518546272012;641.2657507154375;642.4250295985067;662.1656712542135;662.8574856405896;541.0315535192041;563.2790028763189;591.8431615621863;611.458858909868;617.0836308082494;8362.16378362171;8551.230389264996;8800.647974081094;8947.418417802823;8976.461412315282;503.768266597362;534.3934634190144;584.1792281844016;598.3238939997775;607.8662694207268;3472.5138480612736;4303.505096913895;4396.010897548026;4523.25366314561;4987.850364489072;146893;150684;153111;161937.3806261946;163538;87659.56170219109;105352.47323763485;113266;113787.86212137938;114101.85898140912;32465.513017304285;109601;111001.33497997536;112477;116034;9035.367524273237;9163.49600771964;9329.766755831159;9697.709068727949;9839.754006149904;51074;57162.7141864288;60202.69898650479;61947;64746;64391.356086438536;94086.52956735172;96697;97862.02137978814;97927.0207297918;12820.935895320463;13198.20810751358;13384.063115581816;13475;13801.861981380058;14761;14788.778168327268;14824.851751482347;14964.17697026674;15418.997765145677;12366.690832729253;13889.652758681113;13951;14207.573772786833;14643.414263429344;13509.256990865204;13657;13859.514916977858;14049.22729249901;14311.284435778378;13722.862771372158;13821.516246931309;13934.651633709238;13999.370028348545;14156.50452234167;11254.38100904458;11404.657860264206;11499.712507187387;11705.297682139098;11732.824007639721;10745.623903163665;11420.600278990196;11483.770324593628;11637;11685.415729213675 06:13:04 INFO - PROCESS | 1649 | __end_tp_report 06:13:04 INFO - PROCESS | 1649 | __start_cc_report 06:13:04 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1289 06:13:04 INFO - PROCESS | 1649 | __end_cc_report 06:13:04 INFO - PROCESS | 1649 | __startTimestamp1471612384601__endTimestamp 06:13:04 INFO - PROCESS | 1649 | 06:13:04 INFO - PROCESS | 1649 | ------- Summary: start ------- 06:13:04 INFO - PROCESS | 1649 | Number of tests: 6 06:13:04 INFO - PROCESS | 1649 | 06:13:04 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5721.56 Median:5940.50 stddev:653.63 (11.0%) stddev-sans-first:627.63 06:13:04 INFO - PROCESS | 1649 | Values: 3308.8 3337.1 3351.7 3368.8 3369.6 5529.8 5596.2 5646.7 5683.9 5686.7 4633.5 5684.2 5691.9 5694.1 5700.0 5102.4 5151.3 5176.6 5187.5 5264.4 5131.1 5199.3 5203.4 5246.3 5247.9 5149.7 5156.9 5186.1 5203.1 5242.4 5237.2 5246.8 5264.9 5283.8 5314.9 5049.1 5086.9 5137.7 5172.6 5186.1 5578.8 5592.7 5605.2 5605.9 5697.8 6159.3 6228.6 6230.8 6242.1 6245.5 6141.2 6221.0 6226.9 6283.4 6292.1 5070.7 5784.9 5841.6 5858.2 5917.6 6300.7 6308.9 6312.1 6317.8 6335.8 5921.6 5974.9 6050.0 6137.9 6169.6 6167.1 6268.7 6273.4 6274.2 6284.4 6147.2 6194.7 6212.2 6212.9 6223.0 6103.7 6133.3 6261.3 6285.2 6288.5 4901.2 4905.8 4934.5 4938.4 4940.0 4397.8 4414.9 4417.1 4423.2 4460.2 5610.4 5670.0 5783.2 5826.3 5849.7 6154.6 6166.5 6211.2 6218.2 6235.5 5692.1 5744.1 5768.3 5768.4 5770.0 5360.4 5365.2 5371.0 5391.1 5391.1 6254.3 6267.3 6269.9 6281.1 6295.2 6191.5 6241.0 6251.8 6278.3 6308.1 6290.4 6301.8 6311.2 6317.5 6344.5 6093.9 6167.6 6247.8 6265.7 6273.0 5165.5 6202.1 6206.4 6301.6 6311.2 6133.3 6163.4 6164.6 6172.8 6174.3 5062.6 6033.7 6137.4 6147.4 6148.4 5884.9 5910.3 5924.6 6001.7 6037.2 6115.8 6143.1 6144.8 6149.8 6158.5 5733.7 5940.5 5963.7 5995.4 6001.3 06:13:04 INFO - PROCESS | 1649 | 06:13:04 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:68320.17 Median:21469.98 stddev:146514.39 (682.4%) stddev-sans-first:146836.91 06:13:04 INFO - PROCESS | 1649 | Values: 499.5 519.8 525.4 529.1 556.8 22677.8 32525.2 40547.0 41798.0 41840.2 42872.0 43161.6 43204.0 43241.1 43272.4 9725.2 9904.6 9904.6 9908.3 9933.8 8690.9 8902.6 11983.5 12306.5 12335.6 12157.8 12185.2 12264.4 12284.8 12325.8 8679.5 12114.4 12177.4 12203.7 12251.0 8673.3 8794.9 8805.3 11677.2 12046.4 40963.0 41318.0 41371.8 41472.8 41492.0 3213.9 3425.3 3508.0 3543.6 3940.0 27463.3 30011.7 31832.0 32215.4 32572.0 2729.9 3231.4 3294.1 3317.0 3352.7 500186.5 504727.0 506892.0 507645.0 512435.0 49790.0 53647.0 58727.1 60526.0 61865.4 61733.0 61862.0 62040.4 62143.0 62178.0 14703.9 15911.0 16059.3 16239.0 16266.8 11291.1 11768.4 12590.2 12706.7 12733.6 15397.2 15546.6 15732.6 16058.4 16079.7 6435.9 6489.0 6564.2 6582.1 6588.9 865.2 885.4 913.6 947.4 1020.4 25093.7 29868.4 30470.2 31253.2 31258.7 1035.4 1048.8 1099.4 1113.9 1120.0 12631.9 15569.3 15726.0 15873.4 16149.4 631240.0 638093.0 639140.0 639151.0 640325.0 59329.7 59395.7 59505.2 59597.4 59808.0 1224.2 1264.9 1346.3 1371.5 1396.5 29023.6 31420.6 31496.4 31817.7 32167.7 49135.8 49886.0 50088.2 50107.0 50253.2 488871.1 491762.0 492406.5 492437.0 492601.0 30489.5 33861.2 34790.8 39834.2 40002.0 37740.6 44410.8 47545.3 48459.8 48984.8 31250.5 39776.4 39958.4 40313.6 40710.6 38601.6 39699.6 39781.6 40637.8 40865.4 27648.0 31043.8 38335.6 39000.0 39443.8 30901.4 32964.5 34914.8 35253.9 35393.0 21732.6 24543.2 24718.5 25948.0 26053.6 06:13:04 INFO - PROCESS | 1649 | 06:13:04 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:32989.94 Median:1638.93 stddev:93380.57 (5697.6%) stddev-sans-first:93610.35 06:13:04 INFO - PROCESS | 1649 | Values: 342.2 365.3 365.5 367.9 390.0 14145.8 15526.0 20922.3 22228.4 22247.2 20007.7 20700.1 20769.9 20874.9 20924.6 3591.2 5297.7 5473.6 5487.0 5507.0 4076.0 6664.2 6665.9 6694.9 6734.3 6020.0 6105.3 6637.3 6642.8 6669.4 6052.0 6072.3 6085.8 6086.6 6087.8 5602.4 5828.4 5872.8 5882.9 5888.7 13278.7 13335.1 13382.7 13501.1 13513.8 1915.9 2118.5 2187.1 2467.5 2935.7 9856.3 9952.5 10311.5 10371.4 10461.5 1840.5 1842.2 1891.9 1949.4 1953.7 104591.5 127094.0 128652.0 130230.0 130325.0 10306.2 10420.4 10828.9 11201.0 11366.3 14225.9 14293.5 14302.6 14304.3 14306.1 8165.9 8492.9 8517.1 8599.0 8654.5 8456.7 8458.2 8461.9 8637.3 8657.8 4353.5 4449.7 4497.2 4517.8 4567.1 1832.5 1900.7 1914.5 1919.5 1926.6 789.6 830.5 911.3 946.5 976.4 16848.5 20746.0 20768.7 21815.0 21817.0 847.0 939.3 940.2 940.2 1022.6 8803.6 11294.9 11421.8 11476.1 11483.5 448632.0 470849.0 597424.0 618736.0 619668.9 91326.0 117980.4 121176.8 133483.0 138425.6 411.5 430.5 432.9 435.5 436.3 10454.8 11041.0 11062.7 11192.0 11385.8 53010.0 55740.0 55934.2 56426.7 57365.1 58695.0 76005.6 76134.2 76848.6 78170.6 6387.4 7910.8 7916.8 8048.7 8136.9 11220.6 12158.6 12870.1 12980.9 13200.6 10887.0 11209.9 11371.9 11509.9 11711.8 11070.1 11098.8 11150.4 11463.9 11485.3 10087.9 11206.3 11389.3 11470.2 11504.9 7932.7 7957.0 7975.0 8053.7 8071.8 8088.7 10727.9 11297.9 11402.8 11899.5 06:13:04 INFO - PROCESS | 1649 | 06:13:04 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5639.83 Median:4813.12 stddev:3162.42 (65.7%) stddev-sans-first:3155.79 06:13:04 INFO - PROCESS | 1649 | Values: 1473.4 1519.0 1644.2 1762.0 1807.4 8363.7 8835.5 8838.9 8840.2 8857.6 7784.2 7995.0 8404.5 8631.2 8648.7 2308.2 2337.7 2343.2 2345.2 2348.2 2317.8 2330.0 2365.1 2368.8 2368.9 2326.7 2332.3 2349.7 2357.4 2362.3 2307.6 2321.2 2329.0 2329.9 2340.5 2312.8 2318.5 2318.8 2319.6 2322.6 7932.1 8384.1 8739.6 8786.6 8866.7 5096.0 5271.7 5281.2 5281.9 5294.0 3455.3 3518.2 3672.7 3681.1 3684.7 1061.8 1089.8 1097.9 1102.6 1117.0 11433.9 11542.6 11545.0 11551.8 11552.7 4429.1 4515.4 4656.4 4690.0 4695.3 9829.3 9834.4 9852.2 9860.0 9930.0 4625.1 5265.8 5267.5 5278.7 5283.5 4294.5 4359.4 4473.4 4489.0 4671.8 3907.7 3989.8 4006.5 4008.4 4013.4 1237.5 1272.2 1275.5 1281.5 1288.2 903.7 923.2 930.2 939.9 969.1 5882.2 5935.4 6034.2 6145.7 6172.1 431.0 436.7 437.1 442.0 444.6 3987.6 4011.1 4058.4 4097.9 4101.2 10212.0 10618.3 10655.9 10700.8 10730.4 10639.4 10655.3 10689.3 10700.7 10769.4 7989.6 8177.0 8184.5 8197.1 8200.8 5720.5 6005.5 6082.6 6163.3 6182.7 9582.9 9895.5 9988.7 10005.5 10049.5 9060.7 9550.7 10037.7 10138.0 10157.5 7017.5 7154.0 7170.0 7176.7 7352.8 6781.4 8129.7 8235.4 8280.0 8355.0 7431.6 7514.8 7611.8 7621.0 7626.4 6105.8 6194.0 7310.5 7312.7 7380.2 6847.3 6975.9 6986.8 6998.6 7012.5 4930.9 5033.5 5057.9 5058.4 5248.3 5025.3 5117.1 5180.4 5214.7 5284.5 06:13:04 INFO - PROCESS | 1649 | 06:13:04 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4570.88 Median:5140.68 stddev:1442.00 (28.1%) stddev-sans-first:1409.10 06:13:04 INFO - PROCESS | 1649 | Values: 249.8 300.9 306.0 310.5 313.0 4931.5 5106.5 5490.9 5521.0 5526.0 4381.5 5429.0 5487.5 5494.3 5505.1 3457.5 3910.9 3911.9 3991.1 4071.8 3136.5 3247.3 4130.4 4136.5 4136.6 3556.6 4059.2 4060.4 4083.2 4115.2 3466.3 3667.6 3861.4 4103.5 4114.4 2896.4 3053.7 3412.9 3526.5 3536.6 4589.8 4767.0 5241.0 5289.8 5320.4 4540.3 4661.2 4731.5 4732.6 4738.5 5043.7 5394.7 5649.1 5668.2 5693.4 3584.4 3960.4 3962.2 3965.4 3970.1 5140.0 5751.3 5759.7 5927.3 5947.0 3975.1 3987.5 4011.8 4013.6 4015.5 3552.4 3556.5 3801.0 4012.0 4110.9 3818.9 4068.9 4309.0 4702.9 4728.7 4800.2 5531.1 5649.0 5681.9 5713.0 1108.4 1292.1 1362.4 1384.3 1389.5 776.6 796.3 856.8 860.8 863.5 5023.8 5041.0 5141.3 5161.1 5395.5 5123.9 5375.6 5880.6 5898.0 5959.4 4302.5 4862.4 5037.3 5376.5 5380.5 2646.5 3029.4 3034.9 3066.3 3077.7 4897.4 5554.8 5841.8 5977.6 6089.2 4702.8 5519.8 5962.4 5968.0 6119.0 5129.9 5312.8 5959.9 6121.0 6137.0 5272.7 5751.5 5939.8 5948.4 5986.7 5255.1 5786.7 5818.0 5819.8 5827.8 5252.9 5604.1 6048.4 6148.9 6211.9 3728.5 3843.3 3909.1 3909.8 3931.0 5877.8 5883.7 5887.5 5898.9 5911.3 4925.4 5823.7 5840.8 5846.2 5856.7 5170.7 5588.5 5729.5 5758.6 5772.6 5618.4 5621.9 5638.9 5690.8 5736.4 4101.8 4770.8 5522.0 5597.8 5616.5 4922.5 5531.5 5574.2 5582.2 5599.9 06:13:04 INFO - PROCESS | 1649 | 06:13:04 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:24459.91 Median:3504.31 stddev:39021.17 (1113.5%) stddev-sans-first:39089.75 06:13:04 INFO - PROCESS | 1649 | Values: 670.9 702.3 705.0 717.0 799.9 15688.8 16048.4 16799.8 17059.7 17077.5 15076.7 15167.2 15355.5 15377.8 15426.9 843.0 858.0 860.2 861.2 863.3 673.7 694.7 836.7 866.6 868.0 903.8 920.1 923.9 924.0 929.0 909.7 911.1 911.4 913.4 916.9 523.4 649.4 672.6 679.8 680.0 15265.2 15329.6 15334.6 15347.0 15376.7 13898.9 14275.6 14322.0 14367.9 14661.3 12895.9 13040.4 13205.2 13317.1 13616.3 4581.0 4589.9 4673.1 4702.8 4786.1 121083.0 121145.0 122723.0 123484.0 123775.0 10464.9 10627.5 10765.7 11005.4 11018.8 20125.2 22728.4 22948.8 23051.3 23116.1 7981.3 8046.1 8084.6 8116.3 8179.0 4325.7 4409.0 4450.2 4576.5 4675.3 3400.6 3536.1 3537.7 3538.1 3542.4 626.5 641.3 642.4 662.2 662.9 541.0 563.3 591.8 611.5 617.1 8362.2 8551.2 8800.6 8947.4 8976.5 503.8 534.4 584.2 598.3 607.9 3472.5 4303.5 4396.0 4523.3 4987.9 146893.0 150684.0 153111.0 161937.4 163538.0 87659.6 105352.5 113266.0 113787.9 114101.9 32465.5 109601.0 111001.3 112477.0 116034.0 9035.4 9163.5 9329.8 9697.7 9839.8 51074.0 57162.7 60202.7 61947.0 64746.0 64391.4 94086.5 96697.0 97862.0 97927.0 12820.9 13198.2 13384.1 13475.0 13801.9 14761.0 14788.8 14824.9 14964.2 15419.0 12366.7 13889.7 13951.0 14207.6 14643.4 13509.3 13657.0 13859.5 14049.2 14311.3 13722.9 13821.5 13934.7 13999.4 14156.5 11254.4 11404.7 11499.7 11705.3 11732.8 10745.6 11420.6 11483.8 11637.0 11685.4 06:13:04 INFO - PROCESS | 1649 | -------- Summary: end -------- 06:13:04 INFO - PROCESS | 1649 | 06:13:05 INFO - TEST-INFO | 1649: exit 0 06:13:05 INFO - TEST-OK | dromaeo_css | took 1119301ms 06:13:05 INFO - TEST-START | kraken 06:13:05 INFO - operating with platform_type : mac_ 06:13:05 INFO - Initialising browser for kraken test... 06:13:05 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmp1kd9pB/profile http://localhost:49263/getInfo.html) 06:13:07 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 06:13:07 INFO - PROCESS | 1655 | colorDepth:24 06:13:07 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 06:13:07 INFO - PROCESS | 1655 | __metrics 06:13:07 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:13:07 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:13:08 INFO - TEST-INFO | 1655: exit 0 06:13:08 INFO - Browser initialized. 06:13:08 INFO - Running cycle 1/1 for kraken test... 06:13:08 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmp1kd9pB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:20 INFO - PROCESS | 1656 | RSS: Main: 228429824 06:13:20 INFO - PROCESS | 1656 | 06:13:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection) 06:13:23 INFO - PROCESS | 1656 | RSS: Main: 285536256 06:13:23 INFO - PROCESS | 1656 | 06:13:26 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-dft) 06:13:27 INFO - PROCESS | 1656 | RSS: Main: 297476096 06:13:27 INFO - PROCESS | 1656 | 06:13:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-fft) 06:13:31 INFO - PROCESS | 1656 | RSS: Main: 388796416 06:13:31 INFO - PROCESS | 1656 | 06:13:33 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator) 06:13:33 INFO - PROCESS | 1656 | RSS: Main: 289415168 06:13:33 INFO - PROCESS | 1656 | 06:13:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:13:36 INFO - PROCESS | 1656 | RSS: Main: 293388288 06:13:36 INFO - PROCESS | 1656 | 06:13:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:40 INFO - PROCESS | 1656 | RSS: Main: 328777728 06:13:40 INFO - PROCESS | 1656 | 06:13:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:43 INFO - PROCESS | 1656 | RSS: Main: 330944512 06:13:43 INFO - PROCESS | 1656 | 06:13:46 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial) 06:13:47 INFO - PROCESS | 1656 | RSS: Main: 331853824 06:13:47 INFO - PROCESS | 1656 | 06:13:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:49 INFO - PROCESS | 1656 | RSS: Main: 301051904 06:13:49 INFO - PROCESS | 1656 | 06:13:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:51 INFO - PROCESS | 1656 | RSS: Main: 308408320 06:13:51 INFO - PROCESS | 1656 | 06:13:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:54 INFO - PROCESS | 1656 | RSS: Main: 303259648 06:13:54 INFO - PROCESS | 1656 | 06:13:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:58 INFO - PROCESS | 1656 | RSS: Main: 314417152 06:13:58 INFO - PROCESS | 1656 | 06:14:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:01 INFO - PROCESS | 1656 | RSS: Main: 315748352 06:14:01 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49263/tests/kraken/driver.html?testName=ai-astar) 06:14:03 INFO - PROCESS | 1656 | RSS: Main: 358969344 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | __start_tp_report 06:14:03 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 06:14:03 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 06:14:03 INFO - PROCESS | 1656 | |i|pagename|runs| 06:14:03 INFO - PROCESS | 1656 | |0;ai-astar;102;111;114;114;110;113;112;112;114;114 06:14:03 INFO - PROCESS | 1656 | |1;audio-beat-detection;142;122;142;205;95;135;165;139;177;106 06:14:03 INFO - PROCESS | 1656 | |2;audio-dft;187;184;184;185;183;184;182;181;181;185 06:14:03 INFO - PROCESS | 1656 | |3;audio-fft;78;57;61;86;63;58;64;69;87;64 06:14:03 INFO - PROCESS | 1656 | |4;audio-oscillator;84;92;97;94;104;102;97;71;68;104 06:14:03 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;126;73;117;132;103;87;91;87;91;75 06:14:03 INFO - PROCESS | 1656 | |6;imaging-darkroom;96;95;95;97;96;95;101;153;95;95 06:14:03 INFO - PROCESS | 1656 | |7;imaging-desaturate;84;86;84;87;83;86;86;86;85;84 06:14:03 INFO - PROCESS | 1656 | |8;json-parse-financial;55;54;54;53;53;54;54;53;54;55 06:14:03 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;65;70;69;78;75;73;67;67;67;69 06:14:03 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;86;84;83;85;85;84;83;88;91;90 06:14:03 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;138;137;140;137;133;136;126;140;154;140 06:14:03 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;170;168;168;171;169;169;169;169;168;167 06:14:03 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;69;68;68;68;67;66;67;67;67;65 06:14:03 INFO - PROCESS | 1656 | __end_tp_report 06:14:03 INFO - PROCESS | 1656 | __start_cc_report 06:14:03 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2078 06:14:03 INFO - PROCESS | 1656 | __end_cc_report 06:14:03 INFO - PROCESS | 1656 | __startTimestamp1471612443644__endTimestamp 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | ------- Summary: start ------- 06:14:03 INFO - PROCESS | 1656 | Number of tests: 14 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.50 stddev:3.66 (3.2%) stddev-sans-first:1.50 06:14:03 INFO - PROCESS | 1656 | Values: 102.0 111.0 114.0 114.0 110.0 113.0 112.0 112.0 114.0 114.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:153.50 stddev:32.79 (21.4%) stddev-sans-first:34.78 06:14:03 INFO - PROCESS | 1656 | Values: 142.0 122.0 142.0 205.0 95.0 135.0 165.0 139.0 177.0 106.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.90 (1.0%) stddev-sans-first:1.56 06:14:03 INFO - PROCESS | 1656 | Values: 187.0 184.0 184.0 185.0 183.0 184.0 182.0 181.0 181.0 185.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:68.70 Median:66.50 stddev:11.10 (16.7%) stddev-sans-first:11.25 06:14:03 INFO - PROCESS | 1656 | Values: 78.0 57.0 61.0 86.0 63.0 58.0 64.0 69.0 87.0 64.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:88.00 stddev:12.99 (14.8%) stddev-sans-first:13.50 06:14:03 INFO - PROCESS | 1656 | Values: 84.0 92.0 97.0 94.0 104.0 102.0 97.0 71.0 68.0 104.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:98.20 Median:81.00 stddev:20.60 (25.4%) stddev-sans-first:19.24 06:14:03 INFO - PROCESS | 1656 | Values: 126.0 73.0 117.0 132.0 103.0 87.0 91.0 87.0 91.0 75.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:95.00 stddev:18.08 (19.0%) stddev-sans-first:19.06 06:14:03 INFO - PROCESS | 1656 | Values: 96.0 95.0 95.0 97.0 96.0 95.0 101.0 153.0 95.0 95.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:86.00 stddev:1.29 (1.5%) stddev-sans-first:1.30 06:14:03 INFO - PROCESS | 1656 | Values: 84.0 86.0 84.0 87.0 83.0 86.0 86.0 86.0 85.0 84.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 06:14:03 INFO - PROCESS | 1656 | Values: 55.0 54.0 54.0 53.0 53.0 54.0 54.0 53.0 54.0 55.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:69.50 stddev:4.11 (5.9%) stddev-sans-first:3.94 06:14:03 INFO - PROCESS | 1656 | Values: 65.0 70.0 69.0 78.0 75.0 73.0 67.0 67.0 67.0 69.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:2.85 (3.3%) stddev-sans-first:3.02 06:14:03 INFO - PROCESS | 1656 | Values: 86.0 84.0 83.0 85.0 85.0 84.0 83.0 88.0 91.0 90.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:139.00 stddev:7.02 (5.0%) stddev-sans-first:7.44 06:14:03 INFO - PROCESS | 1656 | Values: 138.0 137.0 140.0 137.0 133.0 136.0 126.0 140.0 154.0 140.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 06:14:03 INFO - PROCESS | 1656 | Values: 170.0 168.0 168.0 171.0 169.0 169.0 169.0 169.0 168.0 167.0 06:14:03 INFO - PROCESS | 1656 | 06:14:03 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.14 (1.7%) stddev-sans-first:1.00 06:14:03 INFO - PROCESS | 1656 | Values: 69.0 68.0 68.0 68.0 67.0 66.0 67.0 67.0 67.0 65.0 06:14:03 INFO - PROCESS | 1656 | -------- Summary: end -------- 06:14:03 INFO - PROCESS | 1656 | 06:14:04 INFO - TEST-INFO | 1656: exit 0 06:14:04 INFO - TEST-OK | kraken | took 59443ms 06:14:04 INFO - SUITE-END | took 1178s 06:14:04 INFO - Completed test suite (00:19:38) 06:14:04 INFO - javascript benchmark 06:14:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.768386212965, 3337.149026998115, 3351.6716038933564, 3368.848401821918, 3369.6461871503507, 5529.778808847641, 5596.16057591361, 5646.74589643466, 5683.886322273557, 5686.687232202227, 4633.49031606523, 5684.204211410406, 5691.9146212806845, 5694.145878118274, 5699.971500142494, 5102.36220472441, 5151.304573882534, 5176.55999240065, 5187.507186817265, 5264.42091369949, 5131.1277082895995, 5199.272101905736, 5203.427622961472, 5246.2917506136755, 5247.86880327991, 5149.691018538881, 5156.948430515685, 5186.0665080285535, 5203.1414816555225, 5242.449542798008, 5237.1882358234725, 5246.842594722164, 5264.8683782905355, 5283.762230699628, 5314.92027619586, 5049.141645920203, 5086.92369614456, 5137.74311284438, 5172.6379153459275, 5186.0665080285535, 5578.776848926038, 5592.664440133605, 5605.159226116074, 5605.943940560583, 5697.800576979827, 6159.3224745277985, 6228.626282423069, 6230.813075607739, 6242.094896240065, 6245.500359971192, 6141.24053858259, 6220.973539366045, 6226.906596401058, 6283.403076707706, 6292.056191571255, 5070.721110338966, 5784.884302314014, 5841.649501029867, 5858.238429004202, 5917.55618328627, 6300.684965751694, 6308.905366419507, 6312.053192021233, 6317.810465686037, 6335.841603959846, 5921.644701317935, 5974.940250597525, 6050.0, 6137.877242455126, 6169.56813023093, 6167.136600875881, 6268.655223962634, 6273.435390814849, 6274.1843560337775, 6284.4344009039405, 6147.192603087036, 6194.690265486708, 6212.161358216583, 6212.937870621236, 6222.973209420486, 6103.701349646901, 6133.304060594526, 6261.279952805395, 6285.151504546919, 6288.465480434214, 4901.166801643729, 4905.779239934212, 4934.481879402683, 4938.4320803107385, 4940.011997600494, 4397.8240870364825, 4414.889627759268, 4417.116576684676, 4423.248047831877, 4460.174867649495, 5610.354809196913, 5670.036093864053, 5783.219265399117, 5826.329972053183, 5849.736761845727, 6154.630722156685, 6166.475849552839, 6211.16149319845, 6218.160548326008, 6235.501159907197, 5692.089265717465, 5744.080947048536, 5768.3366412862215, 5768.423157684198, 5770.0, 5360.410354860962, 5365.168398898177, 5370.9731451342495, 5391.05656510117, 5391.083515802323, 6254.28075771274, 6267.341929097379, 6269.937300627026, 6281.12064311006, 6295.150154729053, 6191.504679625529, 6241.032639940817, 6251.812445626639, 6278.277998030285, 6308.116863639002, 6290.370962903673, 6301.8109456716375, 6311.24265088174, 6317.4630156437215, 6344.460720838781, 6093.903097442326, 6167.599106058092, 6247.781327653511, 6265.655388953469, 6273.0, 5165.509276618715, 6202.069689546423, 6206.410391012847, 6301.558890877594, 6311.179546658905, 6133.26400831903, 6163.3528479509005, 6164.568480206342, 6172.814815555541, 6174.320824709368, 5062.594992400673, 6033.728482218223, 6137.41694539018, 6147.415995480422, 6148.44663980244, 5884.941150588439, 5910.261217347832, 5924.6149000314845, 6001.729922153426, 6037.245344331958, 6115.785947491817, 6143.139960405636, 6144.754209831557, 6149.815505534841, 6158.538109641705, 5733.684647344436, 5940.495057919952, 5963.73163207648, 5995.370486098896, 6001.279846418458], "value": 5679.717894889959, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.5329367041816, 519.8414483582508, 525.4194115502371, 529.1427886823346, 556.7967691792492, 22677.773222267773, 32525.186870328253, 40547.0, 41798.0, 41840.163196736044, 42872.0, 43161.568384316146, 43204.0, 43241.13517729643, 43272.35091473623, 9725.221982241404, 9904.55429505674, 9904.603815847357, 9908.306418550705, 9933.801323973516, 8690.869636955451, 8902.599383027778, 11983.520659173622, 12306.507739690402, 12335.629931102036, 12157.817632735516, 12185.20796148252, 12264.448099835528, 12284.75430491394, 12325.753484930341, 8679.479231246145, 12114.394280285995, 12177.391130443442, 12203.694907627292, 12251.019918406506, 8673.262772664331, 8794.86807697885, 8805.339599529996, 11677.240979336317, 12046.397680115959, 40963.0, 41318.0, 41371.7931410344, 41472.792636036625, 41491.96270093242, 3213.903582892517, 3425.2635683327953, 3508.0, 3543.6102028776813, 3939.960600393988, 27463.313417164532, 30011.69988300133, 31832.0, 32215.355692886013, 32572.0, 2729.9044533441233, 3231.353729254135, 3294.061192560109, 3317.0, 3352.7485438592203, 500186.499067506, 504727.0, 506892.0, 507645.0, 512435.0, 49790.0, 53647.0, 58727.11909321364, 60526.0, 61865.38134618686, 61733.0, 61862.0, 62040.379596203464, 62143.0, 62178.0, 14703.897207709251, 15911.0, 16059.277332520065, 16239.0, 16266.75599866003, 11291.096712262999, 11768.352740599177, 12590.24458532491, 12706.682332941751, 12733.617991460085, 15397.23013849303, 15546.611334716723, 15732.60668483297, 16058.357665693242, 16079.678406431805, 6435.876160866903, 6489.0, 6564.179477565304, 6582.144321238304, 6588.868222635616, 865.1564724393666, 885.4465958775766, 913.5660561233494, 947.3889341374775, 1020.3622735790132, 25093.749062509505, 29868.40263194724, 30470.238244044078, 31253.218669532987, 31258.68741312558, 1035.3632516002604, 1048.7849990751877, 1099.4173088263233, 1113.9387333696725, 1119.9720006999728, 12631.93684031574, 15569.299381527859, 15725.977811442219, 15873.365065397255, 16149.426429948737, 631240.0, 638093.0, 639140.0, 639151.0, 640325.0, 59329.70335148297, 59395.703021484616, 59505.214843554764, 59597.44428112904, 59808.0, 1224.1920332580455, 1264.8608653048157, 1346.279740338914, 1371.5131128449257, 1396.532161725813, 29023.564646529896, 31420.586073626284, 31496.37007259796, 31817.706491915567, 32167.678323216467, 49135.75432122817, 49886.0, 50088.248676269155, 50106.99786004187, 50253.24113656004, 488871.1128887083, 491762.0, 492406.53796730784, 492437.0, 492601.0, 30489.54265686061, 33861.153471163416, 34790.82604586961, 39834.2033159341, 40002.0, 37740.62259377371, 44410.777946110065, 47545.28682069702, 48459.75770121127, 48984.75507622439, 31250.531242030935, 39776.403353949136, 39958.40062399124, 40313.59686403216, 40710.59289407068, 38601.560820506, 39699.60300397075, 39781.60218397779, 40637.79681101575, 40865.38701919414, 27648.0, 31043.84478077595, 38335.61664383432, 39000.0, 39443.80278098591, 30901.381972360876, 32964.50553241751, 34914.82542587271, 35253.942381728586, 35393.0, 21732.565348693253, 24543.159263054986, 24718.505629887663, 25948.0, 26053.64747084767], "value": 20078.502166212118, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.20608189001524, 365.26581571042203, 365.51021631014453, 367.90802299425144, 390.02299240402806, 14145.84304661383, 15525.990810597303, 20922.267720629763, 22228.444288892784, 22247.22134725285, 20007.699884501744, 20700.068496917636, 20769.896150519264, 20874.851883146457, 20924.58150836982, 3591.2278860045085, 5297.655652382602, 5473.589480788937, 5487.0, 5506.972465137669, 4075.9796201019103, 6664.233613134503, 6665.900011499832, 6694.899576506356, 6734.326567343275, 6020.0, 6105.32841387447, 6637.269900310962, 6642.800715978528, 6669.366410191048, 6052.0, 6072.301685306202, 6085.756569737206, 6086.6348019119, 6087.847803804896, 5602.38373778884, 5828.358880523139, 5872.765089396419, 5882.882342353129, 5888.705564721747, 13278.734425311537, 13335.133216340906, 13382.732345353039, 13501.054926155173, 13513.797293040612, 1915.9137838797287, 2118.4597927528534, 2187.0814258011515, 2467.543504451682, 2935.6623988241413, 9856.310058295921, 9952.502374881227, 10311.48442577868, 10371.429571373572, 10461.476926153662, 1840.5214644192472, 1842.1710230396375, 1891.8675692701515, 1949.4151754473744, 1953.7264782930401, 104591.47704261506, 127094.0, 128652.0, 130229.99999999905, 130324.96750324986, 10306.156106629873, 10420.374777513221, 10828.891711082946, 11201.047910927662, 11366.261193022592, 14225.933055020914, 14293.499727509487, 14302.642433939234, 14304.28478576067, 14306.141631502143, 8165.877511837327, 8492.891369077006, 8517.148285171434, 8598.957005214934, 8654.524001179869, 8456.704015359555, 8458.238758511763, 8461.873071903927, 8637.309015278763, 8657.826843463095, 4353.542877997828, 4449.7330160190495, 4497.234200966447, 4517.81928722854, 4567.132244873464, 1832.4777438429983, 1900.6863867461714, 1914.4830895658095, 1919.500929758245, 1926.566522532419, 789.6486063701713, 830.4519017448455, 911.3392790227032, 946.5314669238634, 976.4483067067084, 16848.494545163663, 20746.0, 20768.68846967297, 21815.0, 21817.0, 846.9915300846912, 939.2908354192541, 940.219617717293, 940.2431043010442, 1022.616518805448, 8803.603837827184, 11294.887051129384, 11421.771564568662, 11476.13928955315, 11483.483243254073, 448632.0, 470849.0, 597424.0, 618736.0, 619668.9016554889, 91326.0, 117980.41009794896, 121176.78823211831, 133483.0, 138425.61574384128, 411.53907623461913, 430.4941693510113, 432.9199098166786, 435.4730775761301, 436.2561832076366, 10454.790904181722, 11041.00630943219, 11062.668119956414, 11192.0, 11385.804490528375, 53010.0, 55740.0, 55934.16098758441, 56426.71786641041, 57365.13952290636, 58695.0, 76005.61997189978, 76134.23865761493, 76848.6157569231, 78170.6091469539, 6387.393197646216, 7910.841783164419, 7916.762497125095, 8048.678052877819, 8136.918630813616, 11220.607278745205, 12158.574449894211, 12870.09909306377, 12980.935095324463, 13200.603981880558, 10887.0, 11209.879012098725, 11371.896199203175, 11509.884901151216, 11711.824322634997, 11070.059044981266, 11098.778024439627, 11150.442477876237, 11463.885361146615, 11485.310881347146, 10087.940766219735, 11206.263029230482, 11389.259698119597, 11470.197086203885, 11504.94247528757, 7932.682692692459, 7957.045154581488, 7975.003124609424, 8053.718119866011, 8071.757847264592, 8088.676452941816, 10727.946360268461, 11297.943510282395, 11402.82895756581, 11899.524019039141], "value": 8973.228237500542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.4032716749714, 1518.9696206075878, 1644.2354305248057, 1761.9911900440495, 1807.4035568262466, 8363.665453381866, 8835.469871807696, 8838.91161088389, 8840.204381605654, 8857.645694172234, 7784.221577842227, 7995.040595128578, 8404.537750423724, 8631.180037896389, 8648.654053837854, 2308.1921327535356, 2337.6610391493223, 2343.1915988983774, 2345.1909091363455, 2348.154664320843, 2317.79139877411, 2330.0330362899376, 2365.136725095345, 2368.8460250083776, 2368.8578685278853, 2326.7440581536016, 2332.323626148415, 2349.682792822964, 2357.4342157882156, 2362.3149286706835, 2307.573098976695, 2321.245595181564, 2328.976710232893, 2329.9301020969315, 2340.4850932794757, 2312.838101332907, 2318.466752646884, 2318.8029017533363, 2319.5940710375617, 2322.5587138443643, 7932.08780990182, 8384.119667434954, 8739.60671769772, 8786.60460279289, 8866.733997980007, 5096.0, 5271.736413179326, 5281.234221037928, 5281.9207711884355, 5293.9735301323635, 3455.274392377579, 3518.2259902821593, 3672.6694597486353, 3681.067439594208, 3684.6683798458266, 1061.7664113895007, 1089.760252744395, 1097.939613321267, 1102.6306187427222, 1116.972075698114, 11433.885661143448, 11542.59600913964, 11545.01867341277, 11551.826722599168, 11552.6534203974, 4429.09203613265, 4515.412996310459, 4656.394668693116, 4689.968206994456, 4695.3426520287185, 9829.346076559288, 9834.360766550151, 9852.162566181954, 9860.0, 9929.950350248202, 4625.074985003012, 5265.78936842522, 5267.525922666979, 5278.709670968057, 5283.498067683564, 4294.463192100988, 4359.411479450234, 4473.418455600751, 4489.034857505652, 4671.8364857229835, 3907.6873850092493, 3989.8204580793936, 4006.5192176938954, 4008.378701301303, 4013.4180543821567, 1237.4926280225066, 1272.211229037984, 1275.5216793702361, 1281.5450515067016, 1288.1626942487271, 903.7379160043514, 923.215267023025, 930.2418429168877, 939.9295052871062, 969.1035791892472, 5882.176495290662, 5935.436133567304, 6034.185384972972, 6145.661988590581, 6172.099712368176, 430.9612134907873, 436.7401396169274, 437.14319932931176, 441.98453054143596, 444.63539897283914, 3987.641112299849, 4011.13760541485, 4058.370952502367, 4097.85657501986, 4101.200265948171, 10212.0, 10618.256722029384, 10655.946720266349, 10700.839487407695, 10730.444085607543, 10639.414832184304, 10655.30740501865, 10689.251752377259, 10700.732481688021, 10769.407682577377, 7989.56057416836, 8177.0, 8184.468009579358, 8197.098319184885, 8200.753977380688, 5720.542356611544, 6005.549583781147, 6082.635041897501, 6163.291221509584, 6182.690865456799, 9582.856257156009, 9895.50522473859, 9988.650397236062, 10005.549750261402, 10049.547770350206, 9060.728178154666, 9550.713478595653, 10037.74905627336, 10138.03688649577, 10157.54291056919, 7017.543859649107, 7154.03264102376, 7170.0, 7176.677049532679, 7352.779416617296, 6781.355771201728, 8129.670373233284, 8235.423520353517, 8279.95860020696, 8355.0, 7431.591262480615, 7514.774556763306, 7611.771646850603, 7621.0, 7626.351760100231, 6105.786297479567, 6193.977993631001, 7310.451716121206, 7312.707491700486, 7380.225076366904, 6847.315268473113, 6975.907227831732, 6986.764235444813, 6998.580085194904, 7012.544184627983, 4930.901381972412, 5033.513728215989, 5057.949420505895, 5058.3929928408825, 5248.291480650063, 5025.321581586585, 5117.1045067113855, 5180.378354597472, 5214.739263036909, 5284.524392804666], "value": 4470.441205074558, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [249.7739545711131, 300.92476880779805, 306.02683466576286, 310.456700773646, 312.9561861339412, 4931.506849315071, 5106.463821298761, 5490.917636235455, 5520.972395138018, 5526.0, 4381.466486729643, 5428.972855135728, 5487.533559647435, 5494.340679118512, 5505.064139096353, 3457.5159477673146, 3910.863119790815, 3911.902202444933, 3991.1219531703123, 4071.803634147195, 3136.541508198687, 3247.33429646923, 4130.380442933554, 4136.490181083897, 4136.627703506684, 3556.590992035923, 4059.2490389278078, 4060.4315395844606, 4083.1629515949307, 4115.238680844039, 3466.324066806974, 3667.636650411534, 3861.4014827701753, 4103.537877273627, 4114.403411505345, 2896.420715856816, 3053.6869146267095, 3412.941987983733, 3526.4710293455933, 3536.5756109266795, 4589.79345929434, 4767.0, 5240.973795131038, 5289.841304760864, 5320.441353657849, 4540.296254080623, 4661.160991021615, 4731.503192164808, 4732.574068333866, 4738.549837765407, 5043.722595257259, 5394.676319420847, 5649.124385720179, 5668.206451096849, 5693.373728889819, 3584.4085725855202, 3960.3663413853646, 3962.1679447316096, 3965.4448377227213, 3970.086880017612, 5140.021091879653, 5751.25233719618, 5759.654420734728, 5927.2590926134235, 5946.970265148733, 3975.131688106643, 3987.521497420328, 4011.7592944423427, 4013.618706222904, 4015.5382131055303, 3552.4316109422884, 3556.484309775068, 3800.973737091025, 4012.0, 4110.938335924963, 3818.9497888081, 4068.931068931069, 4308.965848196411, 4702.858914232578, 4728.668993170514, 4800.183968725325, 5531.142672885629, 5648.971755141198, 5681.909025501633, 5713.0, 1108.4402376799826, 1292.0748085352757, 1362.4073528015344, 1384.2870921475449, 1389.4997800791707, 776.6311002273875, 796.2873228460495, 856.8329175810782, 860.7675927499665, 863.4948555095214, 5023.79904803811, 5040.974795126001, 5141.331626888481, 5161.122609156452, 5395.514403703607, 5123.949590333973, 5375.569954403716, 5880.618054757128, 5897.994681808206, 5959.374265702126, 4302.526722060571, 4862.350019239523, 5037.345145131183, 5376.542993845489, 5380.542653874386, 2646.4839356325715, 3029.409265193266, 3034.893778717734, 3066.3254084101463, 3077.691980908105, 4897.41231052276, 5554.833354999357, 5841.795537156179, 5977.641341519523, 6089.219962329638, 4702.835400761025, 5519.834404967857, 5962.3927523848315, 5968.045112782021, 6119.0, 5129.923051154161, 5312.787488500494, 5959.927213101683, 6120.969395153084, 6136.956717358149, 5272.736363181903, 5751.53335899343, 5939.792107276225, 5948.434898684618, 5986.700664966821, 5255.1081610619385, 5786.6528008317955, 5818.0, 5819.836032793373, 5827.825165245049, 5252.868678282921, 5604.131359639263, 6048.427408873813, 6148.938510614837, 6211.9068213977735, 3728.496652951925, 3843.2889915365745, 3909.143157000402, 3909.7849618271266, 3930.973150673908, 5877.825204674298, 5883.676397797991, 5887.499562537232, 5898.852528686645, 5911.290645122613, 4925.408950925768, 5823.679697616672, 5840.795572154954, 5846.1815345852465, 5856.677882716321, 5170.71561064145, 5588.524975377139, 5729.455701708331, 5758.62568933018, 5772.5959182856795, 5618.410066942912, 5621.8594535136945, 5638.85902852432, 5690.800821971211, 5736.368999410145, 4101.815418306123, 4770.833020844392, 5521.978433989564, 5597.776088956396, 5616.494515493625, 4922.532359425849, 5531.474509921551, 5574.219609254626, 5582.246396736551, 5599.944000560105], "value": 4103.934230137111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.9295523969982, 702.3012102957555, 704.9753258635945, 716.9533980291284, 799.9040115186177, 15688.843111568882, 16048.35806567736, 16799.824012319143, 17059.65880682389, 17077.487675369728, 15076.6984660307, 15167.1658058807, 15355.539333819976, 15377.769333459979, 15426.922865385686, 842.9747107586767, 858.0432817408607, 860.2343913916619, 861.2421069458867, 863.3007264116055, 673.6833688166579, 694.6978064541916, 836.7196989008689, 866.5970323799432, 868.0, 903.8192361527688, 920.0707285641516, 923.8891333040044, 923.9676611318605, 929.0338048429625, 909.6725178935578, 911.1480765484293, 911.4303560274828, 913.392593925039, 916.9128932751378, 523.4451481429696, 649.405793698765, 672.6434989455596, 679.8232459560501, 680.0, 15265.23673816316, 15329.616759580987, 15334.616634584114, 15347.0, 15376.692466150615, 13898.93050534751, 14275.643108922257, 14322.0, 14367.856321436757, 14661.34023968924, 12895.871041289562, 13040.413181406859, 13205.20768753878, 13317.067805253637, 13616.251106189156, 4581.0, 4589.908201835978, 4673.112108699336, 4702.764861756898, 4786.066716990188, 121083.0, 121145.0, 122723.0, 123484.0, 123775.0, 10464.895351046393, 10627.519797968715, 10765.677029689123, 11005.449727513753, 11018.757778255269, 20125.194992200442, 22728.431789205402, 22948.770512294665, 23051.308460746204, 23116.075356985868, 7981.321587665114, 8046.114927357986, 8084.636191371403, 8116.2695357418115, 8178.96224671741, 4325.7188282762145, 4408.9559104408545, 4450.2434586120435, 4576.473705523841, 4675.29870519418, 3400.59192896854, 3536.1159710072484, 3537.7169826413824, 3538.062413460435, 3542.3977923753023, 626.4518546272012, 641.2657507154375, 642.4250295985067, 662.1656712542135, 662.8574856405896, 541.0315535192041, 563.2790028763189, 591.8431615621863, 611.458858909868, 617.0836308082494, 8362.16378362171, 8551.230389264996, 8800.647974081094, 8947.418417802823, 8976.461412315282, 503.768266597362, 534.3934634190144, 584.1792281844016, 598.3238939997775, 607.8662694207268, 3472.5138480612736, 4303.505096913895, 4396.010897548026, 4523.25366314561, 4987.850364489072, 146893.0, 150684.0, 153111.0, 161937.3806261946, 163538.0, 87659.56170219109, 105352.47323763485, 113266.0, 113787.86212137938, 114101.85898140912, 32465.513017304285, 109601.0, 111001.33497997536, 112477.0, 116034.0, 9035.367524273237, 9163.49600771964, 9329.766755831159, 9697.709068727949, 9839.754006149904, 51074.0, 57162.7141864288, 60202.69898650479, 61947.0, 64746.0, 64391.356086438536, 94086.52956735172, 96697.0, 97862.02137978814, 97927.0207297918, 12820.935895320463, 13198.20810751358, 13384.063115581816, 13475.0, 13801.861981380058, 14761.0, 14788.778168327268, 14824.851751482347, 14964.17697026674, 15418.997765145677, 12366.690832729253, 13889.652758681113, 13951.0, 14207.573772786833, 14643.414263429344, 13509.256990865204, 13657.0, 13859.514916977858, 14049.22729249901, 14311.284435778378, 13722.862771372158, 13821.516246931309, 13934.651633709238, 13999.370028348545, 14156.50452234167, 11254.38100904458, 11404.657860264206, 11499.712507187387, 11705.297682139098, 11732.824007639721, 10745.623903163665, 11420.600278990196, 11483.770324593628, 11637.0, 11685.415729213675], "value": 7835.878974178373, "unit": "score"}], "name": "dromaeo_css", "value": 7265.774614064001, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 114.0, 114.0, 110.0, 113.0, 112.0, 112.0, 114.0, 114.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 122.0, 142.0, 205.0, 95.0, 135.0, 165.0, 139.0, 177.0, 106.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 184.0, 185.0, 183.0, 184.0, 182.0, 181.0, 181.0, 185.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 57.0, 61.0, 86.0, 63.0, 58.0, 64.0, 69.0, 87.0, 64.0], "value": 68.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 92.0, 97.0, 94.0, 104.0, 102.0, 97.0, 71.0, 68.0, 104.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 73.0, 117.0, 132.0, 103.0, 87.0, 91.0, 87.0, 91.0, 75.0], "value": 98.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 97.0, 96.0, 95.0, 101.0, 153.0, 95.0, 95.0], "value": 101.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 87.0, 83.0, 86.0, 86.0, 86.0, 85.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 54.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 69.0, 78.0, 75.0, 73.0, 67.0, 67.0, 67.0, 69.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 83.0, 85.0, 85.0, 84.0, 83.0, 88.0, 91.0, 90.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 140.0, 137.0, 133.0, 136.0, 126.0, 140.0, 154.0, 140.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 168.0, 171.0, 169.0, 169.0, 169.0, 169.0, 168.0, 167.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1467.0, "alertThreshold": 2.0}]} 06:14:04 INFO - Return code: 0 06:14:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:14:04 INFO - # TBPL SUCCESS # 06:14:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:14:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:14:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:14:04 INFO - 2016-08-19 06:14:04.987 screenresolution[1660:9658] starting screenresolution argv=screenresolution get 06:14:04 INFO - 2016-08-19 06:14:04.990 screenresolution[1660:9658] Display 0: 1600x1200x32@60 06:14:04 INFO - 2016-08-19 06:14:04.997 screenresolution[1661:9661] starting screenresolution argv=screenresolution list 06:14:04 INFO - Available Modes on Display 0 06:14:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:14:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:14:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:14:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:14:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:14:05 INFO - Intel Iris: 06:14:05 INFO - Chipset Model: Intel Iris 06:14:05 INFO - Type: GPU 06:14:05 INFO - Bus: Built-In 06:14:05 INFO - VRAM (Dynamic, Max): 1536 MB 06:14:05 INFO - Vendor: Intel (0x8086) 06:14:05 INFO - Device ID: 0x0a2e 06:14:05 INFO - Revision ID: 0x0009 06:14:05 INFO - Displays: 06:14:05 INFO - Display: 06:14:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:14:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:14:05 INFO - Display Serial Number: 1600x1200 60 06:14:05 INFO - Main Display: Yes 06:14:05 INFO - Mirror: Off 06:14:05 INFO - Online: Yes 06:14:05 INFO - Rotation: Supported 06:14:05 INFO - Return code: 0 06:14:05 INFO - Running post-action listener: _resource_record_post_action 06:14:05 INFO - [mozharness: 2016-08-19 13:14:05.251675Z] Finished run-tests step (success) 06:14:05 INFO - Running post-run listener: _resource_record_post_run 06:14:05 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37114880; Write bytes: 705026048; Read time: 241; Write time: 2033 06:14:05 INFO - TinderboxPrint: CPU usage
53.5% 06:14:05 INFO - TinderboxPrint: I/O read bytes / time
37,114,880 / 241 06:14:05 INFO - TinderboxPrint: I/O write bytes / time
705,026,048 / 2,033 06:14:05 INFO - TinderboxPrint: CPU idle
2,257.0 (46.5%) 06:14:05 INFO - TinderboxPrint: CPU system
977.0 (20.1%) 06:14:05 INFO - TinderboxPrint: CPU user
1,623.7 (33.4%) 06:14:05 INFO - TinderboxPrint: Swap in / out
442,580,992 / 0 06:14:05 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384223744; Write bytes: 378943488; Read time: 29292; Write time: 841 06:14:05 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36156416; Write bytes: 296419328; Read time: 229; Write time: 1119 06:14:05 INFO - Running post-run listener: _upload_blobber_files 06:14:05 INFO - Blob upload gear active. 06:14:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:05 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 06:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:14:06 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:14:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:07 INFO - (blobuploader) - INFO - Done attempting. 06:14:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:14:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:08 INFO - (blobuploader) - INFO - Done attempting. 06:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:14:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:11 INFO - (blobuploader) - INFO - Done attempting. 06:14:11 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:11 INFO - Return code: 0 06:14:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faddae13036141d03b375e531811f032a91eec68919765452a956c71742e17341880d70dd48bd6a7cd463f583da886f30234fa53896088c0100702ab61d2bd70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85067c099ec64e4e25aa356c39624e4587f19ede075ef70b88602899db4fbadded4dc894984681a47b7c8c9ac7ddd5ec9d4b8bdeaf4c03ec90e64601d8fd60c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11a18145311e586a0da13b0cf5bf7dc36f1b3e6cf5a4404299f754a29f29e40473128fab160902be4742747e857171ea566fac945ce46ed2a76030da463fdc6d"} 06:14:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:11 INFO - Contents: 06:14:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faddae13036141d03b375e531811f032a91eec68919765452a956c71742e17341880d70dd48bd6a7cd463f583da886f30234fa53896088c0100702ab61d2bd70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85067c099ec64e4e25aa356c39624e4587f19ede075ef70b88602899db4fbadded4dc894984681a47b7c8c9ac7ddd5ec9d4b8bdeaf4c03ec90e64601d8fd60c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11a18145311e586a0da13b0cf5bf7dc36f1b3e6cf5a4404299f754a29f29e40473128fab160902be4742747e857171ea566fac945ce46ed2a76030da463fdc6d"} 06:14:11 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:11 INFO - Copying logs to upload dir... 06:14:11 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.523494 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-19 06:14:11.082766) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 06:14:11.086516) ========= 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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faddae13036141d03b375e531811f032a91eec68919765452a956c71742e17341880d70dd48bd6a7cd463f583da886f30234fa53896088c0100702ab61d2bd70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85067c099ec64e4e25aa356c39624e4587f19ede075ef70b88602899db4fbadded4dc894984681a47b7c8c9ac7ddd5ec9d4b8bdeaf4c03ec90e64601d8fd60c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11a18145311e586a0da13b0cf5bf7dc36f1b3e6cf5a4404299f754a29f29e40473128fab160902be4742747e857171ea566fac945ce46ed2a76030da463fdc6d"} build_url:https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faddae13036141d03b375e531811f032a91eec68919765452a956c71742e17341880d70dd48bd6a7cd463f583da886f30234fa53896088c0100702ab61d2bd70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85067c099ec64e4e25aa356c39624e4587f19ede075ef70b88602899db4fbadded4dc894984681a47b7c8c9ac7ddd5ec9d4b8bdeaf4c03ec90e64601d8fd60c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11a18145311e586a0da13b0cf5bf7dc36f1b3e6cf5a4404299f754a29f29e40473128fab160902be4742747e857171ea566fac945ce46ed2a76030da463fdc6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 06:14:11.121759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 06:14:11.122254) ========= 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.UyF3XX9h1m/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.KM2zH0H6oS/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.005192 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 06:14:11.172090) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 06:14:11.172470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 06:14:11.172938) ========= ========= Total master_lag: 0.23 =========