builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0350 starttime: 1470650685.73 results: success (0) buildid: 20160807235452 builduid: dad1f431d90b4539961cf9d4f34e5d2d revision: 5e045cadaa9fef76f5b5dc61a25cdd927e425486 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:45.725728) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:45.726108) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:45.726377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:46.165508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:46.165809) ========= 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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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-08 03:04:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2016-08-08 03:04:46 (19.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.497374 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:46.689439) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:46.692782) ========= 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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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.025561 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:46.740419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 03:04:46.743797) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5e045cadaa9fef76f5b5dc61a25cdd927e425486 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5e045cadaa9fef76f5b5dc61a25cdd927e425486 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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-08 03:04:46,830 truncating revision to first 12 chars 2016-08-08 03:04:46,830 Setting DEBUG logging. 2016-08-08 03:04:46,830 attempt 1/10 2016-08-08 03:04:46,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5e045cadaa9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 03:04:47,836 unpacking tar archive at: fx-team-5e045cadaa9f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.290200 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 03:04:48.055374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:48.055693) ========= script_repo_revision: 5e045cadaa9fef76f5b5dc61a25cdd927e425486 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:48.056088) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:48.056354) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 03:04:48.074613) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-08 03:04:48.074881) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:04:48 INFO - MultiFileLogger online at 20160808 03:04:48 in /builds/slave/test 03:04:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:04:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:04:48 INFO - {'append_to_log': False, 03:04:48 INFO - 'base_work_dir': '/builds/slave/test', 03:04:48 INFO - 'blob_upload_branch': 'Fx-Team', 03:04:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:04:48 INFO - 'branch': 'Fx-Team', 03:04:48 INFO - 'buildbot_json_path': 'buildprops.json', 03:04:48 INFO - 'config_files': ('talos/mac_config.py',), 03:04:48 INFO - 'default_actions': ('clobber', 03:04:48 INFO - 'read-buildbot-config', 03:04:48 INFO - 'download-and-extract', 03:04:48 INFO - 'populate-webroot', 03:04:48 INFO - 'create-virtualenv', 03:04:48 INFO - 'install', 03:04:48 INFO - 'run-tests'), 03:04:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:04:48 INFO - 'download_minidump_stackwalk': True, 03:04:48 INFO - 'download_symbols': 'ondemand', 03:04:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:04:48 INFO - 'tooltool.py': '/tools/tooltool.py', 03:04:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:04:48 INFO - '/tools/misc-python/virtualenv.py')}, 03:04:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:04:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:04:48 INFO - 'installer_path': 'installer.exe', 03:04:48 INFO - 'log_level': 'info', 03:04:48 INFO - 'log_name': 'talos', 03:04:48 INFO - 'log_to_console': True, 03:04:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:04:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:04:48 INFO - 'opt_config_files': (), 03:04:48 INFO - 'pip_index': False, 03:04:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:04:48 INFO - 'cmd': ('bash', 03:04:48 INFO - '-c', 03:04:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:04:48 INFO - 'enabled': True, 03:04:48 INFO - 'halt_on_failure': False, 03:04:48 INFO - 'name': 'check_screen_resolution'},), 03:04:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:04:48 INFO - 'cmd': ('bash', 03:04:48 INFO - '-c', 03:04:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:04:48 INFO - 'enabled': True, 03:04:48 INFO - 'halt_on_failure': False, 03:04:48 INFO - 'name': 'check_screen_resolution'},), 03:04:48 INFO - 'run_cmd_checks_enabled': True, 03:04:48 INFO - 'sps_profile': False, 03:04:48 INFO - 'sps_profile_interval': 0, 03:04:48 INFO - 'suite': 'dromaeojs-e10s', 03:04:48 INFO - 'system_bits': '32', 03:04:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:04:48 INFO - 'title': 't-yosemite-r7-0350', 03:04:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:04:48 INFO - 'use_talos_json': True, 03:04:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:04:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:04:48 INFO - 'work_dir': 'build'} 03:04:48 INFO - [mozharness: 2016-08-08 10:04:48.268837Z] Running clobber step. 03:04:48 INFO - Running pre-action listener: _resource_record_pre_action 03:04:48 INFO - Running main action method: clobber 03:04:48 INFO - rmtree: /builds/slave/test/build 03:04:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:04:50 INFO - Running post-action listener: _resource_record_post_action 03:04:50 INFO - [mozharness: 2016-08-08 10:04:50.204489Z] Finished clobber step (success) 03:04:50 INFO - [mozharness: 2016-08-08 10:04:50.204564Z] Running read-buildbot-config step. 03:04:50 INFO - Running pre-action listener: _resource_record_pre_action 03:04:50 INFO - Running main action method: read_buildbot_config 03:04:50 INFO - Using buildbot properties: 03:04:50 INFO - { 03:04:50 INFO - "project": "", 03:04:50 INFO - "product": "firefox", 03:04:50 INFO - "script_repo_revision": "production", 03:04:50 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:04:50 INFO - "repository": "", 03:04:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:04:50 INFO - "buildid": "20160807235452", 03:04:50 INFO - "pgo_build": "False", 03:04:50 INFO - "basedir": "/builds/slave/test", 03:04:50 INFO - "buildnumber": 81, 03:04:50 INFO - "slavename": "t-yosemite-r7-0350", 03:04:50 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:04:50 INFO - "platform": "yosemite_r7", 03:04:50 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 03:04:50 INFO - "branch": "fx-team", 03:04:50 INFO - "repo_path": "integration/fx-team", 03:04:50 INFO - "revision": "5e045cadaa9fef76f5b5dc61a25cdd927e425486", 03:04:50 INFO - "stage_platform": "macosx64", 03:04:50 INFO - "builduid": "dad1f431d90b4539961cf9d4f34e5d2d", 03:04:50 INFO - "slavebuilddir": "test" 03:04:50 INFO - } 03:04:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 03:04:50 INFO - Running post-action listener: _resource_record_post_action 03:04:50 INFO - [mozharness: 2016-08-08 10:04:50.208444Z] Finished read-buildbot-config step (success) 03:04:50 INFO - [mozharness: 2016-08-08 10:04:50.208619Z] Running download-and-extract step. 03:04:50 INFO - Running pre-action listener: _resource_record_pre_action 03:04:50 INFO - Running main action method: download_and_extract 03:04:50 INFO - mkdir: /builds/slave/test/build/tests 03:04: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')]} 03:04:50 INFO - trying https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 03:04:50 INFO - Downloading https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/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 03:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/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 03:04:51 INFO - Downloaded 1199 bytes. 03:04:51 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 03:04:51 INFO - Using the following test package requirements: 03:04:51 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 03:04:51 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:04:51 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 03:04:51 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:04:51 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 03:04:51 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:04:51 INFO - u'jsshell-mac.zip'], 03:04:51 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:04:51 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 03:04:51 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 03:04:51 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:04:51 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 03:04:51 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:04:51 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 03:04:51 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:04:51 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 03:04:51 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:04:51 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 03:04:51 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:04:51 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')]} 03:04:51 INFO - trying https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:04:51 INFO - Downloading https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/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 03:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/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 03:04:55 INFO - Downloaded 16324211 bytes. 03:04:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:04:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:04:58 INFO - Return code: 0 03:04:58 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 03:04: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')]} 03:04:58 INFO - trying https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:04:58 INFO - Downloading https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/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 03:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/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 03:04:59 INFO - Downloaded 16324211 bytes. 03:04:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:04:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:05:03 INFO - Return code: 0 03:05:03 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')]} 03:05:03 INFO - trying https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 03:05:03 INFO - Downloading https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/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 03:05:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/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 03:05:04 INFO - Downloaded 14413723 bytes. 03:05:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:05:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:05:04 INFO - Return code: 0 03:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:04 INFO - trying https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:05:04 INFO - Downloading https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 03:05:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/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 03:05:07 INFO - Downloaded 111873452 bytes. 03:05:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:05:07 INFO - mkdir: /builds/slave/test/properties 03:05:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:05:07 INFO - Writing to file /builds/slave/test/properties/build_url 03:05:07 INFO - Contents: 03:05:07 INFO - build_url:https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:05:08 INFO - Running post-action listener: _resource_record_post_action 03:05:08 INFO - Running post-action listener: set_extra_try_arguments 03:05:08 INFO - [mozharness: 2016-08-08 10:05:08.685404Z] Finished download-and-extract step (success) 03:05:08 INFO - [mozharness: 2016-08-08 10:05:08.685570Z] Running populate-webroot step. 03:05:08 INFO - Running pre-action listener: _resource_record_pre_action 03:05:08 INFO - Running main action method: populate_webroot 03:05:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:05:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:05:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:05:08 INFO - '--tppagecycles', 03:05:08 INFO - '7'], 03:05:08 INFO - 'tests': ['tsvgm']}}, 03:05:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:05:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:05:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:05:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:05:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:08 INFO - 'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:05:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:05:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:08 INFO - 'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['damp', 'tps']}, 03:05:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:08 INFO - 'tests': ['damp', 'tps']}, 03:05:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['dromaeo_dom']}, 03:05:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:05:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['basic_compositor_video']}, 03:05:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:05:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['a11yr', 03:05:08 INFO - 'ts_paint', 03:05:08 INFO - 'tpaint', 03:05:08 INFO - 'sessionrestore', 03:05:08 INFO - 'sessionrestore_no_auto_restore', 03:05:08 INFO - 'tabpaint']}, 03:05:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:05:08 INFO - 'ts_paint', 03:05:08 INFO - 'tpaint', 03:05:08 INFO - 'sessionrestore', 03:05:08 INFO - 'sessionrestore_no_auto_restore', 03:05:08 INFO - 'tabpaint']}, 03:05:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:05:08 INFO - 'ts_paint', 03:05:08 INFO - 'tpaint', 03:05:08 INFO - 'sessionrestore', 03:05:08 INFO - 'sessionrestore_no_auto_restore', 03:05:08 INFO - 'tabpaint']}, 03:05:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:05:08 INFO - 'ts_paint', 03:05:08 INFO - 'tpaint', 03:05:08 INFO - 'sessionrestore', 03:05:08 INFO - 'sessionrestore_no_auto_restore', 03:05:08 INFO - 'tabpaint']}, 03:05:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['a11yr', 03:05:08 INFO - 'ts_paint', 03:05:08 INFO - 'tpaint', 03:05:08 INFO - 'sessionrestore', 03:05:08 INFO - 'sessionrestore_no_auto_restore', 03:05:08 INFO - 'tabpaint']}, 03:05:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['a11yr', 03:05:08 INFO - 'ts_paint', 03:05:08 INFO - 'tpaint', 03:05:08 INFO - 'sessionrestore', 03:05:08 INFO - 'sessionrestore_no_auto_restore', 03:05:08 INFO - 'tabpaint']}, 03:05:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['tsvgx', 03:05:08 INFO - 'tsvgr_opacity', 03:05:08 INFO - 'tart', 03:05:08 INFO - 'tscrollx', 03:05:08 INFO - 'cart']}, 03:05:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:05:08 INFO - 'tsvgr_opacity', 03:05:08 INFO - 'tart', 03:05:08 INFO - 'tscrollx', 03:05:08 INFO - 'cart']}, 03:05:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:08 INFO - 'talos_options': ['--disable-e10s'], 03:05:08 INFO - 'tests': ['tp5o']}, 03:05:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:08 INFO - 'tests': ['tp5o']}, 03:05:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:08 INFO - 'talos_options': ['--disable-e10s', 03:05:08 INFO - '--xperf_path', 03:05:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:05:08 INFO - 'tests': ['tp5n']}, 03:05:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:05:08 INFO - 'talos_options': ['--xperf_path', 03:05:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:05:08 INFO - 'tests': ['tp5n']}}, 03:05:08 INFO - 'talos.zip': {'path': '', 03:05:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:05:08 INFO - Running post-action listener: _resource_record_post_action 03:05:08 INFO - [mozharness: 2016-08-08 10:05:08.704562Z] Finished populate-webroot step (success) 03:05:08 INFO - [mozharness: 2016-08-08 10:05:08.704672Z] Running create-virtualenv step. 03:05:08 INFO - Running pre-action listener: _resource_record_pre_action 03:05:08 INFO - Running main action method: create_virtualenv 03:05:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:05:08 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 03:05:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:05:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:05:08 INFO - Using real prefix '/tools/python27' 03:05:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:05:09 INFO - Installing distribute.............................................................................................................................................................................................done. 03:05:12 INFO - Installing pip.................done. 03:05:12 INFO - Return code: 0 03:05:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7256a220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, '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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:05:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:05:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:05:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:05:12 INFO - 'HOME': '/Users/cltbld', 03:05:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:05:12 INFO - 'LOGNAME': 'cltbld', 03:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:12 INFO - 'MOZ_NO_REMOTE': '1', 03:05:12 INFO - 'NO_EM_RESTART': '1', 03:05:12 INFO - 'PAGER': '/bin/cat', 03:05:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:12 INFO - 'PWD': '/builds/slave/test', 03:05:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:05:12 INFO - 'SHELL': '/bin/bash', 03:05:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:05:12 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:05:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:05:12 INFO - 'USER': 'cltbld', 03:05:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:05:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:12 INFO - 'XPC_FLAGS': '0x0', 03:05:12 INFO - 'XPC_SERVICE_NAME': '0', 03:05:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:05:12 INFO - Cleaning up... 03:05:12 INFO - Return code: 0 03:05:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7256a220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, '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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:05:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:05:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:05:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:05:12 INFO - 'HOME': '/Users/cltbld', 03:05:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:05:12 INFO - 'LOGNAME': 'cltbld', 03:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:12 INFO - 'MOZ_NO_REMOTE': '1', 03:05:12 INFO - 'NO_EM_RESTART': '1', 03:05:12 INFO - 'PAGER': '/bin/cat', 03:05:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:12 INFO - 'PWD': '/builds/slave/test', 03:05:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:05:12 INFO - 'SHELL': '/bin/bash', 03:05:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:05:12 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:05:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:05:12 INFO - 'USER': 'cltbld', 03:05:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:05:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:12 INFO - 'XPC_FLAGS': '0x0', 03:05:12 INFO - 'XPC_SERVICE_NAME': '0', 03:05:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:12 INFO - Downloading/unpacking psutil>=3.1.1 03:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:05:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:05:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:05:16 INFO - Installing collected packages: psutil 03:05:16 INFO - Running setup.py install for psutil 03:05:16 INFO - building 'psutil._psutil_osx' extension 03:05:16 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 03:05:16 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 03:05:17 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 03:05:17 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 03:05:17 INFO - building 'psutil._psutil_posix' extension 03:05:17 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 03:05:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:05:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:05:17 INFO - ^ 03:05:17 INFO - 1 warning generated. 03:05:17 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 03:05:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:05:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:05:17 INFO - Successfully installed psutil 03:05:17 INFO - Cleaning up... 03:05:17 INFO - Return code: 0 03:05:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7256a220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, '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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:05:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:05:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:05:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:05:17 INFO - 'HOME': '/Users/cltbld', 03:05:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:05:17 INFO - 'LOGNAME': 'cltbld', 03:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:17 INFO - 'MOZ_NO_REMOTE': '1', 03:05:17 INFO - 'NO_EM_RESTART': '1', 03:05:17 INFO - 'PAGER': '/bin/cat', 03:05:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:17 INFO - 'PWD': '/builds/slave/test', 03:05:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:05:17 INFO - 'SHELL': '/bin/bash', 03:05:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:05:17 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:05:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:05:17 INFO - 'USER': 'cltbld', 03:05:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:05:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:17 INFO - 'XPC_FLAGS': '0x0', 03:05:17 INFO - 'XPC_SERVICE_NAME': '0', 03:05:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:05:20 INFO - Installing collected packages: mozsystemmonitor 03:05:20 INFO - Running setup.py install for mozsystemmonitor 03:05:20 INFO - Successfully installed mozsystemmonitor 03:05:20 INFO - Cleaning up... 03:05:20 INFO - Return code: 0 03:05:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7256a220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, '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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:05:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:05:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:05:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:05:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:05:20 INFO - 'HOME': '/Users/cltbld', 03:05:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:05:20 INFO - 'LOGNAME': 'cltbld', 03:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:20 INFO - 'MOZ_NO_REMOTE': '1', 03:05:20 INFO - 'NO_EM_RESTART': '1', 03:05:20 INFO - 'PAGER': '/bin/cat', 03:05:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:20 INFO - 'PWD': '/builds/slave/test', 03:05:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:05:20 INFO - 'SHELL': '/bin/bash', 03:05:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:05:20 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:05:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:05:20 INFO - 'USER': 'cltbld', 03:05:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:05:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:20 INFO - 'XPC_FLAGS': '0x0', 03:05:20 INFO - 'XPC_SERVICE_NAME': '0', 03:05:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:20 INFO - Downloading/unpacking jsonschema==2.5.1 03:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:05:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:05: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 03:05: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 03:05: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 03:05: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 03:05: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 03:05: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 03:05:23 INFO - Downloading functools32-3.2.3-2.tar.gz 03:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:05:23 INFO - warning: no files found matching '*.txt' 03:05:23 INFO - no previously-included directories found matching 'build' 03:05:23 INFO - no previously-included directories found matching 'dist' 03:05:23 INFO - no previously-included directories found matching '.git*' 03:05:23 INFO - Installing collected packages: jsonschema, functools32 03:05:23 INFO - Running setup.py install for functools32 03:05:23 INFO - warning: no files found matching '*.txt' 03:05:23 INFO - no previously-included directories found matching 'build' 03:05:23 INFO - no previously-included directories found matching 'dist' 03:05:23 INFO - no previously-included directories found matching '.git*' 03:05:23 INFO - Successfully installed jsonschema functools32 03:05:23 INFO - Cleaning up... 03:05:23 INFO - Return code: 0 03:05:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:05: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')]} 03:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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')]} 03:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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', '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 0x104bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7256a220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, '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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:05: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:05: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 functools32==3.2.3-2 03:05:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:05:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:05:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:05:23 INFO - 'HOME': '/Users/cltbld', 03:05:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:05:23 INFO - 'LOGNAME': 'cltbld', 03:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:23 INFO - 'MOZ_NO_REMOTE': '1', 03:05:23 INFO - 'NO_EM_RESTART': '1', 03:05:23 INFO - 'PAGER': '/bin/cat', 03:05:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:23 INFO - 'PWD': '/builds/slave/test', 03:05:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:05:23 INFO - 'SHELL': '/bin/bash', 03:05:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:05:23 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:05:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:05:23 INFO - 'USER': 'cltbld', 03:05:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:05:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:23 INFO - 'XPC_FLAGS': '0x0', 03:05:23 INFO - 'XPC_SERVICE_NAME': '0', 03:05:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:05:24 INFO - Cleaning up... 03:05:24 INFO - Return code: 0 03:05:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:05:24 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')]} 03:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:24 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')]} 03:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:24 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 0x104bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7256a220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, '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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:05:24 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 03:05:24 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 03:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:05:24 INFO - 'HOME': '/Users/cltbld', 03:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:05:24 INFO - 'LOGNAME': 'cltbld', 03:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:24 INFO - 'MOZ_NO_REMOTE': '1', 03:05:24 INFO - 'NO_EM_RESTART': '1', 03:05:24 INFO - 'PAGER': '/bin/cat', 03:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:24 INFO - 'PWD': '/builds/slave/test', 03:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:05:24 INFO - 'SHELL': '/bin/bash', 03:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:05:24 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:05:24 INFO - 'USER': 'cltbld', 03:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:24 INFO - 'XPC_FLAGS': '0x0', 03:05:24 INFO - 'XPC_SERVICE_NAME': '0', 03:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:05:24 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 03:05:24 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 03:05:24 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 03:05:24 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 03:05:24 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 03:05:24 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 03:05:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:05:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:05:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:05:27 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 03:05:27 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 03:05:27 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 03:05:27 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 03:05:27 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 03:05:27 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 03:05:28 INFO - Downloading docopt-0.6.1.tar.gz 03:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:05:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:05:28 INFO - Running setup.py install for blobuploader 03:05:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:05:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:05:28 INFO - Running setup.py install for requests 03:05:28 INFO - Running setup.py install for docopt 03:05:28 INFO - Successfully installed blobuploader requests docopt 03:05:28 INFO - Cleaning up... 03:05:29 INFO - Return code: 0 03:05:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7256a220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, '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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:05:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:05:29 INFO - 'HOME': '/Users/cltbld', 03:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:05:29 INFO - 'LOGNAME': 'cltbld', 03:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:29 INFO - 'MOZ_NO_REMOTE': '1', 03:05:29 INFO - 'NO_EM_RESTART': '1', 03:05:29 INFO - 'PAGER': '/bin/cat', 03:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:29 INFO - 'PWD': '/builds/slave/test', 03:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:05:29 INFO - 'SHELL': '/bin/bash', 03:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:05:29 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:05:29 INFO - 'USER': 'cltbld', 03:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:29 INFO - 'XPC_FLAGS': '0x0', 03:05:29 INFO - 'XPC_SERVICE_NAME': '0', 03:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:29 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-6UUAwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:29 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-17zYPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:29 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-_amzLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:29 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-3qYYf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:29 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-H2BhU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:29 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-Pq1hry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:29 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-TAkxdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:30 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-rguPtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:30 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-pRJ_8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:30 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-el09qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:30 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-WO_LPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:30 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-NbjSRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:30 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-2373jP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:30 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-6wVka1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:30 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-DsyFn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:30 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-IBODb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:31 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-hlvHL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:05:31 INFO - Running setup.py install for manifestparser 03:05:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:05:31 INFO - Running setup.py install for mozcrash 03:05:31 INFO - Running setup.py install for mozdebug 03:05:31 INFO - Running setup.py install for mozdevice 03:05:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:05:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:05:31 INFO - Running setup.py install for mozfile 03:05:31 INFO - Running setup.py install for mozhttpd 03:05:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:05:32 INFO - Running setup.py install for mozinfo 03:05:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:05:32 INFO - Running setup.py install for mozInstall 03:05:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:05:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:05:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:05:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:05:32 INFO - Running setup.py install for mozleak 03:05:32 INFO - Running setup.py install for mozlog 03:05:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:05:32 INFO - Running setup.py install for moznetwork 03:05:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:05:32 INFO - Running setup.py install for mozprocess 03:05:32 INFO - Running setup.py install for mozprofile 03:05:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:05:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:05:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:05:33 INFO - Running setup.py install for mozrunner 03:05:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:05:33 INFO - Running setup.py install for mozscreenshot 03:05:33 INFO - Running setup.py install for moztest 03:05:33 INFO - Running setup.py install for mozversion 03:05:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:05:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:05:33 INFO - Cleaning up... 03:05:33 INFO - Return code: 0 03:05:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:33 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 0x104bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7256a220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, '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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:05:33 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 03:05:33 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 03:05:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:05:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:05:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:05:33 INFO - 'HOME': '/Users/cltbld', 03:05:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:05:33 INFO - 'LOGNAME': 'cltbld', 03:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:33 INFO - 'MOZ_NO_REMOTE': '1', 03:05:33 INFO - 'NO_EM_RESTART': '1', 03:05:33 INFO - 'PAGER': '/bin/cat', 03:05:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:33 INFO - 'PWD': '/builds/slave/test', 03:05:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:05:33 INFO - 'SHELL': '/bin/bash', 03:05:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:05:33 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:05:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:05:33 INFO - 'USER': 'cltbld', 03:05:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:05:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:33 INFO - 'XPC_FLAGS': '0x0', 03:05:33 INFO - 'XPC_SERVICE_NAME': '0', 03:05:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:33 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-jHXvbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:34 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)) 03:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:34 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-qRjBFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:34 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)) 03:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:34 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-L0QrAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:34 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)) 03:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:34 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-kE1H8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:34 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)) 03:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:34 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-yaJuCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:34 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)) 03:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:34 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-Y9GqHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:34 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)) 03:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:34 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-F3UHiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:34 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)) 03:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:34 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-alH9tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:34 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)) 03:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:34 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-H3Viir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:34 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)) 03:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:34 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-s0y4au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:35 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)) 03:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:35 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-gXJm9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:35 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)) 03:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:35 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-bYUNP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:35 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)) 03:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:35 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-ZLPFrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:35 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)) 03:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:35 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-log9hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:35 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)) 03:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:35 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-kilXW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:35 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)) 03:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:35 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-SggEA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:35 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)) 03:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:35 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-0ukY51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 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)) 03:05:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:05: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 03:05: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 03:05: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 03:05: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 03:05: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 03:05: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 03:05:38 INFO - Downloading blessings-1.6.tar.gz 03:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:05:38 INFO - Installing collected packages: blessings 03:05:38 INFO - Running setup.py install for blessings 03:05:38 INFO - Successfully installed blessings 03:05:38 INFO - Cleaning up... 03:05:38 INFO - Return code: 0 03:05:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:38 INFO - Reading from file tmpfile_stdout 03:05:38 INFO - Current package versions: 03:05:38 INFO - blessings == 1.6 03:05:38 INFO - blobuploader == 1.2.4 03:05:38 INFO - docopt == 0.6.1 03:05:38 INFO - functools32 == 3.2.3-2 03:05:38 INFO - jsonschema == 2.5.1 03:05:38 INFO - manifestparser == 1.1 03:05:38 INFO - mozInstall == 1.12 03:05:38 INFO - mozcrash == 0.17 03:05:38 INFO - mozdebug == 0.1 03:05:38 INFO - mozdevice == 0.48 03:05:38 INFO - mozfile == 1.2 03:05:38 INFO - mozhttpd == 0.7 03:05:38 INFO - mozinfo == 0.9 03:05:38 INFO - mozleak == 0.1 03:05:38 INFO - mozlog == 3.3 03:05:38 INFO - moznetwork == 0.27 03:05:38 INFO - mozprocess == 0.23 03:05:38 INFO - mozprofile == 0.28 03:05:38 INFO - mozrunner == 6.12 03:05:38 INFO - mozscreenshot == 0.1 03:05:38 INFO - mozsystemmonitor == 0.3 03:05:38 INFO - moztest == 0.7 03:05:38 INFO - mozversion == 1.4 03:05:38 INFO - psutil == 3.1.1 03:05:38 INFO - requests == 1.2.3 03:05:38 INFO - wsgiref == 0.1.2 03:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:38 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 0x104bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7256a220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, '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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:05:38 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 03:05:38 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 03:05:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:05:38 INFO - 'HOME': '/Users/cltbld', 03:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:05:38 INFO - 'LOGNAME': 'cltbld', 03:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:38 INFO - 'MOZ_NO_REMOTE': '1', 03:05:38 INFO - 'NO_EM_RESTART': '1', 03:05:38 INFO - 'PAGER': '/bin/cat', 03:05:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:38 INFO - 'PWD': '/builds/slave/test', 03:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:05:38 INFO - 'SHELL': '/bin/bash', 03:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:05:38 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:05:38 INFO - 'USER': 'cltbld', 03:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:38 INFO - 'XPC_FLAGS': '0x0', 03:05:38 INFO - 'XPC_SERVICE_NAME': '0', 03:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:39 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)) 03:05:39 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)) 03:05:39 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)) 03:05:39 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)) 03:05:39 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)) 03:05:39 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)) 03:05:39 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)) 03:05:39 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)) 03:05:39 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)) 03:05:39 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)) 03:05:39 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)) 03:05:39 INFO - Cleaning up... 03:05:39 INFO - Return code: 0 03:05:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:05:39 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')]} 03:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:39 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')]} 03:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:39 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 0x104bc3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c58618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7256a220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, '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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 03:05:39 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 03:05:39 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 03:05:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:05:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:05:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:05:39 INFO - 'HOME': '/Users/cltbld', 03:05:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:05:39 INFO - 'LOGNAME': 'cltbld', 03:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:39 INFO - 'MOZ_NO_REMOTE': '1', 03:05:39 INFO - 'NO_EM_RESTART': '1', 03:05:39 INFO - 'PAGER': '/bin/cat', 03:05:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:39 INFO - 'PWD': '/builds/slave/test', 03:05:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:05:39 INFO - 'SHELL': '/bin/bash', 03:05:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:05:39 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:05:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:05:39 INFO - 'USER': 'cltbld', 03:05:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:05:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:39 INFO - 'XPC_FLAGS': '0x0', 03:05:39 INFO - 'XPC_SERVICE_NAME': '0', 03:05:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:05:39 INFO - Cleaning up... 03:05:39 INFO - Return code: 0 03:05:39 INFO - Running post-action listener: _resource_record_post_action 03:05:39 INFO - Running post-action listener: _start_resource_monitoring 03:05:39 INFO - Starting resource monitoring. 03:05:39 INFO - [mozharness: 2016-08-08 10:05:39.429739Z] Finished create-virtualenv step (success) 03:05:39 INFO - [mozharness: 2016-08-08 10:05:39.430808Z] Running install step. 03:05:39 INFO - Running pre-action listener: _resource_record_pre_action 03:05:39 INFO - Running main action method: install 03:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:39 INFO - Reading from file tmpfile_stdout 03:05:39 INFO - Detecting whether we're running mozinstall >=1.0... 03:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:05:39 INFO - Reading from file tmpfile_stdout 03:05:39 INFO - Output received: 03:05:39 INFO - Usage: mozinstall [options] installer 03:05:39 INFO - Options: 03:05:39 INFO - -h, --help show this help message and exit 03:05:39 INFO - -d DEST, --destination=DEST 03:05:39 INFO - Directory to install application into. [default: 03:05:39 INFO - "/builds/slave/test"] 03:05:39 INFO - --app=APP Application being installed. [default: firefox] 03:05:39 INFO - mkdir: /builds/slave/test/build/application 03:05:39 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'] 03:05:39 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 03:06:13 INFO - Reading from file tmpfile_stdout 03:06:13 INFO - Output received: 03:06:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:06:13 INFO - Running post-action listener: _resource_record_post_action 03:06:13 INFO - [mozharness: 2016-08-08 10:06:13.889619Z] Finished install step (success) 03:06:13 INFO - [mozharness: 2016-08-08 10:06:13.889755Z] Running run-tests step. 03:06:13 INFO - Running pre-action listener: _resource_record_pre_action 03:06:13 INFO - Running main action method: run_tests 03:06:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:06:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:06:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:06:13 INFO - 2016-08-08 03:06:13.904 screenresolution[1642:7515] starting screenresolution argv=screenresolution get 03:06:13 INFO - 2016-08-08 03:06:13.907 screenresolution[1642:7515] Display 0: 1600x1200x32@60 03:06:13 INFO - 2016-08-08 03:06:13.913 screenresolution[1643:7519] starting screenresolution argv=screenresolution list 03:06:13 INFO - Available Modes on Display 0 03:06:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:06:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:06:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:06:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:06:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:06:14 INFO - Intel Iris: 03:06:14 INFO - Chipset Model: Intel Iris 03:06:14 INFO - Type: GPU 03:06:14 INFO - Bus: Built-In 03:06:14 INFO - VRAM (Dynamic, Max): 1536 MB 03:06:14 INFO - Vendor: Intel (0x8086) 03:06:14 INFO - Device ID: 0x0a2e 03:06:14 INFO - Revision ID: 0x0009 03:06:14 INFO - Displays: 03:06:14 INFO - Display: 03:06:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:06:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:06:14 INFO - Display Serial Number: 1600x1200 60 03:06:14 INFO - Main Display: Yes 03:06:14 INFO - Mirror: Off 03:06:14 INFO - Online: Yes 03:06:14 INFO - Rotation: Supported 03:06:14 INFO - Return code: 0 03:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:06:14 INFO - Python 2.7.3 03:06:14 INFO - Return code: 0 03:06:14 INFO - grabbing minidump binary from tooltool 03:06: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')]} 03:06:14 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 0x104b27d30>, '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 0x10488cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b1fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:06:14 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 03:06:14 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 03:06:14 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 03:06:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:06:14 INFO - Return code: 0 03:06:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:06:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:06:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:06:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:06:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0350', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0350 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:06:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDxmpjtLMe/Render', 03:06:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:14 INFO - 'HOME': '/Users/cltbld', 03:06:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:14 INFO - 'LOGNAME': 'cltbld', 03:06:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:06:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:14 INFO - 'MOZ_NO_REMOTE': '1', 03:06:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:06:14 INFO - 'NO_EM_RESTART': '1', 03:06:14 INFO - 'PAGER': '/bin/cat', 03:06:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:14 INFO - 'PWD': '/builds/slave/test', 03:06:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:06:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:14 INFO - 'SHELL': '/bin/bash', 03:06:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjbaHtsh1Q/Listeners', 03:06:14 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 03:06:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:14 INFO - 'USER': 'cltbld', 03:06:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:14 INFO - 'XPC_FLAGS': '0x0', 03:06:14 INFO - 'XPC_SERVICE_NAME': '0', 03:06:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0350', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:06:14 INFO - mozversion application_buildid: 20160807235452 03:06:14 INFO - mozversion application_changeset: 5e045cadaa9fef76f5b5dc61a25cdd927e425486 03:06:14 INFO - mozversion application_display_name: Nightly 03:06:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:06:14 INFO - mozversion application_name: Firefox 03:06:14 INFO - mozversion application_remotingname: firefox 03:06:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:06:14 INFO - mozversion application_vendor: Mozilla 03:06:14 INFO - mozversion application_version: 51.0a1 03:06:14 INFO - mozversion platform_buildid: 20160807235452 03:06:14 INFO - mozversion platform_changeset: 5e045cadaa9fef76f5b5dc61a25cdd927e425486 03:06:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:06:14 INFO - mozversion platform_version: 51.0a1 03:06:14 INFO - using testdate: 1470650774 03:06:14 INFO - actual date: 1470650774 03:06:14 INFO - starting webserver on 'localhost:49274' 03:06:14 INFO - SUITE-START | Running 2 tests 03:06:14 INFO - TEST-START | dromaeo_css 03:06:14 INFO - operating with platform_type : mac_ 03:06:14 INFO - Initialising browser for dromaeo_css test... 03:06:14 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmpenjEV4/profile http://localhost:49274/getInfo.html) 03:06:17 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 03:06:17 INFO - PROCESS | 1653 | colorDepth:24 03:06:17 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 03:06:17 INFO - PROCESS | 1653 | __metrics 03:06:17 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:06:18 INFO - TEST-INFO | 1653: exit 0 03:06:18 INFO - Browser initialized. 03:06:18 INFO - Running cycle 1/1 for dromaeo_css test... 03:06:18 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmpenjEV4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:06:30 INFO - PROCESS | 1657 | RSS: Main: 254758912 03:06:30 INFO - PROCESS | 1657 | 03:07:19 INFO - PROCESS | 1657 | 1470650839670 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] 03:09:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 03:09:33 INFO - PROCESS | 1657 | RSS: Main: 267345920 03:09:33 INFO - PROCESS | 1657 | 03:12:35 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 03:12:36 INFO - PROCESS | 1657 | RSS: Main: 279859200 03:12:36 INFO - PROCESS | 1657 | 03:15:38 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 03:15:38 INFO - PROCESS | 1657 | RSS: Main: 287330304 03:15:38 INFO - PROCESS | 1657 | 03:18:40 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 03:18:41 INFO - PROCESS | 1657 | RSS: Main: 287518720 03:18:41 INFO - PROCESS | 1657 | 03:21:43 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 03:21:44 INFO - PROCESS | 1657 | RSS: Main: 292073472 03:21:44 INFO - PROCESS | 1657 | 03:24:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 03:24:47 INFO - PROCESS | 1657 | RSS: Main: 292270080 03:24:47 INFO - PROCESS | 1657 | 03:24:47 INFO - PROCESS | 1657 | __start_tp_report 03:24:47 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 03:24:47 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 03:24:47 INFO - PROCESS | 1657 | |i|pagename|runs| 03:24:47 INFO - PROCESS | 1657 | |0;dojo.html;2867.9569806452905;3409.4374428219344;3428.914277143071;3431.4509678451454;3459.1697992481795;5649.4068122847075;5676;5695.77216911323;5723.11291749779;5739.282589676291;5708.343540492845;5719.59962802604;5722.2274992876055;5725.770969161229;5767.740451679674;5188.195829646411;5233.973830130844;5267.52592266696;5299.920501192485;5307.124324486455;5133.358330208724;5142.971405718871;5200.7399630018535;5204.34945631796;5241.3186285782795;5178.818741344035;5179.663321884065;5192.299039629658;5214.947850521522;5227.60792940531;5188.507091826271;5203.219517072432;5231.869203269911;5257.106291930381;5257.5005374489365;5077.695338279678;5083.593312534988;5158.1746920492915;5186.351706036746;5206.401263854629;5586.692731899744;5696.914546281809;5700.116481945305;5705.229793977843;5757.596968212227;6222.782202622931;6280.811575652738;6305.0857625644485;6305.873882522324;6313.463355614778;6151.200343955302;6214.502839772807;6241.750329986795;6367.808965731036;6369;5784.3926387729525;5837.9124313135335;5858.3555808860565;5865.941340586625;5891.05743081105;6285.497160227263;6334.208223972004;6345.587536810185;6347.365263473615;6347.96826015867;6033.215681961317;6099.146119543268;6124.693765311806;6219.471344935731;6273.215848018997;6298.496120310364;6310.2743184534365;6323.083152942798;6348.492120630339;6349.6507692077375;6186.4741496972365;6219.720112594944;6266.686665666698;6284.025975973731;6306.927822270225;6099.309783606499;6152.953997820381;6159.983602705593;6280.591761535486;6297.622142671455;4914;4948.257761335828;4951.752412379366;4967.254911763264;4980.676256043345;4485.439320084989;4492.124035812985;4492.348609451677;4495.303227999665;4516.412866327357;5595.692236927008;5848.4151584841175;5872.383399743051;5882.735276912549;5896.439838215363;6306.432421082125;6343.619382837044;6346.587471814318;6354.682265886687;6371.904421433682;5889.823305300848;5896.233489646404;5910.320313163955;5918.733656985446;5956.315023772235;5318.335208098988;5386.380566234855;5398.352197736297;5446.754896029688;5451.809186678526;6341.873162536724;6352;6358.950773122568;6371.362863713592;6374.776882809079;6305.842353941188;6306.590071645512;6341.080543321101;6342.334054924351;6377;6242.563020588515;6254.906176407449;6260.373962603703;6330.430261276507;6374.840628984312;5200.765965531636;5874.353821079592;6191.509696945547;6242.438180563771;6243.406876346739;6304.558680892477;6320.209973753281;6326.810195693953;6347.111404403479;6349.206349206349;6043.305019922589;6083.1483592298;6106.542009349228;6108.099244189703;6152.384761523812;6153.84615384619;6177.876442471215;6186.381361863778;6203.96898015507;6214.974529202631;4763.95236047649;5953.077273022688;5960.927033134078;6060.303065147565;6109.633421994695;5075.492450754895;6021.157038014594;6125.9693701531205;6174.043023331391;6199.3490683477585;6044.123602077762;6049.455549000611;6051.576389652682;6071.119687645355;6090.847728806815 03:24:47 INFO - PROCESS | 1657 | |1;ext.html;508.4584917063327;523.693639221056;543.4402565357681;560.9398237331446;577.711144427786;32656.346873062525;40924.18151636965;40944;41007.794961025225;41243.968900777494;34133.48799768005;42133.735987920336;42306.788466057624;42685.57314426855;42831.78584107083;9484.193843523291;9678;9687.564059617334;9694.466804325759;9695;9696.806063878717;9714.562844672007;9715.951420242924;9717.757056073584;9726.756831079208;9686.515674216296;9721.416714997087;9736.610535578568;9756.41461512308;9785.070418310284;9683.322167448281;9708.223342132613;9712.805743885083;9730.610775569005;9760.560774765152;9607.039296070407;9669.371490853073;9683.128518433376;9690.176335011533;9699.321047526675;39933.80033099816;40241.39034438619;40258.79223623296;40312.790616281265;40372.394414083814;3336.0825772912644;3457.27397246576;3463.619001909788;3566.821658917044;3827.8660246891227;32159.19602009945;32591.185220369443;32692;33043;33235;3230.3054843208824;3272.1655977725763;3307.818070006149;3355.2786150977413;3372.0558243691808;322835.3858230717;327882;328727;328731;330310;60464.395356046756;60705;60783.69608151931;60890.69554652199;60910.69544652337;34020.97937061843;34471;34927.30145397078;36210.81894590563;36342;16545.50363489097;16694;16728.581785455463;16746.99518028922;16784.496465106065;12612.432440540199;12619.747605047847;12756.170848894792;12782.169159004636;12807.615771526684;19166.80833191678;19259.215107759836;19425.4172374829;19535.706964395544;19542.0928481307;6718.428933540606;7073.434125270069;7888.408369372205;7917.524948503108;7993.72021979228;847.4618617178136;887.7913690282778;895.9462432254086;986.9538289413244;1056.5456853552892;29752.66113024919;30122.54816177759;30221.395572088873;30233;30894.69105308918;1021.3616489693941;1026.2098184397971;1036.5801850250662;1042.7705904700954;1107.9723006924892;14637.414503419745;15338.846611533741;15518;15554.533363999099;15750.76373854393;578421.1078944579;676997;681241;681606;688491;50379.49620503822;58461;58463.70768146132;58961.41038589645;59023.70488147618;1355.7424089422977;1373.2790285100402;1408.4155075643494;1408.4295860176644;1416.5183837495094;28401.857990709916;29184.7081529182;29210.269743256587;30047.3990520184;31119.53320700146;49896;51320;52176.739116304176;52320;52342;623746;629859;631175;631950.3609927684;632055;26659.46681066329;26772.866135669196;26870.865645671645;27226.72773272242;27256.182314530597;38848.805755971036;47338;47369;47466.76266618645;49358.75320623374;38407;39737.60262397339;40249.71430567518;40823.79588102041;41406.37890431706;34856.302873942885;39425.60574394219;39589.60410395974;39983.60016399799;41114.588854111076;38342;38932.61067389403;39570.80214598909;39682;40571.17429715611;31661.683383165873;34997;35084.473732893515;35191.64808351986;35647.64352356443;23926.08591312656;26110.738892610832;26111.608325874746;26408.339791505365;26662.066827661714 03:24:47 INFO - PROCESS | 1657 | |2;jquery.html;363.4439307858977;378.273714468221;385.2679908174469;388.9727719059667;397.47533256101957;16193.757093643604;19380.806191938093;20592.588148237028;22107.226247081377;22377.216797412093;19665.50836229095;19980.50048748782;20005.299814506496;20056.8997155014;20372.388828335137;5055.545000949923;5313.043652142613;5371.3822910365225;5372.946270537283;5438.456154384549;3924.1759230561615;4911.386076740408;5405.675659460425;6099.634021958675;6114.144019837204;5910.34986151523;6213.34759850216;6225.252969643627;6261.749530018794;6272.435480806726;6172.691365431733;6194.690265486753;6228.719707613168;6230.657313847737;6238.095476155955;6027.09593560965;6028.125921741323;6037.0642550404755;6038.939610603926;6052.727627256784;23549.88225058864;24539.263822085188;24789.752102478924;25828.8708556456;26097.217083487336;2195.6706494025866;2489.8132640051886;2597.8830952607177;2654.1639383594106;2971.0047134210067;10116.443595602239;10188.949055254676;10217.438040907748;10285.280030397875;10458.006489383573;1773.5034190426702;1841.7974022857475;1870.1584287070873;1872.7284543741218;1887.8395336396422;113848.43075784651;123412;123773;124710;125229.37385313107;11738.237014594195;11856.170068095324;11983.760324793455;12012.759744805055;12086.456109475095;12310.522737271405;13321.40053697586;13516.5269215577;14791.482298119729;14798.926005369904;7649.655765490566;7841.411894107965;8627.95686021566;8657.567121643893;8720.389572729848;7069.823254418578;8495.532745698922;8545.487270763773;8574;8711.782205444788;3844.615538446189;4465.441819772528;4593;4624.768761561909;4655.86032419028;1568.3021055630363;1748.8513476354653;1841.162271166616;1908.1127275816812;1982.306192832526;787.7439832054605;899.572702966099;906.1980147569317;953.2516974175378;979.9265055120894;16684.416045438353;20994.580108397746;21095.472613184793;21352.572948541252;22085.337439876508;926.6339795780628;934.8626268546967;940.0928104379307;1031.6183012285353;1057.143713591993;11061.336319820837;11287.60493382744;11440.656780296604;11621.24461909973;11708;583751;587559;593335;608560;609960;72877.6356118216;116335;128876.35561822318;135431.64568354387;135460;972.7957129002989;995.4073482428057;1005.2460654509118;1009.9242556808268;1011.3780025284544;18150.909245453688;19080.14139363704;19240.903795480932;19366.4190074298;19424.90287548553;37422.25155496821;45816.77091614521;51927.96144077173;55639.72180139073;55833.441665582824;77746.61126694556;77749;79461;79676;82229;8296.502209867427;8515.02077261123;8520.36097292718;8554;8555.272801811916;9419.85870211961;12343.814842777187;13215;13370.130941488773;13721.313934303445;9079.092090790868;9136.95431522838;9967.202623790225;11466.598669046543;11547.66962389104;9705.369151005161;10454.790904181722;10895.400752958347;11566.47950842231;11750;5812.157237200498;11685.591004314809;11887.881121188677;12020.519179233082;12050;5919.348871624032;8208.876866847122;8338.415701016787;8358.45670031446;8464.66141354339;8907.064758200295;8964.596593153454;11444.198906076495;11731.41342932867;11881.990030847475 03:24:47 INFO - PROCESS | 1657 | |3;mootools.html;1516.2191471392234;1537.2160198298868;1724.1723972493203;1804.539842340203;1825.497988053286;7811.687532498708;8268.875966860502;8356.039055508618;8797.604107815148;8874.955625221874;8497.277731392838;8697.1302869713;8699.260562852165;8702.695405660803;8761.123887611251;2331.4171457135717;2369.834111612188;2376.8336216464854;2381.4879800842814;2381.8213633977434;2344.76552344765;2367.443650742074;2384.8449850759644;2385.475195457005;2401.6637670726113;2036.3687256950318;2233.910643574255;2346.1319311854636;2358.988205058972;2378.1319818266293;2317.9188728394424;2332.2769941318074;2350.764923507644;2354.399628094842;2357.0218359380838;1783.563027058366;2257.559775843711;2360.492494113774;2371.833971621987;2396.161343529768;7365.484416090876;8711.21599056088;8744.912550874473;8775;8776.122387761172;4393.384926110347;5053.823116190915;5132.28148059272;5151.639385243035;5175.042617115808;3432.42108630028;3447.620761716209;3533.911652208715;3624.4563315502623;3636.090977255686;1042.9271103428378;1060.5969731502057;1078.1536493852288;1099.648112603967;1101.6915263726169;10344.706911636045;10612.151027917747;11250.324980501115;11417.314961102278;11447.885521144764;4472.932906006413;4595.885102872388;4615.746133962597;4689.577937985598;4727.95272047282;8978.191962723386;9232.676856309998;9717.514124293757;9805.705828825146;9829.262805289633;5236.319278493847;5254.264402983586;5270.1040823060175;5271.947280527223;5290.153575427913;4327.697061205686;4613.423322084739;4815.638827087912;4816;4827.734474603931;3915.980420097881;3926.1755031443145;4002.7398219115667;4085.2850751118435;4088.7751173685137;1281.5962971663896;1307.8169056332122;1315.967100822487;1316.2036967634442;1319.5183757928287;911.3848152497038;924.8011677489372;933.8785957825439;953.5041778275258;967.3760424526282;5708.771649134072;5941.643501389931;5976.820695379146;6122.173506576555;6240.719167637467;932.9953350233205;981.4994352880083;1034.2966782587912;1037.2479952034714;1120.434180738738;3772.7359084864347;4018.698109258364;4035.1727895781296;4051.8987025324604;4127.442795222607;10021;10457.26799124054;10458.424786636655;10467.685969420929;10473;10411.427371494488;10414.947925260325;10447.94776026115;10450;10498.527566259536;7926.960365198137;8050.838983220303;8059.194080591894;8060.959695201604;8110.797230069295;5652.689102099424;5701.914471283017;5873;5911.763529458945;5942.584019118794;9684;9795.06946840049;9822.263330250116;9833.65582204648;9864.260180486348;8181.222783835526;9746;10064.345817521838;10109.848352274868;10122.949385253027;6497.252815926229;6872.518923675495;6878.518503704893;6989.685464154024;7128.0754196367725;7409.147947986051;8157.021157461143;8193.303569196447;8275.875861861956;8296.87554686668;7263.745768898063;7408.888866666896;7423.109226892808;7446.292602202782;7545.132309784445;7157.677904494206;7225.385842203262;7245.38414234796;7289.416846652149;7304.671289792079;6804.149481314836;6855.5543889647015;6865.347791959955;6916.170059592881;6925.065116209247;4950.108980383566;4964.652474326763;4999.200127979506;5044.596432285335;5089.6691715038405;4886.92669609949;4933.55597996182;5051.87370315745;5143.92284115746;5164.8192313268855 03:24:47 INFO - PROCESS | 1657 | |4;prototype.html;265.8949714862628;296.179582556319;311.78093653813596;314.5863189905273;315.63859381008746;4141.316682747351;4528.366028755977;5394.865128371793;5504.532114770244;5547.472990065942;4649.3490911272365;5138.122651315266;5306.124489459235;5550.500454959053;5562.916556251649;3695.981520092396;4172.18642364739;4233.386159006942;4253;4276;3873.5861410585076;4158.251514727348;4267.487901451815;4279.0799978004725;4280.57194280571;3794.1083845296334;4124.690648201382;4126.9793651031705;4130;4144.70987030908;3436.6735160159997;3623.221007483404;3698.796566188845;3995.7402768820225;4002.319605667029;3383.7631365804405;3540.9114772130647;3541.94687079694;3560.3235385276716;3574.285142971416;5336.51971322579;5357.9819834231375;5363.517283444508;5367.624266301361;5437.287254514855;4274.5939135782055;4463.5982761551295;4756.881077973044;4768.213244814601;4775.307580400857;5095.515925987025;5531.170324451325;5661.886762264773;5836.533077353802;5913.319968203626;3721.7208709346905;3888.202918401721;3910.335243008667;3917.255721412951;3928.4107383892647;6113.816585502442;6138.925688004626;6143.539234557426;6171.9324026451195;6178.227721534809;3323.8171900545217;3654.4152935530187;3911.5527254915864;3974.5826688197903;4008.6971734186504;3250.561174241447;3319.245026627893;3847.6913851688764;4031.334829753058;4038.2327357801923;4354.804033818486;4713.175194340976;4748.240281554935;4759.286107083965;4763.880902977384;5672.546196304285;5775.075987841925;5829.854253643693;5848.707564621752;5921.703914804242;1296.9027322950628;1390.603677951779;1420.7016526529337;1422.665673566711;1432.176498513359;796.3436053009726;800.9639566219535;884.5400391796359;893.8659201119754;898.2589363774912;4251;4581.358609794632;4624.745638989888;4629.3518907353;4648.628109751212;4573.56551127649;4651.976740116345;4948.752562371867;4979.381700947207;5032.823851165192;3868.6905047596124;4038.788363490941;4608.354830323758;4614.700044497097;4651.813927442864;2031.6444622191352;2637.736226377347;2651.695055068692;2692.1155191366124;2696.341749823844;4992.775325110379;5008.5975926740575;5216.973915130476;5248.816291429782;5248.868778280497;4256.59562341577;4348.608625223745;4608.976955115203;4733.2900064989835;4880.951190488121;5211.592869925099;5525.585581081355;5701.515371193412;6364.377083843683;6392.9360706392345;5853.326867410302;6156.876862462816;6161.691915404302;6162.568620196544;6176.536759742948;4990.8253211137435;5449.820071971243;5693.658380497183;5965.850853728692;6084.817455476343;5381.67709937405;5569.610127291213;6312.621242725268;6320.514679050511;6344.874467053589;3989.58109398509;3993.8003099845473;4002.599740026091;4016.779077150785;4022.1955608877756;5695.572832037531;5845.970770146122;6003.909941350796;6008.339082700987;6088.817335479943;4549.5905368517;5307.097793375213;5713.7428815704225;5865.507159457128;5917.556183286357;4855.830045948375;5536.557075434036;5550.139728342114;5870.299662155286;5882.5293976480925;4430.911381772282;5005.774740136775;5763.4812866842185;5779.508741756829;5804.332501762351;4740.928886066643;5186.533212010937;5911.197219669994;5923.318818335946;5963.850903727268;4943.961768028755;5037.370328708911;5483.519449748465;5794.797182098607;5801.419858014165 03:24:47 INFO - PROCESS | 1657 | |5;yui.html;577.5495113811228;684.2644157530656;689.0456717446339;704.3977399323581;794.1978601612371;15267.389304427823;15948.122853243067;15949.840501594981;16102.114383708891;16158;12948.417321220544;14634.195119268436;14679.853201467982;14768.778468322957;14781;844.1937949258444;889.7464222696533;891.9786844063543;893.1247377569986;893.2853717026385;561.5872333834628;854.6068808348167;880.6345366672823;889.1375365895071;891.9598618062171;878.7846977490524;887.6804350433839;905.2034209895315;915.8076803871195;925.9490728009956;904.2675432899373;911.4075850697067;912.9908700913005;913.1462082952428;914.8902131744167;670.594290454273;682.0519477925687;683.9589624622539;684.4421796236052;690.3096903096903;15137.394504219817;15305.770413443808;15314.923425382913;15319.157446340447;15332.846671533365;14844.109353438827;14935.850641493555;14938.253087345698;14983;15165.317560709795;12017.158798883995;12250.938745306306;12480.750384992249;12531.874681253163;12624.621261362174;3827.349350610403;3833.0800607854194;4045.4538637283886;4067.572904845008;4073.06319546503;127655.36172319172;128489;130019;130562.694373056;131013;11329.716757080974;11474.94262528682;11491.540338386538;11538.76922461563;11971.281723096468;24047.759522404904;24079.036838526612;24334.26997190087;24367.756322436904;24413.38966525851;8170.223828736261;8173.305269052078;8197.34421246299;8249.175082491824;8335.54154521495;4350.8042138103865;4406.801693923781;4492.101579684077;4499.370088187657;4681.578657920803;3394.9830250848586;3528.1179705073732;3555.5022296878456;3561.893143205656;3566.98216508921;640.1581919775481;656.6454114777966;663.290279401046;664.2892105447125;666.0209492046683;579.547952596975;586.7271718650848;615.7567760734574;643.520577170002;646.4020780777855;9028.683996060106;9089.863652045224;9167.358284920125;9173.77065573366;9206.309526785519;544.8474427160402;571.5370549854631;584.8449312607651;602.5781952633174;608.9330173680892;3827.732058755916;4453.55464453552;4487.932681009787;4488.371627972087;4566.611837993742;126962;128694;177086.34370484453;177437;178088;109507;125678.3716081432;128047;130711;155436;64547;68093;72436.63781681057;92950;106902;9069.818603627758;9290.814183716422;9602.85595716051;9992.700218993441;10022.398656080659;51687.48312516827;60229.39770602238;60729.69635151796;65313.34686653073;65449;94582.52708736413;98510;99538.00461995287;100381;101367;13111.2133272004;13169.341532923125;13207.405666744828;13390.26353550564;13556.93221533886;14835.406583736529;14946.775798362816;15000.699986000001;15009.849901500846;15460;13822;13859.792103118663;13889.583312500641;13940.233287169303;14145.646358841112;13777.311134443038;13890;14062.297403775932;14216.644583885485;14813.925930370278;10815.837762433412;11545.769084618092;13096.541621043218;13452.798208027083;13486.393112310167;9582.329236953346;9972.975937615323;11134.832977505506;11252.549898004316;11483;9108.271338292789;10184.796304074025;10735.89264107349;10789.56841726322;11639.825402618799 03:24:47 INFO - PROCESS | 1657 | __end_tp_report 03:24:47 INFO - PROCESS | 1657 | __start_cc_report 03:24:47 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,412 03:24:47 INFO - PROCESS | 1657 | __end_cc_report 03:24:47 INFO - PROCESS | 1657 | __startTimestamp1470651887694__endTimestamp 03:24:47 INFO - PROCESS | 1657 | 03:24:47 INFO - PROCESS | 1657 | ------- Summary: start ------- 03:24:47 INFO - PROCESS | 1657 | Number of tests: 6 03:24:47 INFO - PROCESS | 1657 | 03:24:47 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5767.82 Median:6033.22 stddev:665.08 (11.0%) stddev-sans-first:627.01 03:24:47 INFO - PROCESS | 1657 | Values: 2868.0 3409.4 3428.9 3431.5 3459.2 5649.4 5676.0 5695.8 5723.1 5739.3 5708.3 5719.6 5722.2 5725.8 5767.7 5188.2 5234.0 5267.5 5299.9 5307.1 5133.4 5143.0 5200.7 5204.3 5241.3 5178.8 5179.7 5192.3 5214.9 5227.6 5188.5 5203.2 5231.9 5257.1 5257.5 5077.7 5083.6 5158.2 5186.4 5206.4 5586.7 5696.9 5700.1 5705.2 5757.6 6222.8 6280.8 6305.1 6305.9 6313.5 6151.2 6214.5 6241.8 6367.8 6369.0 5784.4 5837.9 5858.4 5865.9 5891.1 6285.5 6334.2 6345.6 6347.4 6348.0 6033.2 6099.1 6124.7 6219.5 6273.2 6298.5 6310.3 6323.1 6348.5 6349.7 6186.5 6219.7 6266.7 6284.0 6306.9 6099.3 6153.0 6160.0 6280.6 6297.6 4914.0 4948.3 4951.8 4967.3 4980.7 4485.4 4492.1 4492.3 4495.3 4516.4 5595.7 5848.4 5872.4 5882.7 5896.4 6306.4 6343.6 6346.6 6354.7 6371.9 5889.8 5896.2 5910.3 5918.7 5956.3 5318.3 5386.4 5398.4 5446.8 5451.8 6341.9 6352.0 6359.0 6371.4 6374.8 6305.8 6306.6 6341.1 6342.3 6377.0 6242.6 6254.9 6260.4 6330.4 6374.8 5200.8 5874.4 6191.5 6242.4 6243.4 6304.6 6320.2 6326.8 6347.1 6349.2 6043.3 6083.1 6106.5 6108.1 6152.4 6153.8 6177.9 6186.4 6204.0 6215.0 4764.0 5953.1 5960.9 6060.3 6109.6 5075.5 6021.2 6126.0 6174.0 6199.3 6044.1 6049.5 6051.6 6071.1 6090.8 03:24:47 INFO - PROCESS | 1657 | 03:24:47 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:67201.50 Median:39635.80 stddev:150431.48 (379.5%) stddev-sans-first:150770.14 03:24:47 INFO - PROCESS | 1657 | Values: 508.5 523.7 543.4 560.9 577.7 32656.3 40924.2 40944.0 41007.8 41244.0 34133.5 42133.7 42306.8 42685.6 42831.8 9484.2 9678.0 9687.6 9694.5 9695.0 9696.8 9714.6 9716.0 9717.8 9726.8 9686.5 9721.4 9736.6 9756.4 9785.1 9683.3 9708.2 9712.8 9730.6 9760.6 9607.0 9669.4 9683.1 9690.2 9699.3 39933.8 40241.4 40258.8 40312.8 40372.4 3336.1 3457.3 3463.6 3566.8 3827.9 32159.2 32591.2 32692.0 33043.0 33235.0 3230.3 3272.2 3307.8 3355.3 3372.1 322835.4 327882.0 328727.0 328731.0 330310.0 60464.4 60705.0 60783.7 60890.7 60910.7 34021.0 34471.0 34927.3 36210.8 36342.0 16545.5 16694.0 16728.6 16747.0 16784.5 12612.4 12619.7 12756.2 12782.2 12807.6 19166.8 19259.2 19425.4 19535.7 19542.1 6718.4 7073.4 7888.4 7917.5 7993.7 847.5 887.8 895.9 987.0 1056.5 29752.7 30122.5 30221.4 30233.0 30894.7 1021.4 1026.2 1036.6 1042.8 1108.0 14637.4 15338.8 15518.0 15554.5 15750.8 578421.1 676997.0 681241.0 681606.0 688491.0 50379.5 58461.0 58463.7 58961.4 59023.7 1355.7 1373.3 1408.4 1408.4 1416.5 28401.9 29184.7 29210.3 30047.4 31119.5 49896.0 51320.0 52176.7 52320.0 52342.0 623746.0 629859.0 631175.0 631950.4 632055.0 26659.5 26772.9 26870.9 27226.7 27256.2 38848.8 47338.0 47369.0 47466.8 49358.8 38407.0 39737.6 40249.7 40823.8 41406.4 34856.3 39425.6 39589.6 39983.6 41114.6 38342.0 38932.6 39570.8 39682.0 40571.2 31661.7 34997.0 35084.5 35191.6 35647.6 23926.1 26110.7 26111.6 26408.3 26662.1 03:24:47 INFO - PROCESS | 1657 | 03:24:47 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34666.30 Median:1667.22 stddev:99561.73 (5971.7%) stddev-sans-first:99807.71 03:24:47 INFO - PROCESS | 1657 | Values: 363.4 378.3 385.3 389.0 397.5 16193.8 19380.8 20592.6 22107.2 22377.2 19665.5 19980.5 20005.3 20056.9 20372.4 5055.5 5313.0 5371.4 5372.9 5438.5 3924.2 4911.4 5405.7 6099.6 6114.1 5910.3 6213.3 6225.3 6261.7 6272.4 6172.7 6194.7 6228.7 6230.7 6238.1 6027.1 6028.1 6037.1 6038.9 6052.7 23549.9 24539.3 24789.8 25828.9 26097.2 2195.7 2489.8 2597.9 2654.2 2971.0 10116.4 10188.9 10217.4 10285.3 10458.0 1773.5 1841.8 1870.2 1872.7 1887.8 113848.4 123412.0 123773.0 124710.0 125229.4 11738.2 11856.2 11983.8 12012.8 12086.5 12310.5 13321.4 13516.5 14791.5 14798.9 7649.7 7841.4 8628.0 8657.6 8720.4 7069.8 8495.5 8545.5 8574.0 8711.8 3844.6 4465.4 4593.0 4624.8 4655.9 1568.3 1748.9 1841.2 1908.1 1982.3 787.7 899.6 906.2 953.3 979.9 16684.4 20994.6 21095.5 21352.6 22085.3 926.6 934.9 940.1 1031.6 1057.1 11061.3 11287.6 11440.7 11621.2 11708.0 583751.0 587559.0 593335.0 608560.0 609960.0 72877.6 116335.0 128876.4 135431.6 135460.0 972.8 995.4 1005.2 1009.9 1011.4 18150.9 19080.1 19240.9 19366.4 19424.9 37422.3 45816.8 51928.0 55639.7 55833.4 77746.6 77749.0 79461.0 79676.0 82229.0 8296.5 8515.0 8520.4 8554.0 8555.3 9419.9 12343.8 13215.0 13370.1 13721.3 9079.1 9137.0 9967.2 11466.6 11547.7 9705.4 10454.8 10895.4 11566.5 11750.0 5812.2 11685.6 11887.9 12020.5 12050.0 5919.3 8208.9 8338.4 8358.5 8464.7 8907.1 8964.6 11444.2 11731.4 11882.0 03:24:47 INFO - PROCESS | 1657 | 03:24:47 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5595.58 Median:4981.93 stddev:3068.36 (61.6%) stddev-sans-first:3061.65 03:24:47 INFO - PROCESS | 1657 | Values: 1516.2 1537.2 1724.2 1804.5 1825.5 7811.7 8268.9 8356.0 8797.6 8875.0 8497.3 8697.1 8699.3 8702.7 8761.1 2331.4 2369.8 2376.8 2381.5 2381.8 2344.8 2367.4 2384.8 2385.5 2401.7 2036.4 2233.9 2346.1 2359.0 2378.1 2317.9 2332.3 2350.8 2354.4 2357.0 1783.6 2257.6 2360.5 2371.8 2396.2 7365.5 8711.2 8744.9 8775.0 8776.1 4393.4 5053.8 5132.3 5151.6 5175.0 3432.4 3447.6 3533.9 3624.5 3636.1 1042.9 1060.6 1078.2 1099.6 1101.7 10344.7 10612.2 11250.3 11417.3 11447.9 4472.9 4595.9 4615.7 4689.6 4728.0 8978.2 9232.7 9717.5 9805.7 9829.3 5236.3 5254.3 5270.1 5271.9 5290.2 4327.7 4613.4 4815.6 4816.0 4827.7 3916.0 3926.2 4002.7 4085.3 4088.8 1281.6 1307.8 1316.0 1316.2 1319.5 911.4 924.8 933.9 953.5 967.4 5708.8 5941.6 5976.8 6122.2 6240.7 933.0 981.5 1034.3 1037.2 1120.4 3772.7 4018.7 4035.2 4051.9 4127.4 10021.0 10457.3 10458.4 10467.7 10473.0 10411.4 10414.9 10447.9 10450.0 10498.5 7927.0 8050.8 8059.2 8061.0 8110.8 5652.7 5701.9 5873.0 5911.8 5942.6 9684.0 9795.1 9822.3 9833.7 9864.3 8181.2 9746.0 10064.3 10109.8 10122.9 6497.3 6872.5 6878.5 6989.7 7128.1 7409.1 8157.0 8193.3 8275.9 8296.9 7263.7 7408.9 7423.1 7446.3 7545.1 7157.7 7225.4 7245.4 7289.4 7304.7 6804.1 6855.6 6865.3 6916.2 6925.1 4950.1 4964.7 4999.2 5044.6 5089.7 4886.9 4933.6 5051.9 5143.9 5164.8 03:24:47 INFO - PROCESS | 1657 | 03:24:47 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4522.77 Median:4771.76 stddev:1432.77 (30.0%) stddev-sans-first:1400.72 03:24:47 INFO - PROCESS | 1657 | Values: 265.9 296.2 311.8 314.6 315.6 4141.3 4528.4 5394.9 5504.5 5547.5 4649.3 5138.1 5306.1 5550.5 5562.9 3696.0 4172.2 4233.4 4253.0 4276.0 3873.6 4158.3 4267.5 4279.1 4280.6 3794.1 4124.7 4127.0 4130.0 4144.7 3436.7 3623.2 3698.8 3995.7 4002.3 3383.8 3540.9 3541.9 3560.3 3574.3 5336.5 5358.0 5363.5 5367.6 5437.3 4274.6 4463.6 4756.9 4768.2 4775.3 5095.5 5531.2 5661.9 5836.5 5913.3 3721.7 3888.2 3910.3 3917.3 3928.4 6113.8 6138.9 6143.5 6171.9 6178.2 3323.8 3654.4 3911.6 3974.6 4008.7 3250.6 3319.2 3847.7 4031.3 4038.2 4354.8 4713.2 4748.2 4759.3 4763.9 5672.5 5775.1 5829.9 5848.7 5921.7 1296.9 1390.6 1420.7 1422.7 1432.2 796.3 801.0 884.5 893.9 898.3 4251.0 4581.4 4624.7 4629.4 4648.6 4573.6 4652.0 4948.8 4979.4 5032.8 3868.7 4038.8 4608.4 4614.7 4651.8 2031.6 2637.7 2651.7 2692.1 2696.3 4992.8 5008.6 5217.0 5248.8 5248.9 4256.6 4348.6 4609.0 4733.3 4881.0 5211.6 5525.6 5701.5 6364.4 6392.9 5853.3 6156.9 6161.7 6162.6 6176.5 4990.8 5449.8 5693.7 5965.9 6084.8 5381.7 5569.6 6312.6 6320.5 6344.9 3989.6 3993.8 4002.6 4016.8 4022.2 5695.6 5846.0 6003.9 6008.3 6088.8 4549.6 5307.1 5713.7 5865.5 5917.6 4855.8 5536.6 5550.1 5870.3 5882.5 4430.9 5005.8 5763.5 5779.5 5804.3 4740.9 5186.5 5911.2 5923.3 5963.9 4944.0 5037.4 5483.5 5794.8 5801.4 03:24:47 INFO - PROCESS | 1657 | 03:24:47 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:25178.51 Median:3697.17 stddev:40971.59 (1108.2%) stddev-sans-first:41044.89 03:24:47 INFO - PROCESS | 1657 | Values: 577.5 684.3 689.0 704.4 794.2 15267.4 15948.1 15949.8 16102.1 16158.0 12948.4 14634.2 14679.9 14768.8 14781.0 844.2 889.7 892.0 893.1 893.3 561.6 854.6 880.6 889.1 892.0 878.8 887.7 905.2 915.8 925.9 904.3 911.4 913.0 913.1 914.9 670.6 682.1 684.0 684.4 690.3 15137.4 15305.8 15314.9 15319.2 15332.8 14844.1 14935.9 14938.3 14983.0 15165.3 12017.2 12250.9 12480.8 12531.9 12624.6 3827.3 3833.1 4045.5 4067.6 4073.1 127655.4 128489.0 130019.0 130562.7 131013.0 11329.7 11474.9 11491.5 11538.8 11971.3 24047.8 24079.0 24334.3 24367.8 24413.4 8170.2 8173.3 8197.3 8249.2 8335.5 4350.8 4406.8 4492.1 4499.4 4681.6 3395.0 3528.1 3555.5 3561.9 3567.0 640.2 656.6 663.3 664.3 666.0 579.5 586.7 615.8 643.5 646.4 9028.7 9089.9 9167.4 9173.8 9206.3 544.8 571.5 584.8 602.6 608.9 3827.7 4453.6 4487.9 4488.4 4566.6 126962.0 128694.0 177086.3 177437.0 178088.0 109507.0 125678.4 128047.0 130711.0 155436.0 64547.0 68093.0 72436.6 92950.0 106902.0 9069.8 9290.8 9602.9 9992.7 10022.4 51687.5 60229.4 60729.7 65313.3 65449.0 94582.5 98510.0 99538.0 100381.0 101367.0 13111.2 13169.3 13207.4 13390.3 13556.9 14835.4 14946.8 15000.7 15009.8 15460.0 13822.0 13859.8 13889.6 13940.2 14145.6 13777.3 13890.0 14062.3 14216.6 14813.9 10815.8 11545.8 13096.5 13452.8 13486.4 9582.3 9973.0 11134.8 11252.5 11483.0 9108.3 10184.8 10735.9 10789.6 11639.8 03:24:47 INFO - PROCESS | 1657 | -------- Summary: end -------- 03:24:47 INFO - PROCESS | 1657 | 03:24:48 INFO - TEST-INFO | 1657: exit 0 03:24:48 INFO - TEST-OK | dromaeo_css | took 1113797ms 03:24:48 INFO - TEST-START | kraken 03:24:48 INFO - operating with platform_type : mac_ 03:24:48 INFO - Initialising browser for kraken test... 03:24:48 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmpe5w1bn/profile http://localhost:49274/getInfo.html) 03:24:51 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 03:24:51 INFO - PROCESS | 1664 | colorDepth:24 03:24:51 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 03:24:51 INFO - PROCESS | 1664 | __metrics 03:24:51 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:24:52 INFO - TEST-INFO | 1664: exit 0 03:24:52 INFO - Browser initialized. 03:24:52 INFO - Running cycle 1/1 for kraken test... 03:24:52 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmpe5w1bn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:04 INFO - PROCESS | 1666 | RSS: Main: 254533632 03:25:04 INFO - PROCESS | 1666 | 03:25:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 03:25:08 INFO - PROCESS | 1666 | RSS: Main: 267444224 03:25:08 INFO - PROCESS | 1666 | 03:25:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 03:25:11 INFO - PROCESS | 1666 | RSS: Main: 276017152 03:25:11 INFO - PROCESS | 1666 | 03:25:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 03:25:15 INFO - PROCESS | 1666 | RSS: Main: 279121920 03:25:15 INFO - PROCESS | 1666 | 03:25:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 03:25:18 INFO - PROCESS | 1666 | RSS: Main: 281407488 03:25:18 INFO - PROCESS | 1666 | 03:25:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:25:20 INFO - PROCESS | 1666 | RSS: Main: 281743360 03:25:20 INFO - PROCESS | 1666 | 03:25:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 03:25:24 INFO - PROCESS | 1666 | RSS: Main: 281780224 03:25:24 INFO - PROCESS | 1666 | 03:25:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 03:25:28 INFO - PROCESS | 1666 | RSS: Main: 282431488 03:25:28 INFO - PROCESS | 1666 | 03:25:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 03:25:32 INFO - PROCESS | 1666 | RSS: Main: 282431488 03:25:32 INFO - PROCESS | 1666 | 03:25:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:25:34 INFO - PROCESS | 1666 | RSS: Main: 282173440 03:25:34 INFO - PROCESS | 1666 | 03:25:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:25:36 INFO - PROCESS | 1666 | RSS: Main: 282279936 03:25:36 INFO - PROCESS | 1666 | 03:25:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:25:39 INFO - PROCESS | 1666 | RSS: Main: 283222016 03:25:39 INFO - PROCESS | 1666 | 03:25:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:25:43 INFO - PROCESS | 1666 | RSS: Main: 282742784 03:25:43 INFO - PROCESS | 1666 | 03:25:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:25:46 INFO - PROCESS | 1666 | RSS: Main: 282742784 03:25:46 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 03:25:48 INFO - PROCESS | 1666 | RSS: Main: 283873280 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | __start_tp_report 03:25:48 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 03:25:48 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 03:25:48 INFO - PROCESS | 1666 | |i|pagename|runs| 03:25:48 INFO - PROCESS | 1666 | |0;ai-astar;102;118;108;121;118;117;117;117;117;117 03:25:48 INFO - PROCESS | 1666 | |1;audio-beat-detection;142;108;136;158;108;157;191;117;206;139 03:25:48 INFO - PROCESS | 1666 | |2;audio-dft;206;226;187;186;268;209;284;285;195;197 03:25:48 INFO - PROCESS | 1666 | |3;audio-fft;69;85;78;140;60;59;59;64;131;58 03:25:48 INFO - PROCESS | 1666 | |4;audio-oscillator;69;70;117;98;104;110;151;95;73;117 03:25:48 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;89;80;136;121;87;84;89;93;137;117 03:25:48 INFO - PROCESS | 1666 | |6;imaging-darkroom;152;108;144;105;149;152;109;96;94;112 03:25:48 INFO - PROCESS | 1666 | |7;imaging-desaturate;90;92;89;92;93;93;109;153;85;152 03:25:48 INFO - PROCESS | 1666 | |8;json-parse-financial;54;56;58;58;56;57;57;57;55;55 03:25:48 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;72;69;71;70;79;80;72;75;73 03:25:48 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;85;86;83;85;85;85;83;88;86;87 03:25:48 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;139;137;137;139;155;146;156;142;161;149 03:25:48 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;141;234;227;218;163;166;167;168;167;221 03:25:48 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;70;73;67;69;66;69;69;67;72;68 03:25:48 INFO - PROCESS | 1666 | __end_tp_report 03:25:48 INFO - PROCESS | 1666 | __start_cc_report 03:25:48 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1053 03:25:48 INFO - PROCESS | 1666 | __end_cc_report 03:25:48 INFO - PROCESS | 1666 | __startTimestamp1470651948902__endTimestamp 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | ------- Summary: start ------- 03:25:48 INFO - PROCESS | 1666 | Number of tests: 14 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:115.20 Median:117.00 stddev:5.69 (4.9%) stddev-sans-first:3.50 03:25:48 INFO - PROCESS | 1666 | Values: 102.0 118.0 108.0 121.0 118.0 117.0 117.0 117.0 117.0 117.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:149.50 stddev:32.97 (22.1%) stddev-sans-first:34.94 03:25:48 INFO - PROCESS | 1666 | Values: 142.0 108.0 136.0 158.0 108.0 157.0 191.0 117.0 206.0 139.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:224.30 Median:217.50 stddev:39.71 (18.3%) stddev-sans-first:41.56 03:25:48 INFO - PROCESS | 1666 | Values: 206.0 226.0 187.0 186.0 268.0 209.0 284.0 285.0 195.0 197.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:80.30 Median:62.00 stddev:30.50 (49.2%) stddev-sans-first:32.07 03:25:48 INFO - PROCESS | 1666 | Values: 69.0 85.0 78.0 140.0 60.0 59.0 59.0 64.0 131.0 58.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:100.40 Median:69.50 stddev:25.63 (36.9%) stddev-sans-first:24.54 03:25:48 INFO - PROCESS | 1666 | Values: 69.0 70.0 117.0 98.0 104.0 110.0 151.0 95.0 73.0 117.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:103.30 Median:85.50 stddev:22.12 (25.9%) stddev-sans-first:22.84 03:25:48 INFO - PROCESS | 1666 | Values: 89.0 80.0 136.0 121.0 87.0 84.0 89.0 93.0 137.0 117.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:122.10 Median:150.50 stddev:24.10 (16.0%) stddev-sans-first:23.00 03:25:48 INFO - PROCESS | 1666 | Values: 152.0 108.0 144.0 105.0 149.0 152.0 109.0 96.0 94.0 112.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:104.80 Median:91.00 stddev:25.90 (28.5%) stddev-sans-first:26.91 03:25:48 INFO - PROCESS | 1666 | Values: 90.0 92.0 89.0 92.0 93.0 93.0 109.0 153.0 85.0 152.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:1.34 (2.3%) stddev-sans-first:1.13 03:25:48 INFO - PROCESS | 1666 | Values: 54.0 56.0 58.0 58.0 56.0 57.0 57.0 57.0 55.0 55.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:72.50 stddev:4.16 (5.7%) stddev-sans-first:3.84 03:25:48 INFO - PROCESS | 1666 | Values: 67.0 72.0 69.0 71.0 70.0 79.0 80.0 72.0 75.0 73.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:1.57 (1.8%) stddev-sans-first:1.66 03:25:48 INFO - PROCESS | 1666 | Values: 85.0 86.0 83.0 85.0 85.0 85.0 83.0 88.0 86.0 87.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:147.50 stddev:8.76 (5.9%) stddev-sans-first:8.91 03:25:48 INFO - PROCESS | 1666 | Values: 139.0 137.0 137.0 139.0 155.0 146.0 156.0 142.0 161.0 149.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.20 Median:193.00 stddev:33.70 (17.5%) stddev-sans-first:31.32 03:25:48 INFO - PROCESS | 1666 | Values: 141.0 234.0 227.0 218.0 163.0 166.0 167.0 168.0 167.0 221.0 03:25:48 INFO - PROCESS | 1666 | 03:25:48 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.21 (3.2%) stddev-sans-first:2.32 03:25:48 INFO - PROCESS | 1666 | Values: 70.0 73.0 67.0 69.0 66.0 69.0 69.0 67.0 72.0 68.0 03:25:48 INFO - PROCESS | 1666 | -------- Summary: end -------- 03:25:48 INFO - PROCESS | 1666 | 03:25:49 INFO - TEST-INFO | 1666: exit 0 03:25:49 INFO - TEST-OK | kraken | took 61488ms 03:25:49 INFO - SUITE-END | took 1175s 03:25:50 INFO - Completed test suite (00:19:35) 03:25:50 INFO - javascript benchmark 03:25:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7333.087480524015, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2867.9569806452905, 3409.4374428219344, 3428.914277143071, 3431.4509678451454, 3459.1697992481795, 5649.4068122847075, 5676.0, 5695.77216911323, 5723.11291749779, 5739.282589676291, 5708.343540492845, 5719.59962802604, 5722.2274992876055, 5725.770969161229, 5767.740451679674, 5188.195829646411, 5233.973830130844, 5267.52592266696, 5299.920501192485, 5307.124324486455, 5133.358330208724, 5142.971405718871, 5200.7399630018535, 5204.34945631796, 5241.3186285782795, 5178.818741344035, 5179.663321884065, 5192.299039629658, 5214.947850521522, 5227.60792940531, 5188.507091826271, 5203.219517072432, 5231.869203269911, 5257.106291930381, 5257.5005374489365, 5077.695338279678, 5083.593312534988, 5158.1746920492915, 5186.351706036746, 5206.401263854629, 5586.692731899744, 5696.914546281809, 5700.116481945305, 5705.229793977843, 5757.596968212227, 6222.782202622931, 6280.811575652738, 6305.0857625644485, 6305.873882522324, 6313.463355614778, 6151.200343955302, 6214.502839772807, 6241.750329986795, 6367.808965731036, 6369.0, 5784.3926387729525, 5837.9124313135335, 5858.3555808860565, 5865.941340586625, 5891.05743081105, 6285.497160227263, 6334.208223972004, 6345.587536810185, 6347.365263473615, 6347.96826015867, 6033.215681961317, 6099.146119543268, 6124.693765311806, 6219.471344935731, 6273.215848018997, 6298.496120310364, 6310.2743184534365, 6323.083152942798, 6348.492120630339, 6349.6507692077375, 6186.4741496972365, 6219.720112594944, 6266.686665666698, 6284.025975973731, 6306.927822270225, 6099.309783606499, 6152.953997820381, 6159.983602705593, 6280.591761535486, 6297.622142671455, 4914.0, 4948.257761335828, 4951.752412379366, 4967.254911763264, 4980.676256043345, 4485.439320084989, 4492.124035812985, 4492.348609451677, 4495.303227999665, 4516.412866327357, 5595.692236927008, 5848.4151584841175, 5872.383399743051, 5882.735276912549, 5896.439838215363, 6306.432421082125, 6343.619382837044, 6346.587471814318, 6354.682265886687, 6371.904421433682, 5889.823305300848, 5896.233489646404, 5910.320313163955, 5918.733656985446, 5956.315023772235, 5318.335208098988, 5386.380566234855, 5398.352197736297, 5446.754896029688, 5451.809186678526, 6341.873162536724, 6352.0, 6358.950773122568, 6371.362863713592, 6374.776882809079, 6305.842353941188, 6306.590071645512, 6341.080543321101, 6342.334054924351, 6377.0, 6242.563020588515, 6254.906176407449, 6260.373962603703, 6330.430261276507, 6374.840628984312, 5200.765965531636, 5874.353821079592, 6191.509696945547, 6242.438180563771, 6243.406876346739, 6304.558680892477, 6320.209973753281, 6326.810195693953, 6347.111404403479, 6349.206349206349, 6043.305019922589, 6083.1483592298, 6106.542009349228, 6108.099244189703, 6152.384761523812, 6153.84615384619, 6177.876442471215, 6186.381361863778, 6203.96898015507, 6214.974529202631, 4763.95236047649, 5953.077273022688, 5960.927033134078, 6060.303065147565, 6109.633421994695, 5075.492450754895, 6021.157038014594, 6125.9693701531205, 6174.043023331391, 6199.3490683477585, 6044.123602077762, 6049.455549000611, 6051.576389652682, 6071.119687645355, 6090.847728806815], "value": 5724.416328690499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.4584917063327, 523.693639221056, 543.4402565357681, 560.9398237331446, 577.711144427786, 32656.346873062525, 40924.18151636965, 40944.0, 41007.794961025225, 41243.968900777494, 34133.48799768005, 42133.735987920336, 42306.788466057624, 42685.57314426855, 42831.78584107083, 9484.193843523291, 9678.0, 9687.564059617334, 9694.466804325759, 9695.0, 9696.806063878717, 9714.562844672007, 9715.951420242924, 9717.757056073584, 9726.756831079208, 9686.515674216296, 9721.416714997087, 9736.610535578568, 9756.41461512308, 9785.070418310284, 9683.322167448281, 9708.223342132613, 9712.805743885083, 9730.610775569005, 9760.560774765152, 9607.039296070407, 9669.371490853073, 9683.128518433376, 9690.176335011533, 9699.321047526675, 39933.80033099816, 40241.39034438619, 40258.79223623296, 40312.790616281265, 40372.394414083814, 3336.0825772912644, 3457.27397246576, 3463.619001909788, 3566.821658917044, 3827.8660246891227, 32159.19602009945, 32591.185220369443, 32692.0, 33043.0, 33235.0, 3230.3054843208824, 3272.1655977725763, 3307.818070006149, 3355.2786150977413, 3372.0558243691808, 322835.3858230717, 327882.0, 328727.0, 328731.0, 330310.0, 60464.395356046756, 60705.0, 60783.69608151931, 60890.69554652199, 60910.69544652337, 34020.97937061843, 34471.0, 34927.30145397078, 36210.81894590563, 36342.0, 16545.50363489097, 16694.0, 16728.581785455463, 16746.99518028922, 16784.496465106065, 12612.432440540199, 12619.747605047847, 12756.170848894792, 12782.169159004636, 12807.615771526684, 19166.80833191678, 19259.215107759836, 19425.4172374829, 19535.706964395544, 19542.0928481307, 6718.428933540606, 7073.434125270069, 7888.408369372205, 7917.524948503108, 7993.72021979228, 847.4618617178136, 887.7913690282778, 895.9462432254086, 986.9538289413244, 1056.5456853552892, 29752.66113024919, 30122.54816177759, 30221.395572088873, 30233.0, 30894.69105308918, 1021.3616489693941, 1026.2098184397971, 1036.5801850250662, 1042.7705904700954, 1107.9723006924892, 14637.414503419745, 15338.846611533741, 15518.0, 15554.533363999099, 15750.76373854393, 578421.1078944579, 676997.0, 681241.0, 681606.0, 688491.0, 50379.49620503822, 58461.0, 58463.70768146132, 58961.41038589645, 59023.70488147618, 1355.7424089422977, 1373.2790285100402, 1408.4155075643494, 1408.4295860176644, 1416.5183837495094, 28401.857990709916, 29184.7081529182, 29210.269743256587, 30047.3990520184, 31119.53320700146, 49896.0, 51320.0, 52176.739116304176, 52320.0, 52342.0, 623746.0, 629859.0, 631175.0, 631950.3609927684, 632055.0, 26659.46681066329, 26772.866135669196, 26870.865645671645, 27226.72773272242, 27256.182314530597, 38848.805755971036, 47338.0, 47369.0, 47466.76266618645, 49358.75320623374, 38407.0, 39737.60262397339, 40249.71430567518, 40823.79588102041, 41406.37890431706, 34856.302873942885, 39425.60574394219, 39589.60410395974, 39983.60016399799, 41114.588854111076, 38342.0, 38932.61067389403, 39570.80214598909, 39682.0, 40571.17429715611, 31661.683383165873, 34997.0, 35084.473732893515, 35191.64808351986, 35647.64352356443, 23926.08591312656, 26110.738892610832, 26111.608325874746, 26408.339791505365, 26662.066827661714], "value": 19692.777483364374, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.4439307858977, 378.273714468221, 385.2679908174469, 388.9727719059667, 397.47533256101957, 16193.757093643604, 19380.806191938093, 20592.588148237028, 22107.226247081377, 22377.216797412093, 19665.50836229095, 19980.50048748782, 20005.299814506496, 20056.8997155014, 20372.388828335137, 5055.545000949923, 5313.043652142613, 5371.3822910365225, 5372.946270537283, 5438.456154384549, 3924.1759230561615, 4911.386076740408, 5405.675659460425, 6099.634021958675, 6114.144019837204, 5910.34986151523, 6213.34759850216, 6225.252969643627, 6261.749530018794, 6272.435480806726, 6172.691365431733, 6194.690265486753, 6228.719707613168, 6230.657313847737, 6238.095476155955, 6027.09593560965, 6028.125921741323, 6037.0642550404755, 6038.939610603926, 6052.727627256784, 23549.88225058864, 24539.263822085188, 24789.752102478924, 25828.8708556456, 26097.217083487336, 2195.6706494025866, 2489.8132640051886, 2597.8830952607177, 2654.1639383594106, 2971.0047134210067, 10116.443595602239, 10188.949055254676, 10217.438040907748, 10285.280030397875, 10458.006489383573, 1773.5034190426702, 1841.7974022857475, 1870.1584287070873, 1872.7284543741218, 1887.8395336396422, 113848.43075784651, 123412.0, 123773.0, 124710.0, 125229.37385313107, 11738.237014594195, 11856.170068095324, 11983.760324793455, 12012.759744805055, 12086.456109475095, 12310.522737271405, 13321.40053697586, 13516.5269215577, 14791.482298119729, 14798.926005369904, 7649.655765490566, 7841.411894107965, 8627.95686021566, 8657.567121643893, 8720.389572729848, 7069.823254418578, 8495.532745698922, 8545.487270763773, 8574.0, 8711.782205444788, 3844.615538446189, 4465.441819772528, 4593.0, 4624.768761561909, 4655.86032419028, 1568.3021055630363, 1748.8513476354653, 1841.162271166616, 1908.1127275816812, 1982.306192832526, 787.7439832054605, 899.572702966099, 906.1980147569317, 953.2516974175378, 979.9265055120894, 16684.416045438353, 20994.580108397746, 21095.472613184793, 21352.572948541252, 22085.337439876508, 926.6339795780628, 934.8626268546967, 940.0928104379307, 1031.6183012285353, 1057.143713591993, 11061.336319820837, 11287.60493382744, 11440.656780296604, 11621.24461909973, 11708.0, 583751.0, 587559.0, 593335.0, 608560.0, 609960.0, 72877.6356118216, 116335.0, 128876.35561822318, 135431.64568354387, 135460.0, 972.7957129002989, 995.4073482428057, 1005.2460654509118, 1009.9242556808268, 1011.3780025284544, 18150.909245453688, 19080.14139363704, 19240.903795480932, 19366.4190074298, 19424.90287548553, 37422.25155496821, 45816.77091614521, 51927.96144077173, 55639.72180139073, 55833.441665582824, 77746.61126694556, 77749.0, 79461.0, 79676.0, 82229.0, 8296.502209867427, 8515.02077261123, 8520.36097292718, 8554.0, 8555.272801811916, 9419.85870211961, 12343.814842777187, 13215.0, 13370.130941488773, 13721.313934303445, 9079.092090790868, 9136.95431522838, 9967.202623790225, 11466.598669046543, 11547.66962389104, 9705.369151005161, 10454.790904181722, 10895.400752958347, 11566.47950842231, 11750.0, 5812.157237200498, 11685.591004314809, 11887.881121188677, 12020.519179233082, 12050.0, 5919.348871624032, 8208.876866847122, 8338.415701016787, 8358.45670031446, 8464.66141354339, 8907.064758200295, 8964.596593153454, 11444.198906076495, 11731.41342932867, 11881.990030847475], "value": 9494.014205347103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.2191471392234, 1537.2160198298868, 1724.1723972493203, 1804.539842340203, 1825.497988053286, 7811.687532498708, 8268.875966860502, 8356.039055508618, 8797.604107815148, 8874.955625221874, 8497.277731392838, 8697.1302869713, 8699.260562852165, 8702.695405660803, 8761.123887611251, 2331.4171457135717, 2369.834111612188, 2376.8336216464854, 2381.4879800842814, 2381.8213633977434, 2344.76552344765, 2367.443650742074, 2384.8449850759644, 2385.475195457005, 2401.6637670726113, 2036.3687256950318, 2233.910643574255, 2346.1319311854636, 2358.988205058972, 2378.1319818266293, 2317.9188728394424, 2332.2769941318074, 2350.764923507644, 2354.399628094842, 2357.0218359380838, 1783.563027058366, 2257.559775843711, 2360.492494113774, 2371.833971621987, 2396.161343529768, 7365.484416090876, 8711.21599056088, 8744.912550874473, 8775.0, 8776.122387761172, 4393.384926110347, 5053.823116190915, 5132.28148059272, 5151.639385243035, 5175.042617115808, 3432.42108630028, 3447.620761716209, 3533.911652208715, 3624.4563315502623, 3636.090977255686, 1042.9271103428378, 1060.5969731502057, 1078.1536493852288, 1099.648112603967, 1101.6915263726169, 10344.706911636045, 10612.151027917747, 11250.324980501115, 11417.314961102278, 11447.885521144764, 4472.932906006413, 4595.885102872388, 4615.746133962597, 4689.577937985598, 4727.95272047282, 8978.191962723386, 9232.676856309998, 9717.514124293757, 9805.705828825146, 9829.262805289633, 5236.319278493847, 5254.264402983586, 5270.1040823060175, 5271.947280527223, 5290.153575427913, 4327.697061205686, 4613.423322084739, 4815.638827087912, 4816.0, 4827.734474603931, 3915.980420097881, 3926.1755031443145, 4002.7398219115667, 4085.2850751118435, 4088.7751173685137, 1281.5962971663896, 1307.8169056332122, 1315.967100822487, 1316.2036967634442, 1319.5183757928287, 911.3848152497038, 924.8011677489372, 933.8785957825439, 953.5041778275258, 967.3760424526282, 5708.771649134072, 5941.643501389931, 5976.820695379146, 6122.173506576555, 6240.719167637467, 932.9953350233205, 981.4994352880083, 1034.2966782587912, 1037.2479952034714, 1120.434180738738, 3772.7359084864347, 4018.698109258364, 4035.1727895781296, 4051.8987025324604, 4127.442795222607, 10021.0, 10457.26799124054, 10458.424786636655, 10467.685969420929, 10473.0, 10411.427371494488, 10414.947925260325, 10447.94776026115, 10450.0, 10498.527566259536, 7926.960365198137, 8050.838983220303, 8059.194080591894, 8060.959695201604, 8110.797230069295, 5652.689102099424, 5701.914471283017, 5873.0, 5911.763529458945, 5942.584019118794, 9684.0, 9795.06946840049, 9822.263330250116, 9833.65582204648, 9864.260180486348, 8181.222783835526, 9746.0, 10064.345817521838, 10109.848352274868, 10122.949385253027, 6497.252815926229, 6872.518923675495, 6878.518503704893, 6989.685464154024, 7128.0754196367725, 7409.147947986051, 8157.021157461143, 8193.303569196447, 8275.875861861956, 8296.87554686668, 7263.745768898063, 7408.888866666896, 7423.109226892808, 7446.292602202782, 7545.132309784445, 7157.677904494206, 7225.385842203262, 7245.38414234796, 7289.416846652149, 7304.671289792079, 6804.149481314836, 6855.5543889647015, 6865.347791959955, 6916.170059592881, 6925.065116209247, 4950.108980383566, 4964.652474326763, 4999.200127979506, 5044.596432285335, 5089.6691715038405, 4886.92669609949, 4933.55597996182, 5051.87370315745, 5143.92284115746, 5164.8192313268855], "value": 4545.383626410942, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.8949714862628, 296.179582556319, 311.78093653813596, 314.5863189905273, 315.63859381008746, 4141.316682747351, 4528.366028755977, 5394.865128371793, 5504.532114770244, 5547.472990065942, 4649.3490911272365, 5138.122651315266, 5306.124489459235, 5550.500454959053, 5562.916556251649, 3695.981520092396, 4172.18642364739, 4233.386159006942, 4253.0, 4276.0, 3873.5861410585076, 4158.251514727348, 4267.487901451815, 4279.0799978004725, 4280.57194280571, 3794.1083845296334, 4124.690648201382, 4126.9793651031705, 4130.0, 4144.70987030908, 3436.6735160159997, 3623.221007483404, 3698.796566188845, 3995.7402768820225, 4002.319605667029, 3383.7631365804405, 3540.9114772130647, 3541.94687079694, 3560.3235385276716, 3574.285142971416, 5336.51971322579, 5357.9819834231375, 5363.517283444508, 5367.624266301361, 5437.287254514855, 4274.5939135782055, 4463.5982761551295, 4756.881077973044, 4768.213244814601, 4775.307580400857, 5095.515925987025, 5531.170324451325, 5661.886762264773, 5836.533077353802, 5913.319968203626, 3721.7208709346905, 3888.202918401721, 3910.335243008667, 3917.255721412951, 3928.4107383892647, 6113.816585502442, 6138.925688004626, 6143.539234557426, 6171.9324026451195, 6178.227721534809, 3323.8171900545217, 3654.4152935530187, 3911.5527254915864, 3974.5826688197903, 4008.6971734186504, 3250.561174241447, 3319.245026627893, 3847.6913851688764, 4031.334829753058, 4038.2327357801923, 4354.804033818486, 4713.175194340976, 4748.240281554935, 4759.286107083965, 4763.880902977384, 5672.546196304285, 5775.075987841925, 5829.854253643693, 5848.707564621752, 5921.703914804242, 1296.9027322950628, 1390.603677951779, 1420.7016526529337, 1422.665673566711, 1432.176498513359, 796.3436053009726, 800.9639566219535, 884.5400391796359, 893.8659201119754, 898.2589363774912, 4251.0, 4581.358609794632, 4624.745638989888, 4629.3518907353, 4648.628109751212, 4573.56551127649, 4651.976740116345, 4948.752562371867, 4979.381700947207, 5032.823851165192, 3868.6905047596124, 4038.788363490941, 4608.354830323758, 4614.700044497097, 4651.813927442864, 2031.6444622191352, 2637.736226377347, 2651.695055068692, 2692.1155191366124, 2696.341749823844, 4992.775325110379, 5008.5975926740575, 5216.973915130476, 5248.816291429782, 5248.868778280497, 4256.59562341577, 4348.608625223745, 4608.976955115203, 4733.2900064989835, 4880.951190488121, 5211.592869925099, 5525.585581081355, 5701.515371193412, 6364.377083843683, 6392.9360706392345, 5853.326867410302, 6156.876862462816, 6161.691915404302, 6162.568620196544, 6176.536759742948, 4990.8253211137435, 5449.820071971243, 5693.658380497183, 5965.850853728692, 6084.817455476343, 5381.67709937405, 5569.610127291213, 6312.621242725268, 6320.514679050511, 6344.874467053589, 3989.58109398509, 3993.8003099845473, 4002.599740026091, 4016.779077150785, 4022.1955608877756, 5695.572832037531, 5845.970770146122, 6003.909941350796, 6008.339082700987, 6088.817335479943, 4549.5905368517, 5307.097793375213, 5713.7428815704225, 5865.507159457128, 5917.556183286357, 4855.830045948375, 5536.557075434036, 5550.139728342114, 5870.299662155286, 5882.5293976480925, 4430.911381772282, 5005.774740136775, 5763.4812866842185, 5779.508741756829, 5804.332501762351, 4740.928886066643, 5186.533212010937, 5911.197219669994, 5923.318818335946, 5963.850903727268, 4943.961768028755, 5037.370328708911, 5483.519449748465, 5794.797182098607, 5801.419858014165], "value": 4068.4614915837883, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.5495113811228, 684.2644157530656, 689.0456717446339, 704.3977399323581, 794.1978601612371, 15267.389304427823, 15948.122853243067, 15949.840501594981, 16102.114383708891, 16158.0, 12948.417321220544, 14634.195119268436, 14679.853201467982, 14768.778468322957, 14781.0, 844.1937949258444, 889.7464222696533, 891.9786844063543, 893.1247377569986, 893.2853717026385, 561.5872333834628, 854.6068808348167, 880.6345366672823, 889.1375365895071, 891.9598618062171, 878.7846977490524, 887.6804350433839, 905.2034209895315, 915.8076803871195, 925.9490728009956, 904.2675432899373, 911.4075850697067, 912.9908700913005, 913.1462082952428, 914.8902131744167, 670.594290454273, 682.0519477925687, 683.9589624622539, 684.4421796236052, 690.3096903096903, 15137.394504219817, 15305.770413443808, 15314.923425382913, 15319.157446340447, 15332.846671533365, 14844.109353438827, 14935.850641493555, 14938.253087345698, 14983.0, 15165.317560709795, 12017.158798883995, 12250.938745306306, 12480.750384992249, 12531.874681253163, 12624.621261362174, 3827.349350610403, 3833.0800607854194, 4045.4538637283886, 4067.572904845008, 4073.06319546503, 127655.36172319172, 128489.0, 130019.0, 130562.694373056, 131013.0, 11329.716757080974, 11474.94262528682, 11491.540338386538, 11538.76922461563, 11971.281723096468, 24047.759522404904, 24079.036838526612, 24334.26997190087, 24367.756322436904, 24413.38966525851, 8170.223828736261, 8173.305269052078, 8197.34421246299, 8249.175082491824, 8335.54154521495, 4350.8042138103865, 4406.801693923781, 4492.101579684077, 4499.370088187657, 4681.578657920803, 3394.9830250848586, 3528.1179705073732, 3555.5022296878456, 3561.893143205656, 3566.98216508921, 640.1581919775481, 656.6454114777966, 663.290279401046, 664.2892105447125, 666.0209492046683, 579.547952596975, 586.7271718650848, 615.7567760734574, 643.520577170002, 646.4020780777855, 9028.683996060106, 9089.863652045224, 9167.358284920125, 9173.77065573366, 9206.309526785519, 544.8474427160402, 571.5370549854631, 584.8449312607651, 602.5781952633174, 608.9330173680892, 3827.732058755916, 4453.55464453552, 4487.932681009787, 4488.371627972087, 4566.611837993742, 126962.0, 128694.0, 177086.34370484453, 177437.0, 178088.0, 109507.0, 125678.3716081432, 128047.0, 130711.0, 155436.0, 64547.0, 68093.0, 72436.63781681057, 92950.0, 106902.0, 9069.818603627758, 9290.814183716422, 9602.85595716051, 9992.700218993441, 10022.398656080659, 51687.48312516827, 60229.39770602238, 60729.69635151796, 65313.34686653073, 65449.0, 94582.52708736413, 98510.0, 99538.00461995287, 100381.0, 101367.0, 13111.2133272004, 13169.341532923125, 13207.405666744828, 13390.26353550564, 13556.93221533886, 14835.406583736529, 14946.775798362816, 15000.699986000001, 15009.849901500846, 15460.0, 13822.0, 13859.792103118663, 13889.583312500641, 13940.233287169303, 14145.646358841112, 13777.311134443038, 13890.0, 14062.297403775932, 14216.644583885485, 14813.925930370278, 10815.837762433412, 11545.769084618092, 13096.541621043218, 13452.798208027083, 13486.393112310167, 9582.329236953346, 9972.975937615323, 11134.832977505506, 11252.549898004316, 11483.0, 9108.271338292789, 10184.796304074025, 10735.89264107349, 10789.56841726322, 11639.825402618799], "value": 7855.729038451994, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 118.0, 108.0, 121.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 136.0, 158.0, 108.0, 157.0, 191.0, 117.0, 206.0, 139.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 226.0, 187.0, 186.0, 268.0, 209.0, 284.0, 285.0, 195.0, 197.0], "value": 224.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 85.0, 78.0, 140.0, 60.0, 59.0, 59.0, 64.0, 131.0, 58.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 117.0, 98.0, 104.0, 110.0, 151.0, 95.0, 73.0, 117.0], "value": 100.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 136.0, 121.0, 87.0, 84.0, 89.0, 93.0, 137.0, 117.0], "value": 103.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 108.0, 144.0, 105.0, 149.0, 152.0, 109.0, 96.0, 94.0, 112.0], "value": 122.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 89.0, 92.0, 93.0, 93.0, 109.0, 153.0, 85.0, 152.0], "value": 104.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 58.0, 58.0, 56.0, 57.0, 57.0, 57.0, 55.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 69.0, 71.0, 70.0, 79.0, 80.0, 72.0, 75.0, 73.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 83.0, 85.0, 85.0, 85.0, 83.0, 88.0, 86.0, 87.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 137.0, 139.0, 155.0, 146.0, 156.0, 142.0, 161.0, 149.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 234.0, 227.0, 218.0, 163.0, 166.0, 167.0, 168.0, 167.0, 221.0], "value": 187.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 67.0, 69.0, 66.0, 69.0, 69.0, 67.0, 72.0, 68.0], "value": 69.0, "unit": "score"}]}]} 03:25:50 INFO - Return code: 0 03:25:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:25:50 ERROR - # TBPL SUCCESS # 03:25:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:25:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:25:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:25:50 INFO - 2016-08-08 03:25:50.224 screenresolution[1671:10194] starting screenresolution argv=screenresolution get 03:25:50 INFO - 2016-08-08 03:25:50.227 screenresolution[1671:10194] Display 0: 1600x1200x32@60 03:25:50 INFO - 2016-08-08 03:25:50.233 screenresolution[1672:10197] starting screenresolution argv=screenresolution list 03:25:50 INFO - Available Modes on Display 0 03:25:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:25:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:25:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:25:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:25:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:25:50 INFO - Intel Iris: 03:25:50 INFO - Chipset Model: Intel Iris 03:25:50 INFO - Type: GPU 03:25:50 INFO - Bus: Built-In 03:25:50 INFO - VRAM (Dynamic, Max): 1536 MB 03:25:50 INFO - Vendor: Intel (0x8086) 03:25:50 INFO - Device ID: 0x0a2e 03:25:50 INFO - Revision ID: 0x0009 03:25:50 INFO - Displays: 03:25:50 INFO - Display: 03:25:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:25:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:25:50 INFO - Display Serial Number: 1600x1200 60 03:25:50 INFO - Main Display: Yes 03:25:50 INFO - Mirror: Off 03:25:50 INFO - Online: Yes 03:25:50 INFO - Rotation: Supported 03:25:50 INFO - Return code: 0 03:25:50 INFO - Running post-action listener: _resource_record_post_action 03:25:50 INFO - [mozharness: 2016-08-08 10:25:50.466652Z] Finished run-tests step (success) 03:25:50 INFO - Running post-run listener: _resource_record_post_run 03:25:50 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 31726592; Write bytes: 706457600; Read time: 195; Write time: 2043 03:25:50 INFO - TinderboxPrint: CPU usage
54.2% 03:25:50 INFO - TinderboxPrint: I/O read bytes / time
31,726,592 / 195 03:25:50 INFO - TinderboxPrint: I/O write bytes / time
706,457,600 / 2,043 03:25:50 INFO - TinderboxPrint: CPU idle
2,217.3 (45.8%) 03:25:50 INFO - TinderboxPrint: CPU system
972.7 (20.1%) 03:25:50 INFO - TinderboxPrint: CPU user
1,651.7 (34.1%) 03:25:50 INFO - TinderboxPrint: Swap in / out
434,614,272 / 0 03:25:50 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398408192; Write bytes: 392275456; Read time: 29763; Write time: 865 03:25:50 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29744128; Write bytes: 296290816; Read time: 177; Write time: 1131 03:25:50 INFO - Running post-run listener: _upload_blobber_files 03:25:50 INFO - Blob upload gear active. 03:25:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:25:50 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 03:25:50 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:25:50 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:25:51 INFO - (blobuploader) - INFO - Open directory for files ... 03:25:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:25:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:25:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:52 INFO - (blobuploader) - INFO - Done attempting. 03:25:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:25:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:25:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:53 INFO - (blobuploader) - INFO - Done attempting. 03:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:25:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:55 INFO - (blobuploader) - INFO - Done attempting. 03:25:55 INFO - (blobuploader) - INFO - Iteration through files over. 03:25:55 INFO - Return code: 0 03:25:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:25:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:25:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/285451615f8548b697f1d04e4ec441a206a2befebe7c6d942b2c5dc68ea31752ad9d383166348f316c29fa33046e967a06d418231ed799cda9c51b49681b7200", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08bc0333069db508f9ce4ed480f80c45f1529a6046232cbf0e8cbf259060258bf378c78d54f2463fee851b06e2df1db62706e2198a3727b6fc6bee76e1672e9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e487e279e99e7456d4f8ce1451eb5bd984353ac20f8ac75ec1dd09270d80799b0e995984f2b33a94187c11955a9ec504eb453da0951c7d0870d7440c2bb0b41"} 03:25:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:25:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:25:55 INFO - Contents: 03:25:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/285451615f8548b697f1d04e4ec441a206a2befebe7c6d942b2c5dc68ea31752ad9d383166348f316c29fa33046e967a06d418231ed799cda9c51b49681b7200", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08bc0333069db508f9ce4ed480f80c45f1529a6046232cbf0e8cbf259060258bf378c78d54f2463fee851b06e2df1db62706e2198a3727b6fc6bee76e1672e9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e487e279e99e7456d4f8ce1451eb5bd984353ac20f8ac75ec1dd09270d80799b0e995984f2b33a94187c11955a9ec504eb453da0951c7d0870d7440c2bb0b41"} 03:25:55 INFO - Running post-run listener: copy_logs_to_upload_dir 03:25:55 INFO - Copying logs to upload dir... 03:25:55 INFO - mkdir: /builds/slave/test/build/upload/logs 03:25:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.689116 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-08 03:25:55.799969) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 03:25:55.803996) ========= 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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/285451615f8548b697f1d04e4ec441a206a2befebe7c6d942b2c5dc68ea31752ad9d383166348f316c29fa33046e967a06d418231ed799cda9c51b49681b7200", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08bc0333069db508f9ce4ed480f80c45f1529a6046232cbf0e8cbf259060258bf378c78d54f2463fee851b06e2df1db62706e2198a3727b6fc6bee76e1672e9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e487e279e99e7456d4f8ce1451eb5bd984353ac20f8ac75ec1dd09270d80799b0e995984f2b33a94187c11955a9ec504eb453da0951c7d0870d7440c2bb0b41"} build_url:https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011684 build_url: 'https://queue.taskcluster.net/v1/task/bY7xSrIPR5W28LxjmYWxew/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/285451615f8548b697f1d04e4ec441a206a2befebe7c6d942b2c5dc68ea31752ad9d383166348f316c29fa33046e967a06d418231ed799cda9c51b49681b7200", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08bc0333069db508f9ce4ed480f80c45f1529a6046232cbf0e8cbf259060258bf378c78d54f2463fee851b06e2df1db62706e2198a3727b6fc6bee76e1672e9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e487e279e99e7456d4f8ce1451eb5bd984353ac20f8ac75ec1dd09270d80799b0e995984f2b33a94187c11955a9ec504eb453da0951c7d0870d7440c2bb0b41"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 03:25:55.837694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 03:25:55.838021) ========= 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.TDxmpjtLMe/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.kjbaHtsh1Q/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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.005201 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 03:25:55.886592) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 03:25:55.886929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 03:25:55.887247) ========= ========= Total master_lag: 0.17 =========