builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0303 starttime: 1470487162.26 results: success (0) buildid: 20160806030806 builduid: 1724225eaece43b285b9dae9da65bd29 revision: 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:22.263716) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:22.264676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:22.264971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:22.484752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:22.485097) ========= 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.0qNxYD3cxA/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.jwsoD3b57U/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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-06 05:39:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-08-06 05:39:23 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.626723 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:23.230515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:23.230865) ========= 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.0qNxYD3cxA/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.jwsoD3b57U/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.020170 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:23.283120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-06 05:39:23.283433) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0qNxYD3cxA/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.jwsoD3b57U/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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-06 05:39:23,369 truncating revision to first 12 chars 2016-08-06 05:39:23,369 Setting DEBUG logging. 2016-08-06 05:39:23,369 attempt 1/10 2016-08-06 05:39:23,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6b65dd49d4f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-06 05:39:24,501 unpacking tar archive at: mozilla-central-6b65dd49d4f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.386257 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-06 05:39:24.692173) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:24.692545) ========= script_repo_revision: 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:24.692963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:24.693307) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 05:39:24.720159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-06 05:39:24.720458) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0qNxYD3cxA/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.jwsoD3b57U/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:39:24 INFO - MultiFileLogger online at 20160806 05:39:24 in /builds/slave/test 05:39:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:39:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:24 INFO - {'append_to_log': False, 05:39:24 INFO - 'base_work_dir': '/builds/slave/test', 05:39:24 INFO - 'blob_upload_branch': 'Firefox', 05:39:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:24 INFO - 'branch': 'Firefox', 05:39:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:24 INFO - 'config_files': ('talos/mac_config.py',), 05:39:24 INFO - 'default_actions': ('clobber', 05:39:24 INFO - 'read-buildbot-config', 05:39:24 INFO - 'download-and-extract', 05:39:24 INFO - 'populate-webroot', 05:39:24 INFO - 'create-virtualenv', 05:39:24 INFO - 'install', 05:39:24 INFO - 'run-tests'), 05:39:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:24 INFO - 'download_minidump_stackwalk': True, 05:39:24 INFO - 'download_symbols': 'ondemand', 05:39:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:24 INFO - 'installer_path': 'installer.exe', 05:39:24 INFO - 'log_level': 'info', 05:39:24 INFO - 'log_name': 'talos', 05:39:24 INFO - 'log_to_console': True, 05:39:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:39:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:39:24 INFO - 'opt_config_files': (), 05:39:24 INFO - 'pip_index': False, 05:39:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:39:24 INFO - 'cmd': ('bash', 05:39:24 INFO - '-c', 05:39:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:39:24 INFO - 'enabled': True, 05:39:24 INFO - 'halt_on_failure': False, 05:39:24 INFO - 'name': 'check_screen_resolution'},), 05:39:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:39:24 INFO - 'cmd': ('bash', 05:39:24 INFO - '-c', 05:39:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:39:24 INFO - 'enabled': True, 05:39:24 INFO - 'halt_on_failure': False, 05:39:24 INFO - 'name': 'check_screen_resolution'},), 05:39:24 INFO - 'run_cmd_checks_enabled': True, 05:39:24 INFO - 'sps_profile': False, 05:39:24 INFO - 'sps_profile_interval': 0, 05:39:24 INFO - 'suite': 'dromaeojs', 05:39:24 INFO - 'system_bits': '32', 05:39:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:24 INFO - 'title': 't-yosemite-r7-0303', 05:39:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:24 INFO - 'use_talos_json': True, 05:39:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:24 INFO - 'work_dir': 'build'} 05:39:24 INFO - [mozharness: 2016-08-06 12:39:24.915188Z] Running clobber step. 05:39:24 INFO - Running pre-action listener: _resource_record_pre_action 05:39:24 INFO - Running main action method: clobber 05:39:24 INFO - rmtree: /builds/slave/test/build 05:39:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:25 INFO - Running post-action listener: _resource_record_post_action 05:39:25 INFO - [mozharness: 2016-08-06 12:39:25.816094Z] Finished clobber step (success) 05:39:25 INFO - [mozharness: 2016-08-06 12:39:25.816276Z] Running read-buildbot-config step. 05:39:25 INFO - Running pre-action listener: _resource_record_pre_action 05:39:25 INFO - Running main action method: read_buildbot_config 05:39:25 INFO - Using buildbot properties: 05:39:25 INFO - { 05:39:25 INFO - "project": "", 05:39:25 INFO - "product": "firefox", 05:39:25 INFO - "script_repo_revision": "production", 05:39:25 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:39:25 INFO - "repository": "", 05:39:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:39:25 INFO - "buildid": "20160806030806", 05:39:25 INFO - "stage_platform": "macosx64", 05:39:25 INFO - "basedir": "/builds/slave/test", 05:39:25 INFO - "nightly_build": "True", 05:39:25 INFO - "buildnumber": 26, 05:39:25 INFO - "slavename": "t-yosemite-r7-0303", 05:39:25 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:39:25 INFO - "platform": "yosemite_r7", 05:39:25 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:39:25 INFO - "branch": "mozilla-central", 05:39:25 INFO - "repo_path": "mozilla-central", 05:39:25 INFO - "revision": "6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8", 05:39:25 INFO - "pgo_build": "False", 05:39:25 INFO - "builduid": "1724225eaece43b285b9dae9da65bd29", 05:39:25 INFO - "slavebuilddir": "test" 05:39:25 INFO - } 05:39:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:39:25 INFO - Running post-action listener: _resource_record_post_action 05:39:25 INFO - [mozharness: 2016-08-06 12:39:25.819738Z] Finished read-buildbot-config step (success) 05:39:25 INFO - [mozharness: 2016-08-06 12:39:25.819847Z] Running download-and-extract step. 05:39:25 INFO - Running pre-action listener: _resource_record_pre_action 05:39:25 INFO - Running main action method: download_and_extract 05:39:25 INFO - mkdir: /builds/slave/test/build/tests 05:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:25 INFO - trying https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:39:25 INFO - Downloading https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 05:39:26 INFO - Downloaded 1199 bytes. 05:39:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:39:26 INFO - Using the following test package requirements: 05:39:26 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:39:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:39:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:39:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:39:26 INFO - u'jsshell-mac.zip'], 05:39:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:39:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:39:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:39:26 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:39:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:39:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:39:26 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:39:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:26 INFO - trying https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:39:26 INFO - Downloading https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:39:28 INFO - Downloaded 16320647 bytes. 05:39:28 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'] 05:39:28 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 05:39:31 INFO - Return code: 0 05:39:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:31 INFO - trying https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:39:31 INFO - Downloading https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:39:32 INFO - Downloaded 16320647 bytes. 05:39:32 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'] 05:39:32 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 05:39:35 INFO - Return code: 0 05:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:35 INFO - trying https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:39:35 INFO - Downloading https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:39:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:39:37 INFO - Downloaded 14413723 bytes. 05:39:37 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'] 05:39:37 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 05:39:37 INFO - Return code: 0 05:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:37 INFO - trying https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:39:37 INFO - Downloading https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 05:39:43 INFO - Downloaded 111930957 bytes. 05:39:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:39:43 INFO - mkdir: /builds/slave/test/properties 05:39:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:43 INFO - Contents: 05:39:43 INFO - build_url:https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:39:44 INFO - Running post-action listener: _resource_record_post_action 05:39:44 INFO - Running post-action listener: set_extra_try_arguments 05:39:44 INFO - [mozharness: 2016-08-06 12:39:44.497226Z] Finished download-and-extract step (success) 05:39:44 INFO - [mozharness: 2016-08-06 12:39:44.497360Z] Running populate-webroot step. 05:39:44 INFO - Running pre-action listener: _resource_record_pre_action 05:39:44 INFO - Running main action method: populate_webroot 05:39:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:44 INFO - '--tppagecycles', 05:39:44 INFO - '7'], 05:39:44 INFO - 'tests': ['tsvgm']}}, 05:39:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:39:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:39:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:39:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:44 INFO - 'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:44 INFO - 'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['damp', 'tps']}, 05:39:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:44 INFO - 'tests': ['damp', 'tps']}, 05:39:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['dromaeo_dom']}, 05:39:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['basic_compositor_video']}, 05:39:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:39:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['a11yr', 05:39:44 INFO - 'ts_paint', 05:39:44 INFO - 'tpaint', 05:39:44 INFO - 'sessionrestore', 05:39:44 INFO - 'sessionrestore_no_auto_restore', 05:39:44 INFO - 'tabpaint']}, 05:39:44 INFO - 'other-e10s': {'tests': ['a11yr', 05:39:44 INFO - 'ts_paint', 05:39:44 INFO - 'tpaint', 05:39:44 INFO - 'sessionrestore', 05:39:44 INFO - 'sessionrestore_no_auto_restore', 05:39:44 INFO - 'tabpaint']}, 05:39:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:39:44 INFO - 'ts_paint', 05:39:44 INFO - 'tpaint', 05:39:44 INFO - 'sessionrestore', 05:39:44 INFO - 'sessionrestore_no_auto_restore', 05:39:44 INFO - 'tabpaint']}, 05:39:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:39:44 INFO - 'ts_paint', 05:39:44 INFO - 'tpaint', 05:39:44 INFO - 'sessionrestore', 05:39:44 INFO - 'sessionrestore_no_auto_restore', 05:39:44 INFO - 'tabpaint']}, 05:39:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['a11yr', 05:39:44 INFO - 'ts_paint', 05:39:44 INFO - 'tpaint', 05:39:44 INFO - 'sessionrestore', 05:39:44 INFO - 'sessionrestore_no_auto_restore', 05:39:44 INFO - 'tabpaint']}, 05:39:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['a11yr', 05:39:44 INFO - 'ts_paint', 05:39:44 INFO - 'tpaint', 05:39:44 INFO - 'sessionrestore', 05:39:44 INFO - 'sessionrestore_no_auto_restore', 05:39:44 INFO - 'tabpaint']}, 05:39:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['tsvgx', 05:39:44 INFO - 'tsvgr_opacity', 05:39:44 INFO - 'tart', 05:39:44 INFO - 'tscrollx', 05:39:44 INFO - 'cart']}, 05:39:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:39:44 INFO - 'tsvgr_opacity', 05:39:44 INFO - 'tart', 05:39:44 INFO - 'tscrollx', 05:39:44 INFO - 'cart']}, 05:39:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:44 INFO - 'talos_options': ['--disable-e10s'], 05:39:44 INFO - 'tests': ['tp5o']}, 05:39:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:44 INFO - 'tests': ['tp5o']}, 05:39:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:44 INFO - 'talos_options': ['--disable-e10s', 05:39:44 INFO - '--xperf_path', 05:39:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:44 INFO - 'tests': ['tp5n']}, 05:39:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:44 INFO - 'talos_options': ['--xperf_path', 05:39:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:44 INFO - 'tests': ['tp5n']}}, 05:39:44 INFO - 'talos.zip': {'path': '', 05:39:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:44 INFO - Running post-action listener: _resource_record_post_action 05:39:44 INFO - [mozharness: 2016-08-06 12:39:44.516417Z] Finished populate-webroot step (success) 05:39:44 INFO - [mozharness: 2016-08-06 12:39:44.516558Z] Running create-virtualenv step. 05:39:44 INFO - Running pre-action listener: _resource_record_pre_action 05:39:44 INFO - Running main action method: create_virtualenv 05:39:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:39:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:44 INFO - Using real prefix '/tools/python27' 05:39:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:48 INFO - Installing pip.................done. 05:39:48 INFO - Return code: 0 05:39:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:48 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 0x10b3dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b473618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f9e9cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, '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.0qNxYD3cxA/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.jwsoD3b57U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:39:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:39:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:48 INFO - 'HOME': '/Users/cltbld', 05:39:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:48 INFO - 'LOGNAME': 'cltbld', 05:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:48 INFO - 'MOZ_NO_REMOTE': '1', 05:39:48 INFO - 'NO_EM_RESTART': '1', 05:39:48 INFO - 'PAGER': '/bin/cat', 05:39:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:48 INFO - 'PWD': '/builds/slave/test', 05:39:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:48 INFO - 'SHELL': '/bin/bash', 05:39:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:39:48 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:39:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:48 INFO - 'USER': 'cltbld', 05:39:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:48 INFO - 'XPC_FLAGS': '0x0', 05:39:48 INFO - 'XPC_SERVICE_NAME': '0', 05:39:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:39:48 INFO - Cleaning up... 05:39:48 INFO - Return code: 0 05:39:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:48 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 0x10b3dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b473618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f9e9cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, '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.0qNxYD3cxA/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.jwsoD3b57U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:39:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:39:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:48 INFO - 'HOME': '/Users/cltbld', 05:39:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:48 INFO - 'LOGNAME': 'cltbld', 05:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:48 INFO - 'MOZ_NO_REMOTE': '1', 05:39:48 INFO - 'NO_EM_RESTART': '1', 05:39:48 INFO - 'PAGER': '/bin/cat', 05:39:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:48 INFO - 'PWD': '/builds/slave/test', 05:39:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:48 INFO - 'SHELL': '/bin/bash', 05:39:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:39:48 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:39:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:48 INFO - 'USER': 'cltbld', 05:39:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:48 INFO - 'XPC_FLAGS': '0x0', 05:39:48 INFO - 'XPC_SERVICE_NAME': '0', 05:39:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:48 INFO - Downloading/unpacking psutil>=3.1.1 05:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:51 INFO - Installing collected packages: psutil 05:39:51 INFO - Running setup.py install for psutil 05:39:51 INFO - building 'psutil._psutil_osx' extension 05:39:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:39:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:39:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:39:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:39:52 INFO - building 'psutil._psutil_posix' extension 05:39:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:39:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:39:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:39:52 INFO - ^ 05:39:52 INFO - 1 warning generated. 05:39:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:39:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:52 INFO - Successfully installed psutil 05:39:52 INFO - Cleaning up... 05:39:52 INFO - Return code: 0 05:39:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:52 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 0x10b3dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b473618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f9e9cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, '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.0qNxYD3cxA/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.jwsoD3b57U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:52 INFO - 'HOME': '/Users/cltbld', 05:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:52 INFO - 'LOGNAME': 'cltbld', 05:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:52 INFO - 'MOZ_NO_REMOTE': '1', 05:39:52 INFO - 'NO_EM_RESTART': '1', 05:39:52 INFO - 'PAGER': '/bin/cat', 05:39:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:52 INFO - 'PWD': '/builds/slave/test', 05:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:52 INFO - 'SHELL': '/bin/bash', 05:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:39:52 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:52 INFO - 'USER': 'cltbld', 05:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:52 INFO - 'XPC_FLAGS': '0x0', 05:39:52 INFO - 'XPC_SERVICE_NAME': '0', 05:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:39:55 INFO - Installing collected packages: mozsystemmonitor 05:39:55 INFO - Running setup.py install for mozsystemmonitor 05:39:55 INFO - Successfully installed mozsystemmonitor 05:39:55 INFO - Cleaning up... 05:39:55 INFO - Return code: 0 05:39:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:55 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 0x10b3dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b473618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f9e9cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, '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.0qNxYD3cxA/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.jwsoD3b57U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:39:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:39:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:55 INFO - 'HOME': '/Users/cltbld', 05:39:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:55 INFO - 'LOGNAME': 'cltbld', 05:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:55 INFO - 'MOZ_NO_REMOTE': '1', 05:39:55 INFO - 'NO_EM_RESTART': '1', 05:39:55 INFO - 'PAGER': '/bin/cat', 05:39:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:55 INFO - 'PWD': '/builds/slave/test', 05:39:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:55 INFO - 'SHELL': '/bin/bash', 05:39:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:39:55 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:39:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:55 INFO - 'USER': 'cltbld', 05:39:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:55 INFO - 'XPC_FLAGS': '0x0', 05:39:55 INFO - 'XPC_SERVICE_NAME': '0', 05:39:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:55 INFO - Downloading/unpacking jsonschema==2.5.1 05:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:58 INFO - warning: no files found matching '*.txt' 05:39:58 INFO - no previously-included directories found matching 'build' 05:39:58 INFO - no previously-included directories found matching 'dist' 05:39:58 INFO - no previously-included directories found matching '.git*' 05:39:58 INFO - Installing collected packages: jsonschema, functools32 05:39:59 INFO - Running setup.py install for functools32 05:39:59 INFO - warning: no files found matching '*.txt' 05:39:59 INFO - no previously-included directories found matching 'build' 05:39:59 INFO - no previously-included directories found matching 'dist' 05:39:59 INFO - no previously-included directories found matching '.git*' 05:39:59 INFO - Successfully installed jsonschema functools32 05:39:59 INFO - Cleaning up... 05:39:59 INFO - Return code: 0 05:39:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:59 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 0x10b3dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b473618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f9e9cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, '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.0qNxYD3cxA/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.jwsoD3b57U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:39:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:39:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:59 INFO - 'HOME': '/Users/cltbld', 05:39:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:59 INFO - 'LOGNAME': 'cltbld', 05:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:59 INFO - 'MOZ_NO_REMOTE': '1', 05:39:59 INFO - 'NO_EM_RESTART': '1', 05:39:59 INFO - 'PAGER': '/bin/cat', 05:39:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:59 INFO - 'PWD': '/builds/slave/test', 05:39:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:59 INFO - 'SHELL': '/bin/bash', 05:39:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:39:59 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:39:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:59 INFO - 'USER': 'cltbld', 05:39:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:59 INFO - 'XPC_FLAGS': '0x0', 05:39:59 INFO - 'XPC_SERVICE_NAME': '0', 05:39:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:39:59 INFO - Cleaning up... 05:39:59 INFO - Return code: 0 05:39:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:59 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 0x10b3dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b473618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f9e9cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, '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.0qNxYD3cxA/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.jwsoD3b57U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:39:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:39:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:59 INFO - 'HOME': '/Users/cltbld', 05:39:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:59 INFO - 'LOGNAME': 'cltbld', 05:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:59 INFO - 'MOZ_NO_REMOTE': '1', 05:39:59 INFO - 'NO_EM_RESTART': '1', 05:39:59 INFO - 'PAGER': '/bin/cat', 05:39:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:59 INFO - 'PWD': '/builds/slave/test', 05:39:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:59 INFO - 'SHELL': '/bin/bash', 05:39:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:39:59 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:39:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:59 INFO - 'USER': 'cltbld', 05:39:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:59 INFO - 'XPC_FLAGS': '0x0', 05:39:59 INFO - 'XPC_SERVICE_NAME': '0', 05:39:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:40:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:03 INFO - Downloading docopt-0.6.1.tar.gz 05:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:03 INFO - Running setup.py install for blobuploader 05:40:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:40:03 INFO - Running setup.py install for requests 05:40:04 INFO - Running setup.py install for docopt 05:40:04 INFO - Successfully installed blobuploader requests docopt 05:40:04 INFO - Cleaning up... 05:40:04 INFO - Return code: 0 05:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40: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')]} 05:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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')]} 05:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:04 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 0x10b3dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b473618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f9e9cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, '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.0qNxYD3cxA/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.jwsoD3b57U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:40:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:04 INFO - 'HOME': '/Users/cltbld', 05:40:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:04 INFO - 'LOGNAME': 'cltbld', 05:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:04 INFO - 'MOZ_NO_REMOTE': '1', 05:40:04 INFO - 'NO_EM_RESTART': '1', 05:40:04 INFO - 'PAGER': '/bin/cat', 05:40:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:04 INFO - 'PWD': '/builds/slave/test', 05:40:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:04 INFO - 'SHELL': '/bin/bash', 05:40:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:40:04 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:40:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:04 INFO - 'USER': 'cltbld', 05:40:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:04 INFO - 'XPC_FLAGS': '0x0', 05:40:04 INFO - 'XPC_SERVICE_NAME': '0', 05:40:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:04 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-k2m6Is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:04 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-BzVBzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:04 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-McLHWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:04 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-bY_VXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:05 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-nOiEKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:05 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-T1v3tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:05 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-wgvQDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:05 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-9pkZAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:05 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-RsbCpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:05 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-GGiPxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:05 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-47YV5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:05 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-7tgPbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:05 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-bdBpz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:06 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-DzTfGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:06 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-jHpDT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:06 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-FGMNAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:06 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-tTq7SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:06 INFO - Running setup.py install for manifestparser 05:40:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:40:06 INFO - Running setup.py install for mozcrash 05:40:06 INFO - Running setup.py install for mozdebug 05:40:06 INFO - Running setup.py install for mozdevice 05:40:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:40:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:40:07 INFO - Running setup.py install for mozfile 05:40:07 INFO - Running setup.py install for mozhttpd 05:40:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:40:07 INFO - Running setup.py install for mozinfo 05:40:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:40:07 INFO - Running setup.py install for mozInstall 05:40:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:40:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:40:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:40:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:40:07 INFO - Running setup.py install for mozleak 05:40:07 INFO - Running setup.py install for mozlog 05:40:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:40:07 INFO - Running setup.py install for moznetwork 05:40:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:40:08 INFO - Running setup.py install for mozprocess 05:40:08 INFO - Running setup.py install for mozprofile 05:40:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:40:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:40:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:40:08 INFO - Running setup.py install for mozrunner 05:40:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:40:08 INFO - Running setup.py install for mozscreenshot 05:40:08 INFO - Running setup.py install for moztest 05:40:08 INFO - Running setup.py install for mozversion 05:40:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:09 INFO - Cleaning up... 05:40:09 INFO - Return code: 0 05:40:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:09 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 0x10b3dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b473618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f9e9cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, '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.0qNxYD3cxA/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.jwsoD3b57U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:40:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:09 INFO - 'HOME': '/Users/cltbld', 05:40:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:09 INFO - 'LOGNAME': 'cltbld', 05:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:09 INFO - 'MOZ_NO_REMOTE': '1', 05:40:09 INFO - 'NO_EM_RESTART': '1', 05:40:09 INFO - 'PAGER': '/bin/cat', 05:40:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:09 INFO - 'PWD': '/builds/slave/test', 05:40:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:09 INFO - 'SHELL': '/bin/bash', 05:40:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:40:09 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:40:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:09 INFO - 'USER': 'cltbld', 05:40:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:09 INFO - 'XPC_FLAGS': '0x0', 05:40:09 INFO - 'XPC_SERVICE_NAME': '0', 05:40:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:09 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-D_SVN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:09 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Qs7Blh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:09 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-X2eqdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:09 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-TVXWVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:09 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-C4BoKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:09 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-kGdyIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:09 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Iwnfhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:10 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-0us_If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:10 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-4A_5p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:10 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-3Zi6or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:10 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-k8r_Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:10 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-XtI47y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:10 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ffqEzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:10 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-q1kZ3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:10 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-m9PDEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:10 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-nqeKC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:11 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-eKZEFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:13 INFO - Downloading blessings-1.6.tar.gz 05:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:13 INFO - Installing collected packages: blessings 05:40:13 INFO - Running setup.py install for blessings 05:40:13 INFO - Successfully installed blessings 05:40:13 INFO - Cleaning up... 05:40:13 INFO - Return code: 0 05:40:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:14 INFO - Reading from file tmpfile_stdout 05:40:14 INFO - Current package versions: 05:40:14 INFO - blessings == 1.6 05:40:14 INFO - blobuploader == 1.2.4 05:40:14 INFO - docopt == 0.6.1 05:40:14 INFO - functools32 == 3.2.3-2 05:40:14 INFO - jsonschema == 2.5.1 05:40:14 INFO - manifestparser == 1.1 05:40:14 INFO - mozInstall == 1.12 05:40:14 INFO - mozcrash == 0.17 05:40:14 INFO - mozdebug == 0.1 05:40:14 INFO - mozdevice == 0.48 05:40:14 INFO - mozfile == 1.2 05:40:14 INFO - mozhttpd == 0.7 05:40:14 INFO - mozinfo == 0.9 05:40:14 INFO - mozleak == 0.1 05:40:14 INFO - mozlog == 3.3 05:40:14 INFO - moznetwork == 0.27 05:40:14 INFO - mozprocess == 0.23 05:40:14 INFO - mozprofile == 0.28 05:40:14 INFO - mozrunner == 6.12 05:40:14 INFO - mozscreenshot == 0.1 05:40:14 INFO - mozsystemmonitor == 0.3 05:40:14 INFO - moztest == 0.7 05:40:14 INFO - mozversion == 1.4 05:40:14 INFO - psutil == 3.1.1 05:40:14 INFO - requests == 1.2.3 05:40:14 INFO - wsgiref == 0.1.2 05:40:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 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 0x10b3dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b473618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f9e9cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, '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.0qNxYD3cxA/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.jwsoD3b57U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:14 INFO - 'HOME': '/Users/cltbld', 05:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:14 INFO - 'LOGNAME': 'cltbld', 05:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:14 INFO - 'MOZ_NO_REMOTE': '1', 05:40:14 INFO - 'NO_EM_RESTART': '1', 05:40:14 INFO - 'PAGER': '/bin/cat', 05:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:14 INFO - 'PWD': '/builds/slave/test', 05:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:14 INFO - 'SHELL': '/bin/bash', 05:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:40:14 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:14 INFO - 'USER': 'cltbld', 05:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:14 INFO - 'XPC_FLAGS': '0x0', 05:40:14 INFO - 'XPC_SERVICE_NAME': '0', 05:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:40:14 INFO - Cleaning up... 05:40:14 INFO - Return code: 0 05:40:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 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 0x10b3dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b473618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f9e9cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, '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.0qNxYD3cxA/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.jwsoD3b57U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:14 INFO - 'HOME': '/Users/cltbld', 05:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:14 INFO - 'LOGNAME': 'cltbld', 05:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:14 INFO - 'MOZ_NO_REMOTE': '1', 05:40:14 INFO - 'NO_EM_RESTART': '1', 05:40:14 INFO - 'PAGER': '/bin/cat', 05:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:14 INFO - 'PWD': '/builds/slave/test', 05:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:14 INFO - 'SHELL': '/bin/bash', 05:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:40:14 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:14 INFO - 'USER': 'cltbld', 05:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:14 INFO - 'XPC_FLAGS': '0x0', 05:40:14 INFO - 'XPC_SERVICE_NAME': '0', 05:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:40:14 INFO - Cleaning up... 05:40:14 INFO - Return code: 0 05:40:14 INFO - Running post-action listener: _resource_record_post_action 05:40:14 INFO - Running post-action listener: _start_resource_monitoring 05:40:14 INFO - Starting resource monitoring. 05:40:14 INFO - [mozharness: 2016-08-06 12:40:14.721653Z] Finished create-virtualenv step (success) 05:40:14 INFO - [mozharness: 2016-08-06 12:40:14.722518Z] Running install step. 05:40:14 INFO - Running pre-action listener: _resource_record_pre_action 05:40:14 INFO - Running main action method: install 05:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:14 INFO - Reading from file tmpfile_stdout 05:40:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:40:15 INFO - Reading from file tmpfile_stdout 05:40:15 INFO - Output received: 05:40:15 INFO - Usage: mozinstall [options] installer 05:40:15 INFO - Options: 05:40:15 INFO - -h, --help show this help message and exit 05:40:15 INFO - -d DEST, --destination=DEST 05:40:15 INFO - Directory to install application into. [default: 05:40:15 INFO - "/builds/slave/test"] 05:40:15 INFO - --app=APP Application being installed. [default: firefox] 05:40:15 INFO - mkdir: /builds/slave/test/build/application 05:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:40:49 INFO - Reading from file tmpfile_stdout 05:40:49 INFO - Output received: 05:40:49 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:40:49 INFO - Running post-action listener: _resource_record_post_action 05:40:49 INFO - [mozharness: 2016-08-06 12:40:49.611923Z] Finished install step (success) 05:40:49 INFO - [mozharness: 2016-08-06 12:40:49.612105Z] Running run-tests step. 05:40:49 INFO - Running pre-action listener: _resource_record_pre_action 05:40:49 INFO - Running main action method: run_tests 05:40:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:40:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:40:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:40:49 INFO - 2016-08-06 05:40:49.626 screenresolution[2365:32534] starting screenresolution argv=screenresolution get 05:40:49 INFO - 2016-08-06 05:40:49.629 screenresolution[2365:32534] Display 0: 1600x1200x32@60 05:40:49 INFO - 2016-08-06 05:40:49.635 screenresolution[2366:32536] starting screenresolution argv=screenresolution list 05:40:49 INFO - Available Modes on Display 0 05:40:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:40:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:40:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:40:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:40:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:40:49 INFO - Intel Iris: 05:40:49 INFO - Chipset Model: Intel Iris 05:40:49 INFO - Type: GPU 05:40:49 INFO - Bus: Built-In 05:40:49 INFO - VRAM (Dynamic, Max): 1536 MB 05:40:49 INFO - Vendor: Intel (0x8086) 05:40:49 INFO - Device ID: 0x0a2e 05:40:49 INFO - Revision ID: 0x0009 05:40:49 INFO - Displays: 05:40:49 INFO - Display: 05:40:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:40:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:40:49 INFO - Display Serial Number: 1600x1200 60 05:40:49 INFO - Main Display: Yes 05:40:49 INFO - Mirror: Off 05:40:49 INFO - Online: Yes 05:40:49 INFO - Rotation: Supported 05:40:49 INFO - Return code: 0 05:40:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:40:49 INFO - Python 2.7.3 05:40:49 INFO - Return code: 0 05:40:49 INFO - grabbing minidump binary from tooltool 05:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:49 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 0x10b342d30>, '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 0x10b0a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b33ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:40:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:40:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:40:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:40:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:49 INFO - Return code: 0 05:40:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:40:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:40:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:40:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:40:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:40:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0303 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:40:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0qNxYD3cxA/Render', 05:40:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:50 INFO - 'HOME': '/Users/cltbld', 05:40:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:50 INFO - 'LOGNAME': 'cltbld', 05:40:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:40:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:50 INFO - 'MOZ_NO_REMOTE': '1', 05:40:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:40:50 INFO - 'NO_EM_RESTART': '1', 05:40:50 INFO - 'PAGER': '/bin/cat', 05:40:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:50 INFO - 'PWD': '/builds/slave/test', 05:40:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:40:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:50 INFO - 'SHELL': '/bin/bash', 05:40:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwsoD3b57U/Listeners', 05:40:50 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:40:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:50 INFO - 'USER': 'cltbld', 05:40:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:50 INFO - 'XPC_FLAGS': '0x0', 05:40:50 INFO - 'XPC_SERVICE_NAME': '0', 05:40:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:40:50 INFO - mozversion application_buildid: 20160806030806 05:40:50 INFO - mozversion application_changeset: 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 05:40:50 INFO - mozversion application_display_name: Nightly 05:40:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:50 INFO - mozversion application_name: Firefox 05:40:50 INFO - mozversion application_remotingname: firefox 05:40:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:40:50 INFO - mozversion application_vendor: Mozilla 05:40:50 INFO - mozversion application_version: 51.0a1 05:40:50 INFO - mozversion platform_buildid: 20160806030806 05:40:50 INFO - mozversion platform_changeset: 6b65dd49d4f045c0a9753ce60bdb4b7b4aaedcf8 05:40:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:40:50 INFO - mozversion platform_version: 51.0a1 05:40:50 INFO - using testdate: 1470487250 05:40:50 INFO - actual date: 1470487250 05:40:50 INFO - starting webserver on 'localhost:53953' 05:40:50 INFO - SUITE-START | Running 2 tests 05:40:50 INFO - TEST-START | dromaeo_css 05:40:50 INFO - operating with platform_type : mac_ 05:40:50 INFO - Initialising browser for dromaeo_css test... 05:40:50 INFO - TEST-INFO | started process 2376 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpHrKVTZ/profile http://localhost:53953/getInfo.html) 05:40:52 INFO - PROCESS | 2376 | __metrics Screen width/height:1600/1200 05:40:52 INFO - PROCESS | 2376 | colorDepth:24 05:40:52 INFO - PROCESS | 2376 | Browser inner width/height: 1024/689 05:40:52 INFO - PROCESS | 2376 | __metrics 05:40:52 INFO - PROCESS | 2376 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:40:52 INFO - PROCESS | 2376 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:40:53 INFO - TEST-INFO | 2376: exit 0 05:40:53 INFO - Browser initialized. 05:40:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:53 INFO - TEST-INFO | started process 2379 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpHrKVTZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:05 INFO - PROCESS | 2379 | RSS: Main: 243429376 05:41:05 INFO - PROCESS | 2379 | 05:41:57 INFO - PROCESS | 2379 | 1470487317299 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:44:09 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:53953/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53953/tests/dromaeo/cssquery-ext.html) 05:44:10 INFO - PROCESS | 2379 | RSS: Main: 356421632 05:44:10 INFO - PROCESS | 2379 | 05:47:13 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:53953/tests/dromaeo/cssquery-ext.html (next: http://localhost:53953/tests/dromaeo/cssquery-jquery.html) 05:47:14 INFO - PROCESS | 2379 | RSS: Main: 387088384 05:47:14 INFO - PROCESS | 2379 | 05:50:16 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:53953/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53953/tests/dromaeo/cssquery-mootools.html) 05:50:17 INFO - PROCESS | 2379 | RSS: Main: 379486208 05:50:17 INFO - PROCESS | 2379 | 05:53:19 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:53953/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53953/tests/dromaeo/cssquery-prototype.html) 05:53:20 INFO - PROCESS | 2379 | RSS: Main: 348344320 05:53:20 INFO - PROCESS | 2379 | 05:56:23 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:53953/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53953/tests/dromaeo/cssquery-yui.html) 05:56:24 INFO - PROCESS | 2379 | RSS: Main: 343474176 05:56:24 INFO - PROCESS | 2379 | 05:59:28 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:53953/tests/dromaeo/cssquery-yui.html (next: http://localhost:53953/tests/dromaeo/cssquery-dojo.html) 05:59:28 INFO - PROCESS | 2379 | RSS: Main: 459247616 05:59:28 INFO - PROCESS | 2379 | 05:59:28 INFO - PROCESS | 2379 | __start_tp_report 05:59:28 INFO - PROCESS | 2379 | _x_x_mozilla_page_load 05:59:28 INFO - PROCESS | 2379 | _x_x_mozilla_page_load_details 05:59:28 INFO - PROCESS | 2379 | |i|pagename|runs| 05:59:28 INFO - PROCESS | 2379 | |0;dojo.html;3341.33173365327;3365.713914317283;3377.408953433149;3377.493375993601;3384.8815291464803;5587.692676902769;5655.321361436633;5656.7737290508385;5749.367569567345;5765.3369862465825;4815.807367705288;5563.193336966137;5671.092625179982;5807.796727114542;5809.854753631162;5088.54203121719;5115.10485665009;5144.3826740791155;5179.637425380225;5281.551068159192;5302.3106996090455;5309.362876454831;5364.946350536503;5369.919451208235;5372.979133964534;4646.512116227798;5142.717150556718;5198.2722418861385;5240.633155679104;5272.288241087443;5181.4041385240425;5229.424763276036;5235.869103272411;5239.423663397023;5253.08071087562;5155.74221288934;5182.222666600002;5193.091209038404;5214.374275087014;5217.608679349026;5715.114157305624;5717.685527295997;5729.4843464088435;5741.33974592923;5746.166805813134;6112.449879510866;6112.777056696867;6152.5693201475915;6191.0713392990965;6199.070139479069;6178.567500274982;6184.84537886552;6243.43809057187;6250.281217659982;6270.78052268173;5131.076406246837;5892.852678683024;5904.439078287556;5913.763449462016;5944.494717948936;6163.568550201443;6198.938010619926;6212.81361559154;6216.471599914058;6228.408301211378;5155.484451554815;6164.660943648053;6207.131001659771;6209.720562574695;6210.565260431817;6092.329843717188;6240.188775459252;6241.843953901098;6242.032484964838;6260.217472815898;6119.654885717031;6142.140100385949;6144.2488890665945;6186.443220110122;6238.407351301619;6198.659073750897;6221.09794079865;6226.128342032119;6243.937560624427;6249.0938813871735;4232.492100947844;4982.576480999083;4983.9252411213865;4985.401751789808;4996.325496057985;4306;4346.413234213404;4412.911741765147;4444.533324000998;4503.054358584668;5699.629524080921;5701.258836351248;5706;5727.656340619576;5733.455321744427;6230.470410015199;6246.000639897595;6272.153259310026;6272.717727702265;6299.811005669837;5616.326040875121;5713.342965558931;5727.799527016535;5733.254676892061;5839.620424672383;5463.125899856004;5464.754086066137;5469.890602188014;5471.37079235893;5481;6292.811215663537;6321.747130114928;6342.714577843916;6350.079238510482;6359.459445947146;6109.266887973472;6167.198264225802;6178.443940045418;6239.875202496016;6276.309605943434;6271.4669253114;6278.8430289241305;6280.214973128359;6297.685115744286;6316.778912738032;6148.354422785543;6186.752529898934;6188.597741146811;6202.5658203925295;6208.192934918432;6107.097787096225;6130.080487926668;6183.938160618516;6208.782692605737;6262;6070.817875463743;6073.696315184135;6083.64640113197;6099.400579571985;6121.47967422774;5994.67029313392;6029.939700602938;6084.665343406155;6085.361037091042;6097.7865774697675;5778.855528611818;5866.5893387462465;5888.941110588839;5928.140419639214;5994.520438365008;4417;6023.698815059141;6045.425684559959;6057.273127224761;6059.666718330534;5873.618214816023;5890.028145355968;5892.587518873637;5900.321463031806;5923.378045305353 05:59:28 INFO - PROCESS | 2379 | |1;ext.html;469.7745082360467;520.6303524497606;530.1173546045832;538.6095081066228;559.3902646115733;30838.229044273903;31252.21869453262;32242.35515289693;32251.032469025966;32256.193595160134;33128.840490582836;41434;42711.57288427115;42726.93182670435;45193;9541.33210675253;9704.563294651722;9714.174295184883;9730.124288814006;9749.415035097916;9551.665691700791;9656.80686386272;9659.71020869375;9666.081722236411;9692.079252471003;8626;8793.384463087586;8819.897512810898;8890.822183556325;8898.644054237822;8714.782130446758;11550.480228389742;11730.530778768923;11746.295222286604;12007.93996030023;11656.358900260482;11723.7069073273;11726.296422214695;11742;11751.647450576496;39902;40146.79926600378;40153.39769903454;40159.7992010041;40222;3398.1334759636384;3483.8432270547887;3511.315293517765;3969.384745364473;3994.0613955720382;31261.531077033636;32353.676463235537;32564.67435325664;32648.183795405068;33044.17389565256;3250.5611742414944;3265.951010734841;3267.8529466174077;3305.190228394059;3345.9498107528407;508378;512895;513344;515235;523012.769872304;60858;61069.694651527345;61148;61209;61345.07982380268;31205.531917021264;33993.150171245914;34112.14719631979;34510.30979380399;36488;16136.919315403347;16298.26657800378;16332.510024699279;16337.509874703777;16367.754483682755;12510.937445312715;12604.747905041848;12610.936945315214;12618.81071783924;12620.62138135839;18889;19001.42995710131;19002.904985474983;19004.90497547531;19013.80986190148;6369.5222858285815;7154.960836161669;7322.414206863438;8029.197080291924;8170.346372290202;900.3877363392955;968.4721826604517;973.73709098543;1016.4003238089563;1077.6012875236213;30030.84984575107;30110.849445752632;30232.848835756122;30651;30651.8467407666;1011.595361855249;1086.0768346905068;1138.7950168969498;1143.9942800286112;1149.5631659969158;14160.645983850487;15438.691226175413;15880.20598970047;15963.882528223145;16242.593935151715;652744;657754;661063;662426;662777;52114;59582.70208648929;60157.79684406375;60390.39609603935;61667.69166154141;1161.9128565357632;1386.5493714542813;1420.1053336398004;1420.1195258939524;1420.69455067159;30648;31709.36581268408;31807.04578862638;32207.194820129684;32238.35523289568;44185.558144418144;52189.69525761886;52682.73658631682;52698.73650631875;52721.47278527165;582931;586136;647858;664741;669476.6526167338;42310.153796924504;42750.57249427466;42773.14453710971;43316.13367732691;43394.78302608467;46615.53384466112;46864.53135468602;47265.7636711828;47382.52617473781;47654.52345476501;31861.36277274488;36659.083522911074;37770;38007.619923800405;39343.40984885172;27886;38333.23333533258;38895.805520972215;40465.1906961865;41629.95925101897;38268.61731382651;38914.02714932036;39136.608633913296;39508.80245598868;39653.405198921464;33416.832915835264;34429.82785086059;35445.93662190138;35542.933711988684;35546;22494.662580060984;25394.619080714172;25987.960481580525;25991.480170396866;26451.735482644926 05:59:28 INFO - PROCESS | 2379 | |2;jquery.html;327.80659410947544;350.3448551209239;350.54954383617047;365.5923645135675;398.852424602897;15590.610234744137;17798.64402711945;20591.691124633104;20685.276015339467;20825;20143.489238307113;20364;20614.17543298266;21165.788342116575;21334.35996920095;5923.081922302029;5926.407359264072;6111.816645500619;6182.1345011698395;6190.84522886927;5918.88162236755;6088.939110608903;6111.724972376253;6118.663473508956;6126.6017708849;4115.732477388975;6368.235811702602;6699.73201071959;6707.832304192385;6719.764808231713;6446.806595802133;6637;6688.264290927994;6730.932690673079;6757.628330441824;4847.394075740533;5708.257926469532;5753.223314852483;5755.68343741094;5757.395473475309;25855.35361615956;26055.827487763097;26072;26175.214743557724;26405.3398665033;2231.7991380775647;2267.30847091637;2401.591729406005;2425.1390756281617;3039.5592639067213;15206.239688015665;15381.461648842349;15505.302261398152;15961.563459288604;16038.75941860873;1682.2075354910912;1839.8436132928716;1886.9716954245698;1925.3357591630865;1948.1038722187811;103709;104132.47933760358;104478;107241.46379268132;108250;10333.121684656739;10344.172466202686;10347.637832675971;10463.372197668165;10667.87987261342;13184.143030702973;13186.868131318755;13197.076204665582;13217.273049982343;13225.933870330588;8309.335253179732;8474.491530508189;8512.531810750344;8552.40133190683;8570.228679418882;8486.40595158333;8526.147385261549;8666.480011199348;8708.651653933772;8725.563721813884;6363.968180159162;6506.577072490273;6521.706523206467;6534;6534.411902928664;1774.6184570317444;1811.6467288878541;1812.6465339258982;1814.383109742694;1821.6265665538533;864.1617630898019;929.0941332201049;945.9310978594144;972.8881178664402;992.6029588164791;21203.575928481652;22731.204407845646;22797.772022279896;22844;22927.88536057309;899.321012635456;937.639008981547;943.3585162089845;944.4852555357347;979.1041197304387;10829.512671929782;11722.413879306001;11965.28208307487;12028.819567706492;12039.277643341427;502355;517268;588507;600425;603350;42243.788781056515;115024.27463588053;118588;118935;127776;998.9001099889953;1008.6721815410021;1021.1932573267185;1022.1209759606584;1022.1669339488293;17524.649507009533;18939.71590426117;19331.130099145852;19881.30415435453;20009.499762506053;40700;50337.99324013572;52268;53538.73230633822;54867.17699234435;69765.65117174585;70798.64600676963;71375;72727.63636181786;72782.63608681923;7765.456418050682;7949.205079492004;8010.319122874621;8068;8278.089410164757;13133.934330328288;13184.208947463183;13387.665308367368;13528.053036287365;13734.93132534331;11266.985971262626;11297.71755706081;11356.886431135583;11556.306621602394;11608.535658573563;11115.777684446428;11241.100711942861;11332.206745527734;11531.88468115308;11651.30092194471;9254.444733316022;10807.645739465324;11181.04961078285;11503.597374091867;11693.356865372487;7488.652042632379;7494.362979146834;7877.645505952131;8085.555294458626;8137.75586732399;8236.382271329554;10514.684559463229;11055.281406708538;11427.428628568705;11472.254303470248 05:59:28 INFO - PROCESS | 2379 | |3;mootools.html;1332.347149896551;1339.6182088104888;1537.292845291166;1708.7693161423203;1908.4560900143463;7596.9620151899235;8098.757037288883;8464.407491475598;8536.871946920786;8636.654533818639;7405.925940740591;8548.14518548145;8602.569871506415;8609.655613775458;8628.91371086289;2325.976740232593;2351.5061837014246;2352.800011998982;2359;2359.634256690216;1859.5630026943657;2292.6446400807818;2341.426350544119;2346.800521955627;2351.8118550516;2286.3369622809364;2307.9192228272013;2317.6755254264417;2346.3312955807596;2346.533416614616;2292.7707229277107;2316.5714342846545;2320.234322673514;2320.477892474188;2330.510592775502;1941.213808407597;2319.7332306784765;2323.070771691337;2323.8605683658866;2332.918347857817;8562.70030548934;8616.224539791387;8685.956570217108;8687.695930642398;8699.565021748951;5059.254557177768;5085.059264036166;5256.500632439912;5256.8685782855355;5270.183121616155;3529.2412131391875;3613.2050948791225;3613.8915832525067;3621.6921561667027;3621.6921561667027;1068.8931106889327;1082.4858192358645;1098.8461615373853;1100.2298391126164;1110.9833352499718;11301.095912326995;11434.142439317084;11442.599509017144;11465.828012579817;11475.483603237873;4396.032872767986;4436.0462500562535;4510.503844577094;4569.565891240327;4575.359449677047;8979.05719899401;8997.820043599091;9014.414063085878;9019.052999434965;9046.81906361869;5121.027004869063;5131.794728210904;5132.717700526507;5133.4609865964285;5133.845984620468;4016.2971479990883;4324.891877703082;4325.091730736518;4767.356406885096;4771.427428708577;3502.774029089798;3514.61339252682;3744.737868349244;3780.584135745066;3852.9422058669143;1144.5250221158126;1144.8397224388593;1147.4090843215752;1160.1727279534766;1161.0653423993765;873.4235404633039;916.9174774270348;924.3991405586422;936.0452338614575;941.5574679900436;5788.668606220593;5925.229720136441;6004.579679422399;6041.5468839837185;6164.4760195383;880.4937161132375;887.415962506922;889.6485888074175;898.81574277273;952.2762700347786;3506.3141474658914;3851.5185601799776;4042.9281113422953;4072.144849581621;4160.521540022936;9973.551190196313;10215;10452.961672473946;10455.268131230892;10497.2127090467;9838.212942964688;10366.792664146675;10427.635032773967;10525.26323157387;10534.157267418741;7683.423743219169;8092.554909479917;8108.594570271581;8111.878321825177;8113.18868113184;5825.097109947965;5826.854328641818;5974.492168165754;5981.431763982415;6040.305364883095;9700.5149742514;9721.368111072758;9750.707478775648;9751.51242437861;9784.119429251401;9061.77345566366;9411.058894110534;9507.904920950701;9830.066143716336;9836.704898853046;7209.206987231505;7344;7400.592967386845;7416.7774966751085;7539.660715267936;7936.127026027017;7956.2043795619975;8033.477823941659;8136.267735903797;8157.796055098433;7273.163586187656;7360;7366.079240094989;7384.076990376203;7555.168931417649;7147.606881621561;7163.3552980232025;7203.819904502429;7225.494215404871;7232.204457509775;6865.622390768555;6881.862362752817;6894.689738961659;6918.861622767416;6983.720651173896;4885.95114048855;4923.286123512143;4944.579710724484;4949.232868905326;4953.281774142657;4876.902461950812;4891.26631005352;5001.449840517613;5005.924911126263;5138.152204886152 05:59:28 INFO - PROCESS | 2379 | |4;prototype.html;266.23324824505426;300.0937169747363;309.3426468753898;315.78999965023263;317.8140787639231;4492.505824359322;5172.6379153459275;5435.293411856463;5501.724913754307;5515.034868897947;3891;4725.432948046231;4973.825916092937;5004.799808007684;5182.378114626241;4091.529474110471;4092.5088989321325;4104.384342348641;4105.199486100211;4105.4252404663375;3562.8396722147436;3961.722679412428;4110.979445102786;4124;4129.359949207877;3921.6274453926976;3935.330993731073;4036.1725846201607;4052.5744796796353;4092.4475195848627;3742.981285093584;3859.2372436874102;4086.346184610478;4121.093359460929;4147.6889233307475;2942.602748628929;3529.205928666055;3539.2480722042496;3567.3222087803492;3574.874879379235;4964.826231081895;5227.137522308814;5233.450487698813;5262.500062494057;5382.596305277119;4653.674242803005;4669.486356500816;4693.225617773063;4703.553162449562;4724.5747882690375;5616.410276920946;5621.4659607337235;5624.971875140598;5625.324961004706;5636.718164091779;3559.7784005475087;3598.776416018566;3672.706183505313;3944.9940265232467;4007.458993035932;5177.948220517785;5357.901630165807;5847.2983242010805;5948.757926929834;5995.591036106512;3850.210706805098;3867.207222519377;3870.477485539416;3876.0813397368483;3882.378819388884;3938.4836837817647;3938.5273767148124;3939.6362182690154;3961.8613348532663;3976.6421022108148;3593;4334.349847522897;4558;4579.839705610288;4664.440267167962;4651.395318608559;4834.709917404896;5348.465153484698;5545.390007099216;5620.5503559715125;1322.6891680455085;1323.589687196972;1351.223046748104;1351.3851197705021;1351.9729605407838;832.8251067275819;840.2437805974672;874.4272501511393;888.1473785166183;903.8824952756099;5160.09698302803;5172.482751724872;5177.275181474596;5180.585553155738;5251.2123181523075;4889.657723959289;5648.361975027196;5774.831525784483;5812.331581868055;5841.7371218295275;4528.320751887178;4541.182587134282;4836.903261934812;5094.821681241138;5144.485551444825;2896.652401711766;2991.416673748598;2997.9207485305274;3000.4599172149224;3019.433481540673;4912.8280510182685;5498.780048798083;5902.970485147547;5911.408859114054;5951.7619295227705;5718.085106382959;5853.356130825606;5910.739441896715;5946.910796338058;5955.612885162451;5178.844634660966;5283.101872681654;5389.110796718497;5844.912326315109;5893.675847828411;5320.893582128413;5653.632513886584;5706.572007099401;5805.82582522525;5840.649561026352;4537.319402089713;4911.10244955478;5030.522100400456;5605.663660180402;5769.509591684754;4610.4785420810385;5688.175214593944;5955.40445955401;5973.700125451645;5992.221011268507;3388.457846744509;3489.4875689503515;3572.946405803967;3820.961790382172;3821.560520540062;4847.279215878453;5825.70871456417;5849.94150058494;5855.2973643163095;5862.296524417097;4961.50384961501;5696.376532688164;5717.742701578356;5723.8855222896145;5734.971325143348;5373.6414740787;5564.080392264662;5569.526590239875;5582.888342233051;5620.578456615852;5216.269722238813;5430.294061771944;5436.336195264213;5467;5547.916781248366;4708.410374294193;5451.727413629382;5626.718664066699;5639.618293518114;5657.236273103243;5266.8419947401635;5443.829576641041;5550.861228469159;5553.527950124285;5555.694436805853 05:59:28 INFO - PROCESS | 2379 | |5;yui.html;723.8081908294303;736.9373603243721;785.3952456608412;837.1712005114938;839.542449365096;15082.3212955417;16588.66822663549;16615.91692041541;16637.168141592916;16684.916575417123;15072.924635376809;15109.77335339968;15136.394544218245;15161.696766064671;15161.92419037906;702.2100137345486;722.4689852958072;856.4818284937601;866.2463656618751;886.4681191285242;862.4997501449144;880.6433394475216;880.6565439478609;881.2905610983156;883.1345281624012;923.4920793563547;924.5423515359906;926.865604487349;927.5223260021095;929.1962452478625;736.5507040705165;903.8779764731743;920.5351297594739;922.5433410461831;934.1779234273796;692.2558249881347;693.2547511425238;693.3828892285869;693.9444844412435;694.0214297840022;14675.412983480648;14692.70614587713;14714.632134196623;14720.926395367955;14734.410623575044;14054.508092216724;14237.64405889861;14339;14418.639534011629;14527.273636318141;11831.467583958656;13195.802062969064;13198.934005329911;13567.457301708018;13623.591292261248;3694;4556.111558246143;4682.578567928903;4769.093872164312;4775.594074503671;95565;95590;96429.517852411;97297.51351243198;98807.50596247044;11017;11120.888791112147;11288.379139147262;11309.208355415041;11890.989265912322;21703.891480542497;21996.560068798535;22076.2273320433;22110;22110.77889221087;8224.38317126206;8349.582520873932;8515.063343032261;8525.701600443954;8525.914740852511;4526;4560.315952607136;4595.5800282759;4719.882002949885;4736.550027747358;3478.8782392616135;3526.647335266453;3620.637936206358;3620.9637903621156;3630.6006339302658;638.47644931156;640.1198352265635;640.5388120553195;661.5104822431366;665.411111166621;488.47976904596493;518.7172990720067;529.4467281690643;547.9123340265538;591.133988706547;7465.962670186615;7617.885731714029;8344.577373991673;9204.401713888576;9313.813723725487;616.5437576193584;628.5568674084851;637.3180696654535;638.86903184847;642.0786171843326;4338.254980316712;4458.35353873693;4508.436445444319;4533.727976321431;4565.977170114194;143759.12481750306;156100;159552;165714;166424.16787915982;130147.69852301356;140432;142174.2891285537;143723;148234;67651.66174169097;76527.4694506118;110449;112758;125151;9014.639414423349;9227.723168304961;9337.206337461392;9457.33798634089;9589.089036541518;49156.771080723265;52180.73909630428;64320.713585727084;65053;67158.32841671717;86640;93429;96781;97850;101416.98583014075;12742.42659080325;13315.201087934754;13349.399277032362;13461.730765384833;13786.241756703477;14455.13269203851;14523.636909077357;14646.41414343457;14651.706965860836;14926.253687315808;13408.463661453823;13583.32083395846;13818.930905345409;13826;13827;12785.306081704677;12944.093913426346;13371.331433428095;13381.464741410624;13447;12702;13182.340882956005;13486.190828550318;13499.865001350254;13586.388612512263;10886.074683651977;10888;10950.178736594946;10955.397453140155;10982.395968221825;10233.385996840214;10544.736381590521;11160.162987775788;11195.048420884315;11206.943965280447 05:59:28 INFO - PROCESS | 2379 | __end_tp_report 05:59:28 INFO - PROCESS | 2379 | __start_cc_report 05:59:28 INFO - PROCESS | 2379 | _x_x_mozilla_cycle_collect,1255 05:59:28 INFO - PROCESS | 2379 | __end_cc_report 05:59:28 INFO - PROCESS | 2379 | __startTimestamp1470488368507__endTimestamp 05:59:28 INFO - PROCESS | 2379 | 05:59:28 INFO - PROCESS | 2379 | ------- Summary: start ------- 05:59:28 INFO - PROCESS | 2379 | Number of tests: 6 05:59:28 INFO - PROCESS | 2379 | 05:59:28 INFO - PROCESS | 2379 | [#0] dojo.html Cycles:165 Average:5713.10 Median:5913.76 stddev:651.87 (11.0%) stddev-sans-first:626.75 05:59:28 INFO - PROCESS | 2379 | Values: 3341.3 3365.7 3377.4 3377.5 3384.9 5587.7 5655.3 5656.8 5749.4 5765.3 4815.8 5563.2 5671.1 5807.8 5809.9 5088.5 5115.1 5144.4 5179.6 5281.6 5302.3 5309.4 5364.9 5369.9 5373.0 4646.5 5142.7 5198.3 5240.6 5272.3 5181.4 5229.4 5235.9 5239.4 5253.1 5155.7 5182.2 5193.1 5214.4 5217.6 5715.1 5717.7 5729.5 5741.3 5746.2 6112.4 6112.8 6152.6 6191.1 6199.1 6178.6 6184.8 6243.4 6250.3 6270.8 5131.1 5892.9 5904.4 5913.8 5944.5 6163.6 6198.9 6212.8 6216.5 6228.4 5155.5 6164.7 6207.1 6209.7 6210.6 6092.3 6240.2 6241.8 6242.0 6260.2 6119.7 6142.1 6144.2 6186.4 6238.4 6198.7 6221.1 6226.1 6243.9 6249.1 4232.5 4982.6 4983.9 4985.4 4996.3 4306.0 4346.4 4412.9 4444.5 4503.1 5699.6 5701.3 5706.0 5727.7 5733.5 6230.5 6246.0 6272.2 6272.7 6299.8 5616.3 5713.3 5727.8 5733.3 5839.6 5463.1 5464.8 5469.9 5471.4 5481.0 6292.8 6321.7 6342.7 6350.1 6359.5 6109.3 6167.2 6178.4 6239.9 6276.3 6271.5 6278.8 6280.2 6297.7 6316.8 6148.4 6186.8 6188.6 6202.6 6208.2 6107.1 6130.1 6183.9 6208.8 6262.0 6070.8 6073.7 6083.6 6099.4 6121.5 5994.7 6029.9 6084.7 6085.4 6097.8 5778.9 5866.6 5888.9 5928.1 5994.5 4417.0 6023.7 6045.4 6057.3 6059.7 5873.6 5890.0 5892.6 5900.3 5923.4 05:59:28 INFO - PROCESS | 2379 | 05:59:28 INFO - PROCESS | 2379 | [#1] ext.html Cycles:180 Average:72572.54 Median:38300.93 stddev:161930.75 (422.8%) stddev-sans-first:162294.51 05:59:28 INFO - PROCESS | 2379 | Values: 469.8 520.6 530.1 538.6 559.4 30838.2 31252.2 32242.4 32251.0 32256.2 33128.8 41434.0 42711.6 42726.9 45193.0 9541.3 9704.6 9714.2 9730.1 9749.4 9551.7 9656.8 9659.7 9666.1 9692.1 8626.0 8793.4 8819.9 8890.8 8898.6 8714.8 11550.5 11730.5 11746.3 12007.9 11656.4 11723.7 11726.3 11742.0 11751.6 39902.0 40146.8 40153.4 40159.8 40222.0 3398.1 3483.8 3511.3 3969.4 3994.1 31261.5 32353.7 32564.7 32648.2 33044.2 3250.6 3266.0 3267.9 3305.2 3345.9 508378.0 512895.0 513344.0 515235.0 523012.8 60858.0 61069.7 61148.0 61209.0 61345.1 31205.5 33993.2 34112.1 34510.3 36488.0 16136.9 16298.3 16332.5 16337.5 16367.8 12510.9 12604.7 12610.9 12618.8 12620.6 18889.0 19001.4 19002.9 19004.9 19013.8 6369.5 7155.0 7322.4 8029.2 8170.3 900.4 968.5 973.7 1016.4 1077.6 30030.8 30110.8 30232.8 30651.0 30651.8 1011.6 1086.1 1138.8 1144.0 1149.6 14160.6 15438.7 15880.2 15963.9 16242.6 652744.0 657754.0 661063.0 662426.0 662777.0 52114.0 59582.7 60157.8 60390.4 61667.7 1161.9 1386.5 1420.1 1420.1 1420.7 30648.0 31709.4 31807.0 32207.2 32238.4 44185.6 52189.7 52682.7 52698.7 52721.5 582931.0 586136.0 647858.0 664741.0 669476.7 42310.2 42750.6 42773.1 43316.1 43394.8 46615.5 46864.5 47265.8 47382.5 47654.5 31861.4 36659.1 37770.0 38007.6 39343.4 27886.0 38333.2 38895.8 40465.2 41630.0 38268.6 38914.0 39136.6 39508.8 39653.4 33416.8 34429.8 35445.9 35542.9 35546.0 22494.7 25394.6 25988.0 25991.5 26451.7 05:59:28 INFO - PROCESS | 2379 | 05:59:28 INFO - PROCESS | 2379 | [#2] jquery.html Cycles:180 Average:33048.50 Median:25955.59 stddev:93620.35 (360.7%) stddev-sans-first:93850.74 05:59:28 INFO - PROCESS | 2379 | Values: 327.8 350.3 350.5 365.6 398.9 15590.6 17798.6 20591.7 20685.3 20825.0 20143.5 20364.0 20614.2 21165.8 21334.4 5923.1 5926.4 6111.8 6182.1 6190.8 5918.9 6088.9 6111.7 6118.7 6126.6 4115.7 6368.2 6699.7 6707.8 6719.8 6446.8 6637.0 6688.3 6730.9 6757.6 4847.4 5708.3 5753.2 5755.7 5757.4 25855.4 26055.8 26072.0 26175.2 26405.3 2231.8 2267.3 2401.6 2425.1 3039.6 15206.2 15381.5 15505.3 15961.6 16038.8 1682.2 1839.8 1887.0 1925.3 1948.1 103709.0 104132.5 104478.0 107241.5 108250.0 10333.1 10344.2 10347.6 10463.4 10667.9 13184.1 13186.9 13197.1 13217.3 13225.9 8309.3 8474.5 8512.5 8552.4 8570.2 8486.4 8526.1 8666.5 8708.7 8725.6 6364.0 6506.6 6521.7 6534.0 6534.4 1774.6 1811.6 1812.6 1814.4 1821.6 864.2 929.1 945.9 972.9 992.6 21203.6 22731.2 22797.8 22844.0 22927.9 899.3 937.6 943.4 944.5 979.1 10829.5 11722.4 11965.3 12028.8 12039.3 502355.0 517268.0 588507.0 600425.0 603350.0 42243.8 115024.3 118588.0 118935.0 127776.0 998.9 1008.7 1021.2 1022.1 1022.2 17524.6 18939.7 19331.1 19881.3 20009.5 40700.0 50338.0 52268.0 53538.7 54867.2 69765.7 70798.6 71375.0 72727.6 72782.6 7765.5 7949.2 8010.3 8068.0 8278.1 13133.9 13184.2 13387.7 13528.1 13734.9 11267.0 11297.7 11356.9 11556.3 11608.5 11115.8 11241.1 11332.2 11531.9 11651.3 9254.4 10807.6 11181.0 11503.6 11693.4 7488.7 7494.4 7877.6 8085.6 8137.8 8236.4 10514.7 11055.3 11427.4 11472.3 05:59:28 INFO - PROCESS | 2379 | 05:59:28 INFO - PROCESS | 2379 | [#3] mootools.html Cycles:180 Average:5554.74 Median:5132.26 stddev:3080.74 (60.0%) stddev-sans-first:3073.04 05:59:28 INFO - PROCESS | 2379 | Values: 1332.3 1339.6 1537.3 1708.8 1908.5 7597.0 8098.8 8464.4 8536.9 8636.7 7405.9 8548.1 8602.6 8609.7 8628.9 2326.0 2351.5 2352.8 2359.0 2359.6 1859.6 2292.6 2341.4 2346.8 2351.8 2286.3 2307.9 2317.7 2346.3 2346.5 2292.8 2316.6 2320.2 2320.5 2330.5 1941.2 2319.7 2323.1 2323.9 2332.9 8562.7 8616.2 8686.0 8687.7 8699.6 5059.3 5085.1 5256.5 5256.9 5270.2 3529.2 3613.2 3613.9 3621.7 3621.7 1068.9 1082.5 1098.8 1100.2 1111.0 11301.1 11434.1 11442.6 11465.8 11475.5 4396.0 4436.0 4510.5 4569.6 4575.4 8979.1 8997.8 9014.4 9019.1 9046.8 5121.0 5131.8 5132.7 5133.5 5133.8 4016.3 4324.9 4325.1 4767.4 4771.4 3502.8 3514.6 3744.7 3780.6 3852.9 1144.5 1144.8 1147.4 1160.2 1161.1 873.4 916.9 924.4 936.0 941.6 5788.7 5925.2 6004.6 6041.5 6164.5 880.5 887.4 889.6 898.8 952.3 3506.3 3851.5 4042.9 4072.1 4160.5 9973.6 10215.0 10453.0 10455.3 10497.2 9838.2 10366.8 10427.6 10525.3 10534.2 7683.4 8092.6 8108.6 8111.9 8113.2 5825.1 5826.9 5974.5 5981.4 6040.3 9700.5 9721.4 9750.7 9751.5 9784.1 9061.8 9411.1 9507.9 9830.1 9836.7 7209.2 7344.0 7400.6 7416.8 7539.7 7936.1 7956.2 8033.5 8136.3 8157.8 7273.2 7360.0 7366.1 7384.1 7555.2 7147.6 7163.4 7203.8 7225.5 7232.2 6865.6 6881.9 6894.7 6918.9 6983.7 4886.0 4923.3 4944.6 4949.2 4953.3 4876.9 4891.3 5001.4 5005.9 5138.2 05:59:28 INFO - PROCESS | 2379 | 05:59:28 INFO - PROCESS | 2379 | [#4] prototype.html Cycles:180 Average:4530.61 Median:5119.65 stddev:1389.59 (27.1%) stddev-sans-first:1356.13 05:59:28 INFO - PROCESS | 2379 | Values: 266.2 300.1 309.3 315.8 317.8 4492.5 5172.6 5435.3 5501.7 5515.0 3891.0 4725.4 4973.8 5004.8 5182.4 4091.5 4092.5 4104.4 4105.2 4105.4 3562.8 3961.7 4111.0 4124.0 4129.4 3921.6 3935.3 4036.2 4052.6 4092.4 3743.0 3859.2 4086.3 4121.1 4147.7 2942.6 3529.2 3539.2 3567.3 3574.9 4964.8 5227.1 5233.5 5262.5 5382.6 4653.7 4669.5 4693.2 4703.6 4724.6 5616.4 5621.5 5625.0 5625.3 5636.7 3559.8 3598.8 3672.7 3945.0 4007.5 5177.9 5357.9 5847.3 5948.8 5995.6 3850.2 3867.2 3870.5 3876.1 3882.4 3938.5 3938.5 3939.6 3961.9 3976.6 3593.0 4334.3 4558.0 4579.8 4664.4 4651.4 4834.7 5348.5 5545.4 5620.6 1322.7 1323.6 1351.2 1351.4 1352.0 832.8 840.2 874.4 888.1 903.9 5160.1 5172.5 5177.3 5180.6 5251.2 4889.7 5648.4 5774.8 5812.3 5841.7 4528.3 4541.2 4836.9 5094.8 5144.5 2896.7 2991.4 2997.9 3000.5 3019.4 4912.8 5498.8 5903.0 5911.4 5951.8 5718.1 5853.4 5910.7 5946.9 5955.6 5178.8 5283.1 5389.1 5844.9 5893.7 5320.9 5653.6 5706.6 5805.8 5840.6 4537.3 4911.1 5030.5 5605.7 5769.5 4610.5 5688.2 5955.4 5973.7 5992.2 3388.5 3489.5 3572.9 3821.0 3821.6 4847.3 5825.7 5849.9 5855.3 5862.3 4961.5 5696.4 5717.7 5723.9 5735.0 5373.6 5564.1 5569.5 5582.9 5620.6 5216.3 5430.3 5436.3 5467.0 5547.9 4708.4 5451.7 5626.7 5639.6 5657.2 5266.8 5443.8 5550.9 5553.5 5555.7 05:59:28 INFO - PROCESS | 2379 | 05:59:28 INFO - PROCESS | 2379 | [#5] yui.html Cycles:180 Average:24895.27 Median:4398.30 stddev:40304.08 (916.4%) stddev-sans-first:40376.28 05:59:28 INFO - PROCESS | 2379 | Values: 723.8 736.9 785.4 837.2 839.5 15082.3 16588.7 16615.9 16637.2 16684.9 15072.9 15109.8 15136.4 15161.7 15161.9 702.2 722.5 856.5 866.2 886.5 862.5 880.6 880.7 881.3 883.1 923.5 924.5 926.9 927.5 929.2 736.6 903.9 920.5 922.5 934.2 692.3 693.3 693.4 693.9 694.0 14675.4 14692.7 14714.6 14720.9 14734.4 14054.5 14237.6 14339.0 14418.6 14527.3 11831.5 13195.8 13198.9 13567.5 13623.6 3694.0 4556.1 4682.6 4769.1 4775.6 95565.0 95590.0 96429.5 97297.5 98807.5 11017.0 11120.9 11288.4 11309.2 11891.0 21703.9 21996.6 22076.2 22110.0 22110.8 8224.4 8349.6 8515.1 8525.7 8525.9 4526.0 4560.3 4595.6 4719.9 4736.6 3478.9 3526.6 3620.6 3621.0 3630.6 638.5 640.1 640.5 661.5 665.4 488.5 518.7 529.4 547.9 591.1 7466.0 7617.9 8344.6 9204.4 9313.8 616.5 628.6 637.3 638.9 642.1 4338.3 4458.4 4508.4 4533.7 4566.0 143759.1 156100.0 159552.0 165714.0 166424.2 130147.7 140432.0 142174.3 143723.0 148234.0 67651.7 76527.5 110449.0 112758.0 125151.0 9014.6 9227.7 9337.2 9457.3 9589.1 49156.8 52180.7 64320.7 65053.0 67158.3 86640.0 93429.0 96781.0 97850.0 101417.0 12742.4 13315.2 13349.4 13461.7 13786.2 14455.1 14523.6 14646.4 14651.7 14926.3 13408.5 13583.3 13818.9 13826.0 13827.0 12785.3 12944.1 13371.3 13381.5 13447.0 12702.0 13182.3 13486.2 13499.9 13586.4 10886.1 10888.0 10950.2 10955.4 10982.4 10233.4 10544.7 11160.2 11195.0 11206.9 05:59:28 INFO - PROCESS | 2379 | -------- Summary: end -------- 05:59:28 INFO - PROCESS | 2379 | 05:59:29 INFO - TEST-INFO | 2379: exit 0 05:59:29 INFO - TEST-OK | dromaeo_css | took 1118949ms 05:59:29 INFO - TEST-START | kraken 05:59:29 INFO - operating with platform_type : mac_ 05:59:29 INFO - Initialising browser for kraken test... 05:59:29 INFO - TEST-INFO | started process 2382 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmp1JOYFj/profile http://localhost:53953/getInfo.html) 05:59:31 INFO - PROCESS | 2382 | __metrics Screen width/height:1600/1200 05:59:31 INFO - PROCESS | 2382 | colorDepth:24 05:59:31 INFO - PROCESS | 2382 | Browser inner width/height: 1024/689 05:59:31 INFO - PROCESS | 2382 | __metrics 05:59:31 INFO - PROCESS | 2382 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:59:31 INFO - PROCESS | 2382 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:32 INFO - TEST-INFO | 2382: exit 0 05:59:32 INFO - Browser initialized. 05:59:32 INFO - Running cycle 1/1 for kraken test... 05:59:32 INFO - TEST-INFO | started process 2384 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmp1JOYFj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:44 INFO - PROCESS | 2384 | RSS: Main: 243437568 05:59:44 INFO - PROCESS | 2384 | 05:59:46 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53953/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:47 INFO - PROCESS | 2384 | RSS: Main: 294170624 05:59:47 INFO - PROCESS | 2384 | 05:59:50 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53953/tests/kraken/driver.html?testName=audio-dft) 05:59:51 INFO - PROCESS | 2384 | RSS: Main: 300740608 05:59:51 INFO - PROCESS | 2384 | 05:59:54 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53953/tests/kraken/driver.html?testName=audio-fft) 05:59:55 INFO - PROCESS | 2384 | RSS: Main: 393940992 05:59:55 INFO - PROCESS | 2384 | 05:59:57 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53953/tests/kraken/driver.html?testName=audio-oscillator) 05:59:57 INFO - PROCESS | 2384 | RSS: Main: 297230336 05:59:57 INFO - PROCESS | 2384 | 06:00:00 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53953/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:00 INFO - PROCESS | 2384 | RSS: Main: 301527040 06:00:00 INFO - PROCESS | 2384 | 06:00:03 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53953/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:04 INFO - PROCESS | 2384 | RSS: Main: 338231296 06:00:04 INFO - PROCESS | 2384 | 06:00:07 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53953/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:07 INFO - PROCESS | 2384 | RSS: Main: 341032960 06:00:07 INFO - PROCESS | 2384 | 06:00:10 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53953/tests/kraken/driver.html?testName=json-parse-financial) 06:00:11 INFO - PROCESS | 2384 | RSS: Main: 339046400 06:00:11 INFO - PROCESS | 2384 | 06:00:12 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53953/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:13 INFO - PROCESS | 2384 | RSS: Main: 316170240 06:00:13 INFO - PROCESS | 2384 | 06:00:15 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53953/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:16 INFO - PROCESS | 2384 | RSS: Main: 318586880 06:00:16 INFO - PROCESS | 2384 | 06:00:18 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53953/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:19 INFO - PROCESS | 2384 | RSS: Main: 320581632 06:00:19 INFO - PROCESS | 2384 | 06:00:21 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:22 INFO - PROCESS | 2384 | RSS: Main: 331640832 06:00:22 INFO - PROCESS | 2384 | 06:00:25 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:00:25 INFO - PROCESS | 2384 | RSS: Main: 332959744 06:00:25 INFO - PROCESS | 2384 | 06:00:27 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:53953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53953/tests/kraken/driver.html?testName=ai-astar) 06:00:28 INFO - PROCESS | 2384 | RSS: Main: 376193024 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | __start_tp_report 06:00:28 INFO - PROCESS | 2384 | _x_x_mozilla_page_load 06:00:28 INFO - PROCESS | 2384 | _x_x_mozilla_page_load_details 06:00:28 INFO - PROCESS | 2384 | |i|pagename|runs| 06:00:28 INFO - PROCESS | 2384 | |0;ai-astar;101;112;112;112;114;114;113;111;112;112 06:00:28 INFO - PROCESS | 2384 | |1;audio-beat-detection;141;111;94;194;137;137;107;128;154;107 06:00:28 INFO - PROCESS | 2384 | |2;audio-dft;184;181;185;184;185;181;181;184;185;185 06:00:28 INFO - PROCESS | 2384 | |3;audio-fft;78;58;58;107;57;56;61;64;82;56 06:00:28 INFO - PROCESS | 2384 | |4;audio-oscillator;86;68;93;70;81;73;131;101;97;102 06:00:28 INFO - PROCESS | 2384 | |5;imaging-gaussian-blur;92;104;117;125;86;84;88;85;87;84 06:00:28 INFO - PROCESS | 2384 | |6;imaging-darkroom;93;127;151;106;94;95;94;95;93;94 06:00:28 INFO - PROCESS | 2384 | |7;imaging-desaturate;84;86;84;86;83;84;84;84;86;91 06:00:28 INFO - PROCESS | 2384 | |8;json-parse-financial;55;56;54;56;55;53;52;52;52;53 06:00:28 INFO - PROCESS | 2384 | |9;json-stringify-tinderbox;92;78;70;76;81;76;74;72;71;71 06:00:28 INFO - PROCESS | 2384 | |10;stanford-crypto-aes;83;87;83;86;84;82;92;104;109;103 06:00:28 INFO - PROCESS | 2384 | |11;stanford-crypto-ccm;139;137;135;136;155;151;133;134;159;126 06:00:28 INFO - PROCESS | 2384 | |12;stanford-crypto-pbkdf2;166;165;166;165;162;160;165;167;164;168 06:00:28 INFO - PROCESS | 2384 | |13;stanford-crypto-sha256-iterative;68;67;69;83;86;84;65;67;65;67 06:00:28 INFO - PROCESS | 2384 | __end_tp_report 06:00:28 INFO - PROCESS | 2384 | __start_cc_report 06:00:28 INFO - PROCESS | 2384 | _x_x_mozilla_cycle_collect,2075 06:00:28 INFO - PROCESS | 2384 | __end_cc_report 06:00:28 INFO - PROCESS | 2384 | __startTimestamp1470488428029__endTimestamp 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | ------- Summary: start ------- 06:00:28 INFO - PROCESS | 2384 | Number of tests: 14 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:3.74 (3.3%) stddev-sans-first:1.01 06:00:28 INFO - PROCESS | 2384 | Values: 101.0 112.0 112.0 112.0 114.0 114.0 113.0 111.0 112.0 112.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:139.00 stddev:29.06 (20.9%) stddev-sans-first:30.60 06:00:28 INFO - PROCESS | 2384 | Values: 141.0 111.0 94.0 194.0 137.0 137.0 107.0 128.0 154.0 107.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.50 stddev:1.78 (1.0%) stddev-sans-first:1.88 06:00:28 INFO - PROCESS | 2384 | Values: 184.0 181.0 185.0 184.0 185.0 181.0 181.0 184.0 185.0 185.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#3] audio-fft Cycles:10 Average:67.70 Median:59.50 stddev:16.63 (28.0%) stddev-sans-first:17.22 06:00:28 INFO - PROCESS | 2384 | Values: 78.0 58.0 58.0 107.0 57.0 56.0 61.0 64.0 82.0 56.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:77.00 stddev:19.07 (24.8%) stddev-sans-first:20.17 06:00:28 INFO - PROCESS | 2384 | Values: 86.0 68.0 93.0 70.0 81.0 73.0 131.0 101.0 97.0 102.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#5] imaging-gaussian-blur Cycles:10 Average:95.20 Median:85.50 stddev:14.94 (17.5%) stddev-sans-first:15.80 06:00:28 INFO - PROCESS | 2384 | Values: 92.0 104.0 117.0 125.0 86.0 84.0 88.0 85.0 87.0 84.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:94.00 stddev:19.57 (20.8%) stddev-sans-first:20.33 06:00:28 INFO - PROCESS | 2384 | Values: 93.0 127.0 151.0 106.0 94.0 95.0 94.0 95.0 93.0 94.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:2.30 (2.7%) stddev-sans-first:2.40 06:00:28 INFO - PROCESS | 2384 | Values: 84.0 86.0 84.0 86.0 83.0 84.0 84.0 84.0 86.0 91.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.50 stddev:1.62 (3.0%) stddev-sans-first:1.66 06:00:28 INFO - PROCESS | 2384 | Values: 55.0 56.0 54.0 56.0 55.0 53.0 52.0 52.0 52.0 53.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#9] json-stringify-tinderbox Cycles:10 Average:76.10 Median:76.00 stddev:6.59 (8.7%) stddev-sans-first:3.71 06:00:28 INFO - PROCESS | 2384 | Values: 92.0 78.0 70.0 76.0 81.0 76.0 74.0 72.0 71.0 71.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:83.50 stddev:10.20 (12.2%) stddev-sans-first:10.37 06:00:28 INFO - PROCESS | 2384 | Values: 83.0 87.0 83.0 86.0 84.0 82.0 92.0 104.0 109.0 103.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:138.00 stddev:10.73 (7.8%) stddev-sans-first:11.37 06:00:28 INFO - PROCESS | 2384 | Values: 139.0 137.0 135.0 136.0 155.0 151.0 133.0 134.0 159.0 126.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.50 stddev:2.35 (1.4%) stddev-sans-first:2.45 06:00:28 INFO - PROCESS | 2384 | Values: 166.0 165.0 166.0 165.0 162.0 160.0 165.0 167.0 164.0 168.0 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - PROCESS | 2384 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:68.50 stddev:8.56 (12.5%) stddev-sans-first:8.95 06:00:28 INFO - PROCESS | 2384 | Values: 68.0 67.0 69.0 83.0 86.0 84.0 65.0 67.0 65.0 67.0 06:00:28 INFO - PROCESS | 2384 | -------- Summary: end -------- 06:00:28 INFO - PROCESS | 2384 | 06:00:28 INFO - TEST-INFO | 2384: exit 0 06:00:28 INFO - TEST-OK | kraken | took 59711ms 06:00:28 INFO - SUITE-END | took 1178s 06:00:29 INFO - Completed test suite (00:19:38) 06:00:29 INFO - javascript benchmark 06:00:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3341.33173365327, 3365.713914317283, 3377.408953433149, 3377.493375993601, 3384.8815291464803, 5587.692676902769, 5655.321361436633, 5656.7737290508385, 5749.367569567345, 5765.3369862465825, 4815.807367705288, 5563.193336966137, 5671.092625179982, 5807.796727114542, 5809.854753631162, 5088.54203121719, 5115.10485665009, 5144.3826740791155, 5179.637425380225, 5281.551068159192, 5302.3106996090455, 5309.362876454831, 5364.946350536503, 5369.919451208235, 5372.979133964534, 4646.512116227798, 5142.717150556718, 5198.2722418861385, 5240.633155679104, 5272.288241087443, 5181.4041385240425, 5229.424763276036, 5235.869103272411, 5239.423663397023, 5253.08071087562, 5155.74221288934, 5182.222666600002, 5193.091209038404, 5214.374275087014, 5217.608679349026, 5715.114157305624, 5717.685527295997, 5729.4843464088435, 5741.33974592923, 5746.166805813134, 6112.449879510866, 6112.777056696867, 6152.5693201475915, 6191.0713392990965, 6199.070139479069, 6178.567500274982, 6184.84537886552, 6243.43809057187, 6250.281217659982, 6270.78052268173, 5131.076406246837, 5892.852678683024, 5904.439078287556, 5913.763449462016, 5944.494717948936, 6163.568550201443, 6198.938010619926, 6212.81361559154, 6216.471599914058, 6228.408301211378, 5155.484451554815, 6164.660943648053, 6207.131001659771, 6209.720562574695, 6210.565260431817, 6092.329843717188, 6240.188775459252, 6241.843953901098, 6242.032484964838, 6260.217472815898, 6119.654885717031, 6142.140100385949, 6144.2488890665945, 6186.443220110122, 6238.407351301619, 6198.659073750897, 6221.09794079865, 6226.128342032119, 6243.937560624427, 6249.0938813871735, 4232.492100947844, 4982.576480999083, 4983.9252411213865, 4985.401751789808, 4996.325496057985, 4306.0, 4346.413234213404, 4412.911741765147, 4444.533324000998, 4503.054358584668, 5699.629524080921, 5701.258836351248, 5706.0, 5727.656340619576, 5733.455321744427, 6230.470410015199, 6246.000639897595, 6272.153259310026, 6272.717727702265, 6299.811005669837, 5616.326040875121, 5713.342965558931, 5727.799527016535, 5733.254676892061, 5839.620424672383, 5463.125899856004, 5464.754086066137, 5469.890602188014, 5471.37079235893, 5481.0, 6292.811215663537, 6321.747130114928, 6342.714577843916, 6350.079238510482, 6359.459445947146, 6109.266887973472, 6167.198264225802, 6178.443940045418, 6239.875202496016, 6276.309605943434, 6271.4669253114, 6278.8430289241305, 6280.214973128359, 6297.685115744286, 6316.778912738032, 6148.354422785543, 6186.752529898934, 6188.597741146811, 6202.5658203925295, 6208.192934918432, 6107.097787096225, 6130.080487926668, 6183.938160618516, 6208.782692605737, 6262.0, 6070.817875463743, 6073.696315184135, 6083.64640113197, 6099.400579571985, 6121.47967422774, 5994.67029313392, 6029.939700602938, 6084.665343406155, 6085.361037091042, 6097.7865774697675, 5778.855528611818, 5866.5893387462465, 5888.941110588839, 5928.140419639214, 5994.520438365008, 4417.0, 6023.698815059141, 6045.425684559959, 6057.273127224761, 6059.666718330534, 5873.618214816023, 5890.028145355968, 5892.587518873637, 5900.321463031806, 5923.378045305353], "value": 5672.365341471039, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.7745082360467, 520.6303524497606, 530.1173546045832, 538.6095081066228, 559.3902646115733, 30838.229044273903, 31252.21869453262, 32242.35515289693, 32251.032469025966, 32256.193595160134, 33128.840490582836, 41434.0, 42711.57288427115, 42726.93182670435, 45193.0, 9541.33210675253, 9704.563294651722, 9714.174295184883, 9730.124288814006, 9749.415035097916, 9551.665691700791, 9656.80686386272, 9659.71020869375, 9666.081722236411, 9692.079252471003, 8626.0, 8793.384463087586, 8819.897512810898, 8890.822183556325, 8898.644054237822, 8714.782130446758, 11550.480228389742, 11730.530778768923, 11746.295222286604, 12007.93996030023, 11656.358900260482, 11723.7069073273, 11726.296422214695, 11742.0, 11751.647450576496, 39902.0, 40146.79926600378, 40153.39769903454, 40159.7992010041, 40222.0, 3398.1334759636384, 3483.8432270547887, 3511.315293517765, 3969.384745364473, 3994.0613955720382, 31261.531077033636, 32353.676463235537, 32564.67435325664, 32648.183795405068, 33044.17389565256, 3250.5611742414944, 3265.951010734841, 3267.8529466174077, 3305.190228394059, 3345.9498107528407, 508378.0, 512895.0, 513344.0, 515235.0, 523012.769872304, 60858.0, 61069.694651527345, 61148.0, 61209.0, 61345.07982380268, 31205.531917021264, 33993.150171245914, 34112.14719631979, 34510.30979380399, 36488.0, 16136.919315403347, 16298.26657800378, 16332.510024699279, 16337.509874703777, 16367.754483682755, 12510.937445312715, 12604.747905041848, 12610.936945315214, 12618.81071783924, 12620.62138135839, 18889.0, 19001.42995710131, 19002.904985474983, 19004.90497547531, 19013.80986190148, 6369.5222858285815, 7154.960836161669, 7322.414206863438, 8029.197080291924, 8170.346372290202, 900.3877363392955, 968.4721826604517, 973.73709098543, 1016.4003238089563, 1077.6012875236213, 30030.84984575107, 30110.849445752632, 30232.848835756122, 30651.0, 30651.8467407666, 1011.595361855249, 1086.0768346905068, 1138.7950168969498, 1143.9942800286112, 1149.5631659969158, 14160.645983850487, 15438.691226175413, 15880.20598970047, 15963.882528223145, 16242.593935151715, 652744.0, 657754.0, 661063.0, 662426.0, 662777.0, 52114.0, 59582.70208648929, 60157.79684406375, 60390.39609603935, 61667.69166154141, 1161.9128565357632, 1386.5493714542813, 1420.1053336398004, 1420.1195258939524, 1420.69455067159, 30648.0, 31709.36581268408, 31807.04578862638, 32207.194820129684, 32238.35523289568, 44185.558144418144, 52189.69525761886, 52682.73658631682, 52698.73650631875, 52721.47278527165, 582931.0, 586136.0, 647858.0, 664741.0, 669476.6526167338, 42310.153796924504, 42750.57249427466, 42773.14453710971, 43316.13367732691, 43394.78302608467, 46615.53384466112, 46864.53135468602, 47265.7636711828, 47382.52617473781, 47654.52345476501, 31861.36277274488, 36659.083522911074, 37770.0, 38007.619923800405, 39343.40984885172, 27886.0, 38333.23333533258, 38895.805520972215, 40465.1906961865, 41629.95925101897, 38268.61731382651, 38914.02714932036, 39136.608633913296, 39508.80245598868, 39653.405198921464, 33416.832915835264, 34429.82785086059, 35445.93662190138, 35542.933711988684, 35546.0, 22494.662580060984, 25394.619080714172, 25987.960481580525, 25991.480170396866, 26451.735482644926], "value": 20179.07031071339, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.80659410947544, 350.3448551209239, 350.54954383617047, 365.5923645135675, 398.852424602897, 15590.610234744137, 17798.64402711945, 20591.691124633104, 20685.276015339467, 20825.0, 20143.489238307113, 20364.0, 20614.17543298266, 21165.788342116575, 21334.35996920095, 5923.081922302029, 5926.407359264072, 6111.816645500619, 6182.1345011698395, 6190.84522886927, 5918.88162236755, 6088.939110608903, 6111.724972376253, 6118.663473508956, 6126.6017708849, 4115.732477388975, 6368.235811702602, 6699.73201071959, 6707.832304192385, 6719.764808231713, 6446.806595802133, 6637.0, 6688.264290927994, 6730.932690673079, 6757.628330441824, 4847.394075740533, 5708.257926469532, 5753.223314852483, 5755.68343741094, 5757.395473475309, 25855.35361615956, 26055.827487763097, 26072.0, 26175.214743557724, 26405.3398665033, 2231.7991380775647, 2267.30847091637, 2401.591729406005, 2425.1390756281617, 3039.5592639067213, 15206.239688015665, 15381.461648842349, 15505.302261398152, 15961.563459288604, 16038.75941860873, 1682.2075354910912, 1839.8436132928716, 1886.9716954245698, 1925.3357591630865, 1948.1038722187811, 103709.0, 104132.47933760358, 104478.0, 107241.46379268132, 108250.0, 10333.121684656739, 10344.172466202686, 10347.637832675971, 10463.372197668165, 10667.87987261342, 13184.143030702973, 13186.868131318755, 13197.076204665582, 13217.273049982343, 13225.933870330588, 8309.335253179732, 8474.491530508189, 8512.531810750344, 8552.40133190683, 8570.228679418882, 8486.40595158333, 8526.147385261549, 8666.480011199348, 8708.651653933772, 8725.563721813884, 6363.968180159162, 6506.577072490273, 6521.706523206467, 6534.0, 6534.411902928664, 1774.6184570317444, 1811.6467288878541, 1812.6465339258982, 1814.383109742694, 1821.6265665538533, 864.1617630898019, 929.0941332201049, 945.9310978594144, 972.8881178664402, 992.6029588164791, 21203.575928481652, 22731.204407845646, 22797.772022279896, 22844.0, 22927.88536057309, 899.321012635456, 937.639008981547, 943.3585162089845, 944.4852555357347, 979.1041197304387, 10829.512671929782, 11722.413879306001, 11965.28208307487, 12028.819567706492, 12039.277643341427, 502355.0, 517268.0, 588507.0, 600425.0, 603350.0, 42243.788781056515, 115024.27463588053, 118588.0, 118935.0, 127776.0, 998.9001099889953, 1008.6721815410021, 1021.1932573267185, 1022.1209759606584, 1022.1669339488293, 17524.649507009533, 18939.71590426117, 19331.130099145852, 19881.30415435453, 20009.499762506053, 40700.0, 50337.99324013572, 52268.0, 53538.73230633822, 54867.17699234435, 69765.65117174585, 70798.64600676963, 71375.0, 72727.63636181786, 72782.63608681923, 7765.456418050682, 7949.205079492004, 8010.319122874621, 8068.0, 8278.089410164757, 13133.934330328288, 13184.208947463183, 13387.665308367368, 13528.053036287365, 13734.93132534331, 11266.985971262626, 11297.71755706081, 11356.886431135583, 11556.306621602394, 11608.535658573563, 11115.777684446428, 11241.100711942861, 11332.206745527734, 11531.88468115308, 11651.30092194471, 9254.444733316022, 10807.645739465324, 11181.04961078285, 11503.597374091867, 11693.356865372487, 7488.652042632379, 7494.362979146834, 7877.645505952131, 8085.555294458626, 8137.75586732399, 8236.382271329554, 10514.684559463229, 11055.281406708538, 11427.428628568705, 11472.254303470248], "value": 9699.953887193315, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.347149896551, 1339.6182088104888, 1537.292845291166, 1708.7693161423203, 1908.4560900143463, 7596.9620151899235, 8098.757037288883, 8464.407491475598, 8536.871946920786, 8636.654533818639, 7405.925940740591, 8548.14518548145, 8602.569871506415, 8609.655613775458, 8628.91371086289, 2325.976740232593, 2351.5061837014246, 2352.800011998982, 2359.0, 2359.634256690216, 1859.5630026943657, 2292.6446400807818, 2341.426350544119, 2346.800521955627, 2351.8118550516, 2286.3369622809364, 2307.9192228272013, 2317.6755254264417, 2346.3312955807596, 2346.533416614616, 2292.7707229277107, 2316.5714342846545, 2320.234322673514, 2320.477892474188, 2330.510592775502, 1941.213808407597, 2319.7332306784765, 2323.070771691337, 2323.8605683658866, 2332.918347857817, 8562.70030548934, 8616.224539791387, 8685.956570217108, 8687.695930642398, 8699.565021748951, 5059.254557177768, 5085.059264036166, 5256.500632439912, 5256.8685782855355, 5270.183121616155, 3529.2412131391875, 3613.2050948791225, 3613.8915832525067, 3621.6921561667027, 3621.6921561667027, 1068.8931106889327, 1082.4858192358645, 1098.8461615373853, 1100.2298391126164, 1110.9833352499718, 11301.095912326995, 11434.142439317084, 11442.599509017144, 11465.828012579817, 11475.483603237873, 4396.032872767986, 4436.0462500562535, 4510.503844577094, 4569.565891240327, 4575.359449677047, 8979.05719899401, 8997.820043599091, 9014.414063085878, 9019.052999434965, 9046.81906361869, 5121.027004869063, 5131.794728210904, 5132.717700526507, 5133.4609865964285, 5133.845984620468, 4016.2971479990883, 4324.891877703082, 4325.091730736518, 4767.356406885096, 4771.427428708577, 3502.774029089798, 3514.61339252682, 3744.737868349244, 3780.584135745066, 3852.9422058669143, 1144.5250221158126, 1144.8397224388593, 1147.4090843215752, 1160.1727279534766, 1161.0653423993765, 873.4235404633039, 916.9174774270348, 924.3991405586422, 936.0452338614575, 941.5574679900436, 5788.668606220593, 5925.229720136441, 6004.579679422399, 6041.5468839837185, 6164.4760195383, 880.4937161132375, 887.415962506922, 889.6485888074175, 898.81574277273, 952.2762700347786, 3506.3141474658914, 3851.5185601799776, 4042.9281113422953, 4072.144849581621, 4160.521540022936, 9973.551190196313, 10215.0, 10452.961672473946, 10455.268131230892, 10497.2127090467, 9838.212942964688, 10366.792664146675, 10427.635032773967, 10525.26323157387, 10534.157267418741, 7683.423743219169, 8092.554909479917, 8108.594570271581, 8111.878321825177, 8113.18868113184, 5825.097109947965, 5826.854328641818, 5974.492168165754, 5981.431763982415, 6040.305364883095, 9700.5149742514, 9721.368111072758, 9750.707478775648, 9751.51242437861, 9784.119429251401, 9061.77345566366, 9411.058894110534, 9507.904920950701, 9830.066143716336, 9836.704898853046, 7209.206987231505, 7344.0, 7400.592967386845, 7416.7774966751085, 7539.660715267936, 7936.127026027017, 7956.2043795619975, 8033.477823941659, 8136.267735903797, 8157.796055098433, 7273.163586187656, 7360.0, 7366.079240094989, 7384.076990376203, 7555.168931417649, 7147.606881621561, 7163.3552980232025, 7203.819904502429, 7225.494215404871, 7232.204457509775, 6865.622390768555, 6881.862362752817, 6894.689738961659, 6918.861622767416, 6983.720651173896, 4885.95114048855, 4923.286123512143, 4944.579710724484, 4949.232868905326, 4953.281774142657, 4876.902461950812, 4891.26631005352, 5001.449840517613, 5005.924911126263, 5138.152204886152], "value": 4474.448680575303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.23324824505426, 300.0937169747363, 309.3426468753898, 315.78999965023263, 317.8140787639231, 4492.505824359322, 5172.6379153459275, 5435.293411856463, 5501.724913754307, 5515.034868897947, 3891.0, 4725.432948046231, 4973.825916092937, 5004.799808007684, 5182.378114626241, 4091.529474110471, 4092.5088989321325, 4104.384342348641, 4105.199486100211, 4105.4252404663375, 3562.8396722147436, 3961.722679412428, 4110.979445102786, 4124.0, 4129.359949207877, 3921.6274453926976, 3935.330993731073, 4036.1725846201607, 4052.5744796796353, 4092.4475195848627, 3742.981285093584, 3859.2372436874102, 4086.346184610478, 4121.093359460929, 4147.6889233307475, 2942.602748628929, 3529.205928666055, 3539.2480722042496, 3567.3222087803492, 3574.874879379235, 4964.826231081895, 5227.137522308814, 5233.450487698813, 5262.500062494057, 5382.596305277119, 4653.674242803005, 4669.486356500816, 4693.225617773063, 4703.553162449562, 4724.5747882690375, 5616.410276920946, 5621.4659607337235, 5624.971875140598, 5625.324961004706, 5636.718164091779, 3559.7784005475087, 3598.776416018566, 3672.706183505313, 3944.9940265232467, 4007.458993035932, 5177.948220517785, 5357.901630165807, 5847.2983242010805, 5948.757926929834, 5995.591036106512, 3850.210706805098, 3867.207222519377, 3870.477485539416, 3876.0813397368483, 3882.378819388884, 3938.4836837817647, 3938.5273767148124, 3939.6362182690154, 3961.8613348532663, 3976.6421022108148, 3593.0, 4334.349847522897, 4558.0, 4579.839705610288, 4664.440267167962, 4651.395318608559, 4834.709917404896, 5348.465153484698, 5545.390007099216, 5620.5503559715125, 1322.6891680455085, 1323.589687196972, 1351.223046748104, 1351.3851197705021, 1351.9729605407838, 832.8251067275819, 840.2437805974672, 874.4272501511393, 888.1473785166183, 903.8824952756099, 5160.09698302803, 5172.482751724872, 5177.275181474596, 5180.585553155738, 5251.2123181523075, 4889.657723959289, 5648.361975027196, 5774.831525784483, 5812.331581868055, 5841.7371218295275, 4528.320751887178, 4541.182587134282, 4836.903261934812, 5094.821681241138, 5144.485551444825, 2896.652401711766, 2991.416673748598, 2997.9207485305274, 3000.4599172149224, 3019.433481540673, 4912.8280510182685, 5498.780048798083, 5902.970485147547, 5911.408859114054, 5951.7619295227705, 5718.085106382959, 5853.356130825606, 5910.739441896715, 5946.910796338058, 5955.612885162451, 5178.844634660966, 5283.101872681654, 5389.110796718497, 5844.912326315109, 5893.675847828411, 5320.893582128413, 5653.632513886584, 5706.572007099401, 5805.82582522525, 5840.649561026352, 4537.319402089713, 4911.10244955478, 5030.522100400456, 5605.663660180402, 5769.509591684754, 4610.4785420810385, 5688.175214593944, 5955.40445955401, 5973.700125451645, 5992.221011268507, 3388.457846744509, 3489.4875689503515, 3572.946405803967, 3820.961790382172, 3821.560520540062, 4847.279215878453, 5825.70871456417, 5849.94150058494, 5855.2973643163095, 5862.296524417097, 4961.50384961501, 5696.376532688164, 5717.742701578356, 5723.8855222896145, 5734.971325143348, 5373.6414740787, 5564.080392264662, 5569.526590239875, 5582.888342233051, 5620.578456615852, 5216.269722238813, 5430.294061771944, 5436.336195264213, 5467.0, 5547.916781248366, 4708.410374294193, 5451.727413629382, 5626.718664066699, 5639.618293518114, 5657.236273103243, 5266.8419947401635, 5443.829576641041, 5550.861228469159, 5553.527950124285, 5555.694436805853], "value": 4085.7245764138097, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.8081908294303, 736.9373603243721, 785.3952456608412, 837.1712005114938, 839.542449365096, 15082.3212955417, 16588.66822663549, 16615.91692041541, 16637.168141592916, 16684.916575417123, 15072.924635376809, 15109.77335339968, 15136.394544218245, 15161.696766064671, 15161.92419037906, 702.2100137345486, 722.4689852958072, 856.4818284937601, 866.2463656618751, 886.4681191285242, 862.4997501449144, 880.6433394475216, 880.6565439478609, 881.2905610983156, 883.1345281624012, 923.4920793563547, 924.5423515359906, 926.865604487349, 927.5223260021095, 929.1962452478625, 736.5507040705165, 903.8779764731743, 920.5351297594739, 922.5433410461831, 934.1779234273796, 692.2558249881347, 693.2547511425238, 693.3828892285869, 693.9444844412435, 694.0214297840022, 14675.412983480648, 14692.70614587713, 14714.632134196623, 14720.926395367955, 14734.410623575044, 14054.508092216724, 14237.64405889861, 14339.0, 14418.639534011629, 14527.273636318141, 11831.467583958656, 13195.802062969064, 13198.934005329911, 13567.457301708018, 13623.591292261248, 3694.0, 4556.111558246143, 4682.578567928903, 4769.093872164312, 4775.594074503671, 95565.0, 95590.0, 96429.517852411, 97297.51351243198, 98807.50596247044, 11017.0, 11120.888791112147, 11288.379139147262, 11309.208355415041, 11890.989265912322, 21703.891480542497, 21996.560068798535, 22076.2273320433, 22110.0, 22110.77889221087, 8224.38317126206, 8349.582520873932, 8515.063343032261, 8525.701600443954, 8525.914740852511, 4526.0, 4560.315952607136, 4595.5800282759, 4719.882002949885, 4736.550027747358, 3478.8782392616135, 3526.647335266453, 3620.637936206358, 3620.9637903621156, 3630.6006339302658, 638.47644931156, 640.1198352265635, 640.5388120553195, 661.5104822431366, 665.411111166621, 488.47976904596493, 518.7172990720067, 529.4467281690643, 547.9123340265538, 591.133988706547, 7465.962670186615, 7617.885731714029, 8344.577373991673, 9204.401713888576, 9313.813723725487, 616.5437576193584, 628.5568674084851, 637.3180696654535, 638.86903184847, 642.0786171843326, 4338.254980316712, 4458.35353873693, 4508.436445444319, 4533.727976321431, 4565.977170114194, 143759.12481750306, 156100.0, 159552.0, 165714.0, 166424.16787915982, 130147.69852301356, 140432.0, 142174.2891285537, 143723.0, 148234.0, 67651.66174169097, 76527.4694506118, 110449.0, 112758.0, 125151.0, 9014.639414423349, 9227.723168304961, 9337.206337461392, 9457.33798634089, 9589.089036541518, 49156.771080723265, 52180.73909630428, 64320.713585727084, 65053.0, 67158.32841671717, 86640.0, 93429.0, 96781.0, 97850.0, 101416.98583014075, 12742.42659080325, 13315.201087934754, 13349.399277032362, 13461.730765384833, 13786.241756703477, 14455.13269203851, 14523.636909077357, 14646.41414343457, 14651.706965860836, 14926.253687315808, 13408.463661453823, 13583.32083395846, 13818.930905345409, 13826.0, 13827.0, 12785.306081704677, 12944.093913426346, 13371.331433428095, 13381.464741410624, 13447.0, 12702.0, 13182.340882956005, 13486.190828550318, 13499.865001350254, 13586.388612512263, 10886.074683651977, 10888.0, 10950.178736594946, 10955.397453140155, 10982.395968221825, 10233.385996840214, 10544.736381590521, 11160.162987775788, 11195.048420884315, 11206.943965280447], "value": 7863.917723479076, "unit": "score"}], "name": "dromaeo_css", "value": 7365.264916650581, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 112.0, 114.0, 114.0, 113.0, 111.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 94.0, 194.0, 137.0, 137.0, 107.0, 128.0, 154.0, 107.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 185.0, 184.0, 185.0, 181.0, 181.0, 184.0, 185.0, 185.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 58.0, 107.0, 57.0, 56.0, 61.0, 64.0, 82.0, 56.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 68.0, 93.0, 70.0, 81.0, 73.0, 131.0, 101.0, 97.0, 102.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 104.0, 117.0, 125.0, 86.0, 84.0, 88.0, 85.0, 87.0, 84.0], "value": 95.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 127.0, 151.0, 106.0, 94.0, 95.0, 94.0, 95.0, 93.0, 94.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 86.0, 83.0, 84.0, 84.0, 84.0, 86.0, 91.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 56.0, 55.0, 53.0, 52.0, 52.0, 52.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 78.0, 70.0, 76.0, 81.0, 76.0, 74.0, 72.0, 71.0, 71.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 83.0, 86.0, 84.0, 82.0, 92.0, 104.0, 109.0, 103.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 135.0, 136.0, 155.0, 151.0, 133.0, 134.0, 159.0, 126.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 166.0, 165.0, 162.0, 160.0, 165.0, 167.0, 164.0, 168.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 83.0, 86.0, 84.0, 65.0, 67.0, 65.0, 67.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1466.9, "alertThreshold": 2.0}]} 06:00:29 INFO - Return code: 0 06:00:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:00:29 INFO - # TBPL SUCCESS # 06:00:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:00:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:00:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:00:29 INFO - 2016-08-06 06:00:29.347 screenresolution[2388:34632] starting screenresolution argv=screenresolution get 06:00:29 INFO - 2016-08-06 06:00:29.350 screenresolution[2388:34632] Display 0: 1600x1200x32@60 06:00:29 INFO - 2016-08-06 06:00:29.356 screenresolution[2389:34635] starting screenresolution argv=screenresolution list 06:00:29 INFO - Available Modes on Display 0 06:00:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:00:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:00:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:00:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:00:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:00:29 INFO - Intel Iris: 06:00:29 INFO - Chipset Model: Intel Iris 06:00:29 INFO - Type: GPU 06:00:29 INFO - Bus: Built-In 06:00:29 INFO - VRAM (Dynamic, Max): 1536 MB 06:00:29 INFO - Vendor: Intel (0x8086) 06:00:29 INFO - Device ID: 0x0a2e 06:00:29 INFO - Revision ID: 0x0009 06:00:29 INFO - Displays: 06:00:29 INFO - Display: 06:00:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:00:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:00:29 INFO - Display Serial Number: 1600x1200 60 06:00:29 INFO - Main Display: Yes 06:00:29 INFO - Mirror: Off 06:00:29 INFO - Online: Yes 06:00:29 INFO - Rotation: Supported 06:00:29 INFO - Return code: 0 06:00:29 INFO - Running post-action listener: _resource_record_post_action 06:00:29 INFO - [mozharness: 2016-08-06 13:00:29.590060Z] Finished run-tests step (success) 06:00:29 INFO - Running post-run listener: _resource_record_post_run 06:00:29 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 253952; Write bytes: 706480128; Read time: 2; Write time: 2002 06:00:29 INFO - TinderboxPrint: CPU usage
53.4% 06:00:29 INFO - TinderboxPrint: I/O read bytes / time
253,952 / 2 06:00:29 INFO - TinderboxPrint: I/O write bytes / time
706,480,128 / 2,002 06:00:29 INFO - TinderboxPrint: CPU idle
2,265.8 (46.6%) 06:00:29 INFO - TinderboxPrint: CPU system
970.3 (20.0%) 06:00:29 INFO - TinderboxPrint: CPU user
1,621.6 (33.4%) 06:00:29 INFO - TinderboxPrint: Swap in / out
406,331,392 / 0 06:00:29 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389704192; Write bytes: 384624128; Read time: 29204; Write time: 827 06:00:29 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 253952; Write bytes: 296575488; Read time: 2; Write time: 1117 06:00:30 INFO - Running post-run listener: _upload_blobber_files 06:00:30 INFO - Blob upload gear active. 06:00:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:00:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:00:30 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:00:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:00:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:31 INFO - (blobuploader) - INFO - Done attempting. 06:00:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:00:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:00:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:32 INFO - (blobuploader) - INFO - Done attempting. 06:00:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:00:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:00:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:34 INFO - (blobuploader) - INFO - Done attempting. 06:00:34 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:34 INFO - Return code: 0 06:00:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:00:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4147c00da992afbf80a8662647d729b6a50e6437f95e985949b38102d0974f4302d67ba705f29489763c8db43a5b66bc46fc01fa5695b6782cf2a7ffd52963f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6d8734861f852c62420eeb8e0b2dfa61c921badd7346833fed301527f3387e447c1ee50d4ac9c71d92638b50e3e4aa967860e884e26c826f2894e4a665e4114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b65402dae389b02837ef8d2b65475a9fd1ea3ce19a48203fde736f3325f494a37f8d2a624a21a465b76ba1e09790c5afdd5c519ab94f5bdf0e3a6bd4c20d4bca"} 06:00:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:00:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:00:34 INFO - Contents: 06:00:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4147c00da992afbf80a8662647d729b6a50e6437f95e985949b38102d0974f4302d67ba705f29489763c8db43a5b66bc46fc01fa5695b6782cf2a7ffd52963f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6d8734861f852c62420eeb8e0b2dfa61c921badd7346833fed301527f3387e447c1ee50d4ac9c71d92638b50e3e4aa967860e884e26c826f2894e4a665e4114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b65402dae389b02837ef8d2b65475a9fd1ea3ce19a48203fde736f3325f494a37f8d2a624a21a465b76ba1e09790c5afdd5c519ab94f5bdf0e3a6bd4c20d4bca"} 06:00:34 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:34 INFO - Copying logs to upload dir... 06:00:34 INFO - mkdir: /builds/slave/test/build/upload/logs 06:00:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.271461 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-06 06:00:35.268896) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 06:00:35.274957) ========= 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.0qNxYD3cxA/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.jwsoD3b57U/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4147c00da992afbf80a8662647d729b6a50e6437f95e985949b38102d0974f4302d67ba705f29489763c8db43a5b66bc46fc01fa5695b6782cf2a7ffd52963f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6d8734861f852c62420eeb8e0b2dfa61c921badd7346833fed301527f3387e447c1ee50d4ac9c71d92638b50e3e4aa967860e884e26c826f2894e4a665e4114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b65402dae389b02837ef8d2b65475a9fd1ea3ce19a48203fde736f3325f494a37f8d2a624a21a465b76ba1e09790c5afdd5c519ab94f5bdf0e3a6bd4c20d4bca"} build_url:https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/cRpyWGTVQ8GmFRjx2D5hYQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4147c00da992afbf80a8662647d729b6a50e6437f95e985949b38102d0974f4302d67ba705f29489763c8db43a5b66bc46fc01fa5695b6782cf2a7ffd52963f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6d8734861f852c62420eeb8e0b2dfa61c921badd7346833fed301527f3387e447c1ee50d4ac9c71d92638b50e3e4aa967860e884e26c826f2894e4a665e4114", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b65402dae389b02837ef8d2b65475a9fd1ea3ce19a48203fde736f3325f494a37f8d2a624a21a465b76ba1e09790c5afdd5c519ab94f5bdf0e3a6bd4c20d4bca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 06:00:35.308001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:00:35.308317) ========= 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.0qNxYD3cxA/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.jwsoD3b57U/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:00:35.357260) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 06:00:35.357587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 06:00:35.357896) ========= ========= Total master_lag: 0.52 =========