builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0178 starttime: 1486675984.27 results: success (0) buildid: 20170209111620 builduid: 768dbab09dd4472cac5b98b521fd69de revision: cbfc87ea5508b744abc2e2909cddd01840877236 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:04.268425) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:04.269101) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:04.269489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:04.298782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:04.299424) ========= 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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 --2017-02-09 13:33:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 27.9M=0s 2017-02-09 13:33:04 (27.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.318747 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:04.644047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:04.644438) ========= 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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.028048 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:04.695164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 13:33:04.695527) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cbfc87ea5508b744abc2e2909cddd01840877236 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cbfc87ea5508b744abc2e2909cddd01840877236 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 2017-02-09 13:33:04,793 truncating revision to first 12 chars 2017-02-09 13:33:04,793 Setting DEBUG logging. 2017-02-09 13:33:04,793 attempt 1/10 2017-02-09 13:33:04,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cbfc87ea5508?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 13:33:06,206 unpacking tar archive at: mozilla-beta-cbfc87ea5508/testing/mozharness/ program finished with exit code 0 elapsedTime=1.681161 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 13:33:06.400667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:06.401117) ========= script_repo_revision: cbfc87ea5508b744abc2e2909cddd01840877236 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:06.401528) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:06.401817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 13:33:06.422297) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-02-09 13:33:06.422872) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:33:06 INFO - MultiFileLogger online at 20170209 13:33:06 in /builds/slave/test 13:33:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:33:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:33:06 INFO - {'append_to_log': False, 13:33:06 INFO - 'base_work_dir': '/builds/slave/test', 13:33:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:33:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:33:06 INFO - 'branch': 'Mozilla-Beta', 13:33:06 INFO - 'buildbot_json_path': 'buildprops.json', 13:33:06 INFO - 'config_files': ('talos/mac_config.py',), 13:33:06 INFO - 'default_actions': ('clobber', 13:33:06 INFO - 'read-buildbot-config', 13:33:06 INFO - 'download-and-extract', 13:33:06 INFO - 'populate-webroot', 13:33:06 INFO - 'create-virtualenv', 13:33:06 INFO - 'install', 13:33:06 INFO - 'run-tests'), 13:33:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:33:06 INFO - 'download_minidump_stackwalk': True, 13:33:06 INFO - 'download_symbols': 'ondemand', 13:33:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:33:06 INFO - 'tooltool.py': '/tools/tooltool.py', 13:33:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:33:06 INFO - '/tools/misc-python/virtualenv.py')}, 13:33:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:33:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:33:06 INFO - 'installer_path': 'installer.exe', 13:33:06 INFO - 'log_level': 'info', 13:33:06 INFO - 'log_name': 'talos', 13:33:06 INFO - 'log_to_console': True, 13:33:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:33:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:33:06 INFO - 'opt_config_files': (), 13:33:06 INFO - 'pip_index': False, 13:33:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:33:06 INFO - 'cmd': ('bash', 13:33:06 INFO - '-c', 13:33:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:33:06 INFO - 'enabled': True, 13:33:06 INFO - 'halt_on_failure': False, 13:33:06 INFO - 'name': 'check_screen_resolution'},), 13:33:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:33:06 INFO - 'cmd': ('bash', 13:33:06 INFO - '-c', 13:33:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:33:06 INFO - 'enabled': True, 13:33:06 INFO - 'halt_on_failure': False, 13:33:06 INFO - 'name': 'check_screen_resolution'},), 13:33:06 INFO - 'run_cmd_checks_enabled': True, 13:33:06 INFO - 'sps_profile': False, 13:33:06 INFO - 'sps_profile_interval': 0, 13:33:06 INFO - 'suite': 'dromaeojs-e10s', 13:33:06 INFO - 'system_bits': '32', 13:33:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:33:06 INFO - 'title': 't-yosemite-r7-0178', 13:33:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:33:06 INFO - 'use_talos_json': True, 13:33:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:33:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:33:06 INFO - 'work_dir': 'build'} 13:33:06 INFO - [mozharness: 2017-02-09 21:33:06.641096Z] Running clobber step. 13:33:06 INFO - Running pre-action listener: _resource_record_pre_action 13:33:06 INFO - Running main action method: clobber 13:33:06 INFO - rmtree: /builds/slave/test/build 13:33:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:33:09 INFO - Running post-action listener: _resource_record_post_action 13:33:09 INFO - [mozharness: 2017-02-09 21:33:09.083031Z] Finished clobber step (success) 13:33:09 INFO - [mozharness: 2017-02-09 21:33:09.083197Z] Running read-buildbot-config step. 13:33:09 INFO - Running pre-action listener: _resource_record_pre_action 13:33:09 INFO - Running main action method: read_buildbot_config 13:33:09 INFO - Using buildbot properties: 13:33:09 INFO - { 13:33:09 INFO - "project": "", 13:33:09 INFO - "product": "firefox", 13:33:09 INFO - "script_repo_revision": "production", 13:33:09 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:33:09 INFO - "repository": "", 13:33:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:33:09 INFO - "buildid": "20170209111620", 13:33:09 INFO - "pgo_build": "False", 13:33:09 INFO - "basedir": "/builds/slave/test", 13:33:09 INFO - "buildnumber": 30, 13:33:09 INFO - "slavename": "t-yosemite-r7-0178", 13:33:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:33:09 INFO - "platform": "yosemite_r7", 13:33:09 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:33:09 INFO - "branch": "mozilla-beta", 13:33:09 INFO - "repo_path": "releases/mozilla-beta", 13:33:09 INFO - "revision": "cbfc87ea5508b744abc2e2909cddd01840877236", 13:33:09 INFO - "stage_platform": "macosx64", 13:33:09 INFO - "builduid": "768dbab09dd4472cac5b98b521fd69de", 13:33:09 INFO - "slavebuilddir": "test" 13:33:09 INFO - } 13:33:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 13:33:09 INFO - Running post-action listener: _resource_record_post_action 13:33:09 INFO - [mozharness: 2017-02-09 21:33:09.086554Z] Finished read-buildbot-config step (success) 13:33:09 INFO - [mozharness: 2017-02-09 21:33:09.086692Z] Running download-and-extract step. 13:33:09 INFO - Running pre-action listener: _resource_record_pre_action 13:33:09 INFO - Running main action method: download_and_extract 13:33:09 INFO - mkdir: /builds/slave/test/build/tests 13:33: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')]} 13:33:09 INFO - trying https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 13:33:09 INFO - Downloading https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:33:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 13:33:10 INFO - Downloaded 1165 bytes. 13:33:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:33:10 INFO - Using the following test package requirements: 13:33:10 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:33:10 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:33:10 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 13:33:10 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:33:10 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 13:33:10 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:33:10 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:33:10 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 13:33:10 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:33:10 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:33:10 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 13:33:10 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:33:10 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 13:33:10 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:33:10 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 13:33:10 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:33:10 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 13:33:10 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 13:33:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:33:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:33:10 INFO - Fetch https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:33:11 INFO - Http code: 200 13:33:11 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 13:33:11 INFO - x-amz-cf-id: 7lkQntyyrd_2xQElJOmdQ4ea_pG4LNOdDCht9FEVNUzJnWBXoExbqg== 13:33:11 INFO - x-amz-version-id: _gdQaNKjurXNFMK_AN6LMMaUbPoxbEFh 13:33:11 INFO - Expected file size: 16093664 13:33:11 INFO - Obtained file size: 16093664 13:33:17 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:33:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:33:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:33:17 INFO - Fetch https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:33:18 INFO - Http code: 200 13:33:18 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 13:33:18 INFO - x-amz-cf-id: TT2o0ZcS8xoOUwWdRJNFg4FnRutqD9RtSE_jWDrFSdkYHg98lbI62g== 13:33:18 INFO - x-amz-version-id: _gdQaNKjurXNFMK_AN6LMMaUbPoxbEFh 13:33:18 INFO - Expected file size: 16093664 13:33:18 INFO - Obtained file size: 16093664 13:33:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 13:33:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 13:33:25 INFO - Fetch https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 13:33:25 INFO - Http code: 200 13:33:25 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 13:33:25 INFO - x-amz-cf-id: zdNUADluW0IebeF5YTeM-7IqvvukrsVs5ehmyAx_KJ0g3XrN9qtvGg== 13:33:25 INFO - x-amz-version-id: jwJ5NlEtz5rh4BNLI3hHznX4gGSKYM9Q 13:33:26 INFO - Expected file size: 14403005 13:33:26 INFO - Obtained file size: 14403005 13:33: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')]} 13:33:26 INFO - trying https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:33:26 INFO - Downloading https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 13:33:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 13:33:28 INFO - Downloaded 82152488 bytes. 13:33:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:33:28 INFO - mkdir: /builds/slave/test/properties 13:33:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:33:28 INFO - Writing to file /builds/slave/test/properties/build_url 13:33:28 INFO - Contents: 13:33:28 INFO - build_url:https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:33:29 INFO - Running post-action listener: _resource_record_post_action 13:33:29 INFO - Running post-action listener: set_extra_try_arguments 13:33:29 INFO - [mozharness: 2017-02-09 21:33:29.570589Z] Finished download-and-extract step (success) 13:33:29 INFO - [mozharness: 2017-02-09 21:33:29.570736Z] Running populate-webroot step. 13:33:29 INFO - Running pre-action listener: _resource_record_pre_action 13:33:29 INFO - Running main action method: populate_webroot 13:33:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:33:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:33:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:33:29 INFO - '--tppagecycles', 13:33:29 INFO - '7'], 13:33:29 INFO - 'tests': ['tsvgm']}}, 13:33:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:33:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:33:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:33:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:33:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:29 INFO - 'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:29 INFO - 'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['damp', 'tps']}, 13:33:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:29 INFO - 'tests': ['damp', 'tps']}, 13:33:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['dromaeo_dom']}, 13:33:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:33:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['basic_compositor_video']}, 13:33:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:33:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['a11yr', 13:33:29 INFO - 'ts_paint', 13:33:29 INFO - 'tpaint', 13:33:29 INFO - 'sessionrestore', 13:33:29 INFO - 'sessionrestore_no_auto_restore', 13:33:29 INFO - 'tabpaint']}, 13:33:29 INFO - 'other-e10s': {'tests': ['a11yr', 13:33:29 INFO - 'ts_paint', 13:33:29 INFO - 'tpaint', 13:33:29 INFO - 'sessionrestore', 13:33:29 INFO - 'sessionrestore_no_auto_restore', 13:33:29 INFO - 'tabpaint']}, 13:33:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:33:29 INFO - 'ts_paint', 13:33:29 INFO - 'tpaint', 13:33:29 INFO - 'sessionrestore', 13:33:29 INFO - 'sessionrestore_no_auto_restore', 13:33:29 INFO - 'tabpaint']}, 13:33:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:33:29 INFO - 'ts_paint', 13:33:29 INFO - 'tpaint', 13:33:29 INFO - 'sessionrestore', 13:33:29 INFO - 'sessionrestore_no_auto_restore', 13:33:29 INFO - 'tabpaint']}, 13:33:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['a11yr', 13:33:29 INFO - 'ts_paint', 13:33:29 INFO - 'tpaint', 13:33:29 INFO - 'sessionrestore', 13:33:29 INFO - 'sessionrestore_no_auto_restore', 13:33:29 INFO - 'tabpaint']}, 13:33:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['a11yr', 13:33:29 INFO - 'ts_paint', 13:33:29 INFO - 'tpaint', 13:33:29 INFO - 'sessionrestore', 13:33:29 INFO - 'sessionrestore_no_auto_restore', 13:33:29 INFO - 'tabpaint']}, 13:33:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['tsvgx', 13:33:29 INFO - 'tsvgr_opacity', 13:33:29 INFO - 'tart', 13:33:29 INFO - 'tscrollx', 13:33:29 INFO - 'cart']}, 13:33:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:33:29 INFO - 'tsvgr_opacity', 13:33:29 INFO - 'tart', 13:33:29 INFO - 'tscrollx', 13:33:29 INFO - 'cart']}, 13:33:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:29 INFO - 'talos_options': ['--disable-e10s'], 13:33:29 INFO - 'tests': ['tp5o']}, 13:33:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:29 INFO - 'tests': ['tp5o']}, 13:33:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:29 INFO - 'talos_options': ['--disable-e10s', 13:33:29 INFO - '--xperf_path', 13:33:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:29 INFO - 'tests': ['tp5n']}, 13:33:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:29 INFO - 'talos_options': ['--xperf_path', 13:33:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:29 INFO - 'tests': ['tp5n']}}, 13:33:29 INFO - 'talos.zip': {'path': '', 13:33:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:33:29 INFO - Running post-action listener: _resource_record_post_action 13:33:29 INFO - [mozharness: 2017-02-09 21:33:29.589510Z] Finished populate-webroot step (success) 13:33:29 INFO - [mozharness: 2017-02-09 21:33:29.589641Z] Running create-virtualenv step. 13:33:29 INFO - Running pre-action listener: _resource_record_pre_action 13:33:29 INFO - Running main action method: create_virtualenv 13:33:29 INFO - Creating virtualenv /builds/slave/test/build/venv 13:33:29 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 13:33:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:33:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:33:29 INFO - Using real prefix '/tools/python27' 13:33:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:33:30 INFO - Installing distribute.............................................................................................................................................................................................done. 13:33:33 INFO - Installing pip.................done. 13:33:33 INFO - Return code: 0 13:33:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:33:33 INFO - Reading from file tmpfile_stdout 13:33:33 INFO - Output received: 13:33:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:33:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:33 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 0x10c757490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb604cf3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, '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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:33:33 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 13:33:33 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 13:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:33 INFO - 'HOME': '/Users/cltbld', 13:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:33 INFO - 'LOGNAME': 'cltbld', 13:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:33 INFO - 'MOZ_NO_REMOTE': '1', 13:33:33 INFO - 'NO_EM_RESTART': '1', 13:33:33 INFO - 'PAGER': '/bin/cat', 13:33:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:33 INFO - 'PWD': '/builds/slave/test', 13:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:33 INFO - 'SHELL': '/bin/bash', 13:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:33:33 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:33 INFO - 'USER': 'cltbld', 13:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:33 INFO - 'XPC_FLAGS': '0x0', 13:33:33 INFO - 'XPC_SERVICE_NAME': '0', 13:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:33 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 13:33:33 INFO - Cleaning up... 13:33:33 INFO - Return code: 0 13:33:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:33 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 0x10c757490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb604cf3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, '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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:33:33 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 13:33:33 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 13:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:33 INFO - 'HOME': '/Users/cltbld', 13:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:33 INFO - 'LOGNAME': 'cltbld', 13:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:33 INFO - 'MOZ_NO_REMOTE': '1', 13:33:33 INFO - 'NO_EM_RESTART': '1', 13:33:33 INFO - 'PAGER': '/bin/cat', 13:33:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:33 INFO - 'PWD': '/builds/slave/test', 13:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:33 INFO - 'SHELL': '/bin/bash', 13:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:33:33 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:33 INFO - 'USER': 'cltbld', 13:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:33 INFO - 'XPC_FLAGS': '0x0', 13:33:33 INFO - 'XPC_SERVICE_NAME': '0', 13:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:34 INFO - Downloading/unpacking psutil>=3.1.1 13:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:33:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:37 INFO - Installing collected packages: psutil 13:33:37 INFO - Running setup.py install for psutil 13:33:37 INFO - building 'psutil._psutil_osx' extension 13:33:37 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 13:33:38 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 13:33:38 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 13:33:38 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 13:33:38 INFO - building 'psutil._psutil_posix' extension 13:33:38 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 13:33:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:33:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:33:38 INFO - ^ 13:33:38 INFO - 1 warning generated. 13:33:38 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 13:33:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:38 INFO - Successfully installed psutil 13:33:38 INFO - Cleaning up... 13:33:38 INFO - Return code: 0 13:33:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c757490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb604cf3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, '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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:38 INFO - 'HOME': '/Users/cltbld', 13:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:38 INFO - 'LOGNAME': 'cltbld', 13:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:38 INFO - 'MOZ_NO_REMOTE': '1', 13:33:38 INFO - 'NO_EM_RESTART': '1', 13:33:38 INFO - 'PAGER': '/bin/cat', 13:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:38 INFO - 'PWD': '/builds/slave/test', 13:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:38 INFO - 'SHELL': '/bin/bash', 13:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:33:38 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:38 INFO - 'USER': 'cltbld', 13:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:38 INFO - 'XPC_FLAGS': '0x0', 13:33:38 INFO - 'XPC_SERVICE_NAME': '0', 13:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:33:39 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 13:33:39 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 13:33:39 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 13:33:39 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 13:33:39 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 13:33:39 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 13:33:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:33:41 INFO - Installing collected packages: mozsystemmonitor 13:33:41 INFO - Running setup.py install for mozsystemmonitor 13:33:41 INFO - Successfully installed mozsystemmonitor 13:33:41 INFO - Cleaning up... 13:33:41 INFO - Return code: 0 13:33:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:41 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 0x10c757490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb604cf3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, '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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:33:41 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 13:33:41 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 13:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:41 INFO - 'HOME': '/Users/cltbld', 13:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:41 INFO - 'LOGNAME': 'cltbld', 13:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:41 INFO - 'MOZ_NO_REMOTE': '1', 13:33:41 INFO - 'NO_EM_RESTART': '1', 13:33:41 INFO - 'PAGER': '/bin/cat', 13:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:41 INFO - 'PWD': '/builds/slave/test', 13:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:41 INFO - 'SHELL': '/bin/bash', 13:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:33:41 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:41 INFO - 'USER': 'cltbld', 13:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:41 INFO - 'XPC_FLAGS': '0x0', 13:33:41 INFO - 'XPC_SERVICE_NAME': '0', 13:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:42 INFO - Downloading/unpacking jsonschema==2.5.1 13:33:42 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 13:33:42 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 13:33:42 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 13:33:42 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 13:33:42 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 13:33:42 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 13:33:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:33:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:33:44 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 13:33:44 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 13:33:44 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 13:33:44 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 13:33:44 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 13:33:44 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 13:33:45 INFO - Downloading functools32-3.2.3-2.tar.gz 13:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:33:45 INFO - warning: no files found matching '*.txt' 13:33:45 INFO - no previously-included directories found matching 'build' 13:33:45 INFO - no previously-included directories found matching 'dist' 13:33:45 INFO - no previously-included directories found matching '.git*' 13:33:45 INFO - Installing collected packages: jsonschema, functools32 13:33:45 INFO - Running setup.py install for functools32 13:33:45 INFO - warning: no files found matching '*.txt' 13:33:45 INFO - no previously-included directories found matching 'build' 13:33:45 INFO - no previously-included directories found matching 'dist' 13:33:45 INFO - no previously-included directories found matching '.git*' 13:33:45 INFO - Successfully installed jsonschema functools32 13:33:45 INFO - Cleaning up... 13:33:45 INFO - Return code: 0 13:33:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:33:45 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')]} 13:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:45 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')]} 13:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:45 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 0x10c757490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb604cf3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, '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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:33:45 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 13:33:45 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 13:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:45 INFO - 'HOME': '/Users/cltbld', 13:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:45 INFO - 'LOGNAME': 'cltbld', 13:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:45 INFO - 'MOZ_NO_REMOTE': '1', 13:33:45 INFO - 'NO_EM_RESTART': '1', 13:33:45 INFO - 'PAGER': '/bin/cat', 13:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:45 INFO - 'PWD': '/builds/slave/test', 13:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:45 INFO - 'SHELL': '/bin/bash', 13:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:33:45 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:45 INFO - 'USER': 'cltbld', 13:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:45 INFO - 'XPC_FLAGS': '0x0', 13:33:45 INFO - 'XPC_SERVICE_NAME': '0', 13:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:33:45 INFO - Cleaning up... 13:33:45 INFO - Return code: 0 13:33:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:33:45 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')]} 13:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:45 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')]} 13:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:45 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 0x10c757490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb604cf3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, '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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:33:45 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 13:33:45 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 13:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:45 INFO - 'HOME': '/Users/cltbld', 13:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:45 INFO - 'LOGNAME': 'cltbld', 13:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:45 INFO - 'MOZ_NO_REMOTE': '1', 13:33:45 INFO - 'NO_EM_RESTART': '1', 13:33:45 INFO - 'PAGER': '/bin/cat', 13:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:45 INFO - 'PWD': '/builds/slave/test', 13:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:45 INFO - 'SHELL': '/bin/bash', 13:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:33:45 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:45 INFO - 'USER': 'cltbld', 13:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:45 INFO - 'XPC_FLAGS': '0x0', 13:33:45 INFO - 'XPC_SERVICE_NAME': '0', 13:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:46 INFO - Downloading/unpacking blobuploader==1.2.4 13:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:48 INFO - Downloading blobuploader-1.2.4.tar.gz 13:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:33:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:33:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:49 INFO - Downloading docopt-0.6.1.tar.gz 13:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:33:49 INFO - Installing collected packages: blobuploader, requests, docopt 13:33:49 INFO - Running setup.py install for blobuploader 13:33:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:33:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:33:50 INFO - Running setup.py install for requests 13:33:50 INFO - Running setup.py install for docopt 13:33:50 INFO - Successfully installed blobuploader requests docopt 13:33:50 INFO - Cleaning up... 13:33:50 INFO - Return code: 0 13:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:50 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 0x10c757490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb604cf3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, '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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:33:50 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 13:33:50 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 13:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:50 INFO - 'HOME': '/Users/cltbld', 13:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:50 INFO - 'LOGNAME': 'cltbld', 13:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:50 INFO - 'MOZ_NO_REMOTE': '1', 13:33:50 INFO - 'NO_EM_RESTART': '1', 13:33:50 INFO - 'PAGER': '/bin/cat', 13:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:50 INFO - 'PWD': '/builds/slave/test', 13:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:50 INFO - 'SHELL': '/bin/bash', 13:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:33:50 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:50 INFO - 'USER': 'cltbld', 13:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:50 INFO - 'XPC_FLAGS': '0x0', 13:33:50 INFO - 'XPC_SERVICE_NAME': '0', 13:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:51 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-HrwQHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:51 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-BUYVO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:51 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-EogXYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:51 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-XCLh4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:51 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-w23RrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:51 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-db9HoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:51 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-xvyMwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:51 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-9j0E3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:51 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-5hVpnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:52 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-hbwqJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:52 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ElYIPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:52 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ijAJG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:52 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-eXRZ6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:52 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-PuhdAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:52 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-vokRk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:52 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-jTuMIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:52 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Xt1O3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:33:52 INFO - Running setup.py install for manifestparser 13:33:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:33:53 INFO - Running setup.py install for mozcrash 13:33:53 INFO - Running setup.py install for mozdebug 13:33:53 INFO - Running setup.py install for mozdevice 13:33:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:33:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:33:53 INFO - Running setup.py install for mozfile 13:33:53 INFO - Running setup.py install for mozhttpd 13:33:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:33:53 INFO - Running setup.py install for mozinfo 13:33:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:33:53 INFO - Running setup.py install for mozInstall 13:33:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:33:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:33:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:33:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:33:54 INFO - Running setup.py install for mozleak 13:33:54 INFO - Running setup.py install for mozlog 13:33:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:33:54 INFO - Running setup.py install for moznetwork 13:33:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:33:54 INFO - Running setup.py install for mozprocess 13:33:54 INFO - Running setup.py install for mozprofile 13:33:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:33:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:33:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:33:54 INFO - Running setup.py install for mozrunner 13:33:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:33:55 INFO - Running setup.py install for mozscreenshot 13:33:55 INFO - Running setup.py install for moztest 13:33:55 INFO - Running setup.py install for mozversion 13:33:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:33:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:33:55 INFO - Cleaning up... 13:33:55 INFO - Return code: 0 13:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:55 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 0x10c757490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb604cf3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, '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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:33:55 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 13:33:55 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 13:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:55 INFO - 'HOME': '/Users/cltbld', 13:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:55 INFO - 'LOGNAME': 'cltbld', 13:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:55 INFO - 'MOZ_NO_REMOTE': '1', 13:33:55 INFO - 'NO_EM_RESTART': '1', 13:33:55 INFO - 'PAGER': '/bin/cat', 13:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:55 INFO - 'PWD': '/builds/slave/test', 13:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:55 INFO - 'SHELL': '/bin/bash', 13:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:33:55 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:55 INFO - 'USER': 'cltbld', 13:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:55 INFO - 'XPC_FLAGS': '0x0', 13:33:55 INFO - 'XPC_SERVICE_NAME': '0', 13:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:55 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-3G7z2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:55 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)) 13:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:55 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-YRsrEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:56 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-6mfxgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:56 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)) 13:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:56 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Dl81vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:56 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)) 13:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:56 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-6fGj3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:56 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)) 13:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:56 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-hoEA4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:56 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)) 13:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:56 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-BaAr48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:56 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)) 13:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:56 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-nbli7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:56 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)) 13:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:56 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Q_SwI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:56 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)) 13:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:56 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-TB6_eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:56 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-e6FgXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:56 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)) 13:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:56 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-wyImJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:57 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)) 13:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-IGlMl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:57 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)) 13:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-s63wHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-NBOoVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:57 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)) 13:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ApZrDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-1kVzE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:57 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)) 13:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:33:57 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)) 13:33:57 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)) 13:33:57 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)) 13:33:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:33:57 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 13:33:57 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 13:33:57 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 13:33:57 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 13:33:57 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 13:33:57 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 13:34:00 INFO - Downloading blessings-1.6.tar.gz 13:34:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:34:00 INFO - Installing collected packages: blessings 13:34:00 INFO - Running setup.py install for blessings 13:34:00 INFO - Successfully installed blessings 13:34:00 INFO - Cleaning up... 13:34:00 INFO - Return code: 0 13:34:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:34:00 INFO - Reading from file tmpfile_stdout 13:34:00 INFO - Current package versions: 13:34:00 INFO - blessings == 1.6 13:34:00 INFO - blobuploader == 1.2.4 13:34:00 INFO - docopt == 0.6.1 13:34:00 INFO - functools32 == 3.2.3-2 13:34:00 INFO - jsonschema == 2.5.1 13:34:00 INFO - manifestparser == 1.1 13:34:00 INFO - mozInstall == 1.12 13:34:00 INFO - mozcrash == 1.0 13:34:00 INFO - mozdebug == 0.1 13:34:00 INFO - mozdevice == 0.48 13:34:00 INFO - mozfile == 1.2 13:34:00 INFO - mozhttpd == 0.7 13:34:00 INFO - mozinfo == 0.9 13:34:00 INFO - mozleak == 0.1 13:34:00 INFO - mozlog == 3.4 13:34:00 INFO - moznetwork == 0.27 13:34:00 INFO - mozprocess == 0.23 13:34:00 INFO - mozprofile == 0.28 13:34:00 INFO - mozrunner == 6.13 13:34:00 INFO - mozscreenshot == 0.1 13:34:00 INFO - mozsystemmonitor == 0.3 13:34:00 INFO - moztest == 0.8 13:34:00 INFO - mozversion == 1.4 13:34:00 INFO - psutil == 3.1.1 13:34:00 INFO - requests == 1.2.3 13:34:00 INFO - wsgiref == 0.1.2 13:34:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:01 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')]} 13:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:01 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 0x10c757490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb604cf3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, '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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:34:01 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 13:34:01 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 13:34:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:34:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:01 INFO - 'HOME': '/Users/cltbld', 13:34:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:01 INFO - 'LOGNAME': 'cltbld', 13:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:01 INFO - 'MOZ_NO_REMOTE': '1', 13:34:01 INFO - 'NO_EM_RESTART': '1', 13:34:01 INFO - 'PAGER': '/bin/cat', 13:34:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:01 INFO - 'PWD': '/builds/slave/test', 13:34:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:01 INFO - 'SHELL': '/bin/bash', 13:34:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:34:01 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:34:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:01 INFO - 'USER': 'cltbld', 13:34:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:01 INFO - 'XPC_FLAGS': '0x0', 13:34:01 INFO - 'XPC_SERVICE_NAME': '0', 13:34:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:01 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)) 13:34:01 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)) 13:34:01 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)) 13:34:01 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)) 13:34:01 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)) 13:34:01 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)) 13:34:01 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)) 13:34:01 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)) 13:34:01 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)) 13:34:01 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)) 13:34:01 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)) 13:34:01 INFO - Cleaning up... 13:34:01 INFO - Return code: 0 13:34:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:34:01 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')]} 13:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:01 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')]} 13:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:02 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 0x10c757490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb604cf3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, '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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 13:34:02 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 13:34:02 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 13:34:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:34:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:02 INFO - 'HOME': '/Users/cltbld', 13:34:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:02 INFO - 'LOGNAME': 'cltbld', 13:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:02 INFO - 'MOZ_NO_REMOTE': '1', 13:34:02 INFO - 'NO_EM_RESTART': '1', 13:34:02 INFO - 'PAGER': '/bin/cat', 13:34:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:02 INFO - 'PWD': '/builds/slave/test', 13:34:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:02 INFO - 'SHELL': '/bin/bash', 13:34:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:34:02 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:34:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:02 INFO - 'USER': 'cltbld', 13:34:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:02 INFO - 'XPC_FLAGS': '0x0', 13:34:02 INFO - 'XPC_SERVICE_NAME': '0', 13:34:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:34:02 INFO - Cleaning up... 13:34:02 INFO - Return code: 0 13:34:02 INFO - Running post-action listener: _resource_record_post_action 13:34:02 INFO - Running post-action listener: _start_resource_monitoring 13:34:02 INFO - Starting resource monitoring. 13:34:02 INFO - [mozharness: 2017-02-09 21:34:02.470109Z] Finished create-virtualenv step (success) 13:34:02 INFO - [mozharness: 2017-02-09 21:34:02.471122Z] Running install step. 13:34:02 INFO - Running pre-action listener: _resource_record_pre_action 13:34:02 INFO - Running main action method: install 13:34:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:34:02 INFO - Reading from file tmpfile_stdout 13:34:02 INFO - Detecting whether we're running mozinstall >=1.0... 13:34:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:34:02 INFO - Reading from file tmpfile_stdout 13:34:02 INFO - Output received: 13:34:02 INFO - Usage: mozinstall [options] installer 13:34:02 INFO - Options: 13:34:02 INFO - -h, --help show this help message and exit 13:34:02 INFO - -d DEST, --destination=DEST 13:34:02 INFO - Directory to install application into. [default: 13:34:02 INFO - "/builds/slave/test"] 13:34:02 INFO - --app=APP Application being installed. [default: firefox] 13:34:02 INFO - mkdir: /builds/slave/test/build/application 13:34:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:34:23 INFO - Reading from file tmpfile_stdout 13:34:23 INFO - Output received: 13:34:23 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:34:23 INFO - Running post-action listener: _resource_record_post_action 13:34:23 INFO - [mozharness: 2017-02-09 21:34:23.966898Z] Finished install step (success) 13:34:23 INFO - [mozharness: 2017-02-09 21:34:23.967008Z] Running run-tests step. 13:34:23 INFO - Running pre-action listener: _resource_record_pre_action 13:34:23 INFO - Running main action method: run_tests 13:34:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:34:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:34:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:34:23 INFO - 2017-02-09 13:34:23.981 screenresolution[1621:7263] starting screenresolution argv=screenresolution get 13:34:23 INFO - 2017-02-09 13:34:23.984 screenresolution[1621:7263] Display 0: 1600x1200x32@60 13:34:23 INFO - 2017-02-09 13:34:23.989 screenresolution[1622:7265] starting screenresolution argv=screenresolution list 13:34:23 INFO - Available Modes on Display 0 13:34:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:34:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:34:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:34:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:34:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:34:24 INFO - Intel Iris: 13:34:24 INFO - Chipset Model: Intel Iris 13:34:24 INFO - Type: GPU 13:34:24 INFO - Bus: Built-In 13:34:24 INFO - VRAM (Dynamic, Max): 1536 MB 13:34:24 INFO - Vendor: Intel (0x8086) 13:34:24 INFO - Device ID: 0x0a2e 13:34:24 INFO - Revision ID: 0x0009 13:34:24 INFO - Displays: 13:34:24 INFO - Display: 13:34:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:34:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:34:24 INFO - Display Serial Number: 1600x1200 60 13:34:24 INFO - Main Display: Yes 13:34:24 INFO - Mirror: Off 13:34:24 INFO - Online: Yes 13:34:24 INFO - Rotation: Supported 13:34:24 INFO - Return code: 0 13:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:34:24 INFO - Python 2.7.3 13:34:24 INFO - Return code: 0 13:34:24 INFO - grabbing minidump binary from tooltool 13:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:24 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 0x10c56bd30>, '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 0x10c3d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c563b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:34:24 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 13:34:24 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 13:34:24 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 13:34:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:34:24 INFO - Return code: 0 13:34:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:34:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:34:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:34:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:34:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:34:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Zkj9mJ8rBS/Render', 13:34:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:24 INFO - 'HOME': '/Users/cltbld', 13:34:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:24 INFO - 'LOGNAME': 'cltbld', 13:34:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:34:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:24 INFO - 'MOZ_NO_REMOTE': '1', 13:34:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:34:24 INFO - 'NO_EM_RESTART': '1', 13:34:24 INFO - 'PAGER': '/bin/cat', 13:34:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:24 INFO - 'PWD': '/builds/slave/test', 13:34:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:34:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:24 INFO - 'SHELL': '/bin/bash', 13:34:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Vh8w5YpQW/Listeners', 13:34:24 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 13:34:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:24 INFO - 'USER': 'cltbld', 13:34:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:24 INFO - 'XPC_FLAGS': '0x0', 13:34:24 INFO - 'XPC_SERVICE_NAME': '0', 13:34:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:34:24 INFO - mozversion application_buildid: 20170209111620 13:34:24 INFO - mozversion application_changeset: cbfc87ea5508b744abc2e2909cddd01840877236 13:34:24 INFO - mozversion application_display_name: Firefox 13:34:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:34:24 INFO - mozversion application_name: Firefox 13:34:24 INFO - mozversion application_remotingname: firefox 13:34:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:34:24 INFO - mozversion application_vendor: Mozilla 13:34:24 INFO - mozversion application_version: 52.0 13:34:24 INFO - mozversion platform_buildid: 20170209111620 13:34:24 INFO - mozversion platform_changeset: cbfc87ea5508b744abc2e2909cddd01840877236 13:34:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:34:24 INFO - mozversion platform_version: 52.0 13:34:24 INFO - using testdate: 1486676064 13:34:24 INFO - actual date: 1486676064 13:34:24 INFO - starting webserver on 'localhost:49243' 13:34:24 INFO - SUITE-START | Running 2 tests 13:34:24 INFO - TEST-START | dromaeo_css 13:34:24 INFO - operating with platform_type : mac_ 13:34:24 INFO - Initialising browser for dromaeo_css test... 13:34:24 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpd0CkYg/profile http://localhost:49243/getInfo.html) 13:34:27 INFO - PROCESS | 1632 | 2017-02-09 13:34:27.429 plugin-container[1635:7440] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d43, name = 'com.apple.tsm.portname' 13:34:27 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:34:27 INFO - PROCESS | 1632 | 2017-02-09 13:34:27.430 plugin-container[1635:7440] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9303, name = 'com.apple.CFPasteboardClient' 13:34:27 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:34:27 INFO - PROCESS | 1632 | 2017-02-09 13:34:27.430 plugin-container[1635:7440] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:34:27 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 13:34:27 INFO - PROCESS | 1632 | colorDepth:24 13:34:27 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 13:34:27 INFO - PROCESS | 1632 | __metrics 13:34:27 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 13:34:28 INFO - TEST-INFO | 1632: exit 0 13:34:28 INFO - Browser initialized. 13:34:28 INFO - Running cycle 1/1 for dromaeo_css test... 13:34:28 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpd0CkYg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:30 INFO - PROCESS | 1636 | 2017-02-09 13:34:30.718 plugin-container[1637:7571] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 13:34:30 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:34:30 INFO - PROCESS | 1636 | 2017-02-09 13:34:30.718 plugin-container[1637:7571] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 13:34:30 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:34:30 INFO - PROCESS | 1636 | 2017-02-09 13:34:30.718 plugin-container[1637:7571] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:34:40 INFO - PROCESS | 1636 | RSS: Main: 177184768 13:34:40 INFO - PROCESS | 1636 | 13:37:41 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 13:37:43 INFO - PROCESS | 1636 | RSS: Main: 182673408 13:37:43 INFO - PROCESS | 1636 | 13:40:45 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 13:40:46 INFO - PROCESS | 1636 | RSS: Main: 191913984 13:40:46 INFO - PROCESS | 1636 | 13:43:48 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 13:43:48 INFO - PROCESS | 1636 | RSS: Main: 198733824 13:43:48 INFO - PROCESS | 1636 | 13:46:50 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 13:46:51 INFO - PROCESS | 1636 | RSS: Main: 201760768 13:46:51 INFO - PROCESS | 1636 | 13:49:54 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 13:49:54 INFO - PROCESS | 1636 | RSS: Main: 203096064 13:49:54 INFO - PROCESS | 1636 | 13:52:57 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 13:52:57 INFO - PROCESS | 1636 | RSS: Main: 203497472 13:52:57 INFO - PROCESS | 1636 | 13:52:57 INFO - PROCESS | 1636 | __start_tp_report 13:52:57 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 13:52:57 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 13:52:57 INFO - PROCESS | 1636 | |i|pagename|runs| 13:52:57 INFO - PROCESS | 1636 | |0;dojo.html;3476.669716376945;3488.0930957950927;3494.598121216061;3506.842192101355;3520.6655367740073;5619.4099619539975;5625.212470254162;5644.491995720385;5673.8297851064435;5688.914666280009;4864.246041863508;5625.6905870177125;5684.27679869685;5744.339400968879;5748;4197.496300443951;5098.031374038939;5115.641905066647;5173.3016042834115;5203.16749320107;4381.737095774264;4690.648201384893;5156.432792392834;5161.071007218699;5206.791728330882;5053.343065401511;5110.029094472057;5163.993021360836;5166.870828229286;5170.043541944733;5117.897642047157;5119;5176.689398636094;5208.817691380784;5256.737163141827;5082.23766435034;5130.384353877521;5136.768845401966;5137.768800403991;5139.306193663845;5509.421510741355;5692.800751973702;5694.003549378884;5798.507126894219;5845.503132233765;6054.424829641177;6105.358937311563;6133.21225245364;6134.130457564626;6245.656488893109;6226;6226.564140510166;6230.626162430223;6231.096491008823;6238.906416403757;5751.309842818889;5756.222909907193;5770.278715160605;5772.278465191851;5833.591648584601;6169.136320915076;6193.349698281706;6221.9377806221355;6225.906611400833;6226.906596401058;6068.878622427526;6096.29892562361;6111.54163437744;6115.785947491905;6142.508599312045;6129.11127886454;6171.643207496286;6178.351273116348;6202.875942481125;6232.407921247474;5979.923613749567;6055.424734650202;6065.484433823174;6115.296740874767;6132.110769107974;6126.578745377165;6149.446549810449;6161.630302181883;6165.260168779775;6170.969145154246;4156.43888075112;4930.679505832181;4940.567235501736;4944.98627781304;4980.477049909779;3613;4363.345498175299;4374.8906277342685;4418.7127836690515;4433.069055498381;5588.273524441878;5703.515201207943;5760.049591817303;5793.507551858139;5806;6182.381761823782;6184.443400094013;6216.420185622916;6223.626582405071;6240.65676387794;5578.776848925998;5669.064604340238;5669.574781891292;5694.829155125353;5727.083666613322;5367.382750983609;5383.138697808332;5386.622936394415;5388.595855310868;5420.566354691615;6274.2784579773;6278.277998030194;6281.874362512633;6310.49516038725;6316.968415157895;6126.785562505291;6150.169727086965;6170.3212646607935;6171.506279497719;6224.221972253468;6294.685265736786;6365.522585806176;6377.87244255103;6381.202349706286;6381.553291269566;5980.820575382745;6104.603200791934;6107.0228763397645;6162.630242185483;6185.969070154621;5925.1704761332585;6128.387161283836;6128.503123582109;6237.8752424950335;6277.96861015692;5940.7920722776225;6033.78881739137;6034.185384972972;6060.636361818305;6064.636121832704;5987.700614969322;6021.969890150521;6022.5784195105925;6027.909581356195;6030.577859549965;5658.745356458887;5712.800051998326;5779.971100144472;5792.160136780228;5843.912341314969;5987.64074155552;6048.455638992512;6054.122152287981;6056.454919057306;6078.756849725962;5868.882622347614;5889.204957330706;5894.616849904743;5921.615095018982;5936.465718085393 13:52:57 INFO - PROCESS | 1636 | |1;ext.html;473.7915317260405;492.8004158315881;510.6272421132573;573.6758731316803;581.1428143488353;37259.25481490369;39669.60330396695;39727.404088938616;39732.205355892904;39809.20381592366;40721.778346649575;40993.79503102488;41393.17213655725;41471.58528414715;41496.75509734705;9450.669226577089;9510.191633711109;9667.516624168798;9669.95165024174;9675.903240967571;9575.808483830318;9685.70942871715;9699.612015519371;9712.757181070494;9753.268504862128;9638.759031024245;9723.902760972405;9779.46212958287;9794.755131121708;9806.411615303105;9672.419654820698;9765.169960553361;9771.804563908752;9785.657501987467;9908.157806586449;9569.856452153223;9608.135267825859;9688.224942004694;9711.61153553857;9718.979507151718;38844;39315.803420983;39731.80134099311;39781.60218397837;39784.20431591381;3197.2646291353117;3308.3052558962645;3353.1281866714585;3378.577677790276;3385.9492107618407;29713;29997.850010750026;30611.69388306133;30693.386132277454;31170.532442013387;3158.921026974321;3251.886183983549;3271.263965607743;3302.1909632140278;3310.784798988058;511958;516881;517948;518697;520536.39731801476;57051;59127.70436147792;59143.70428147832;59207.81584368288;59420;65312;66206;66572.33427665758;66577.66711166414;66583.66708166429;16452.670946581;16966.915165424092;17225.31098756061;17239.22423490946;17249.655006899793;12653.30406827615;12782.744345113231;13078.738425231442;13142.934285328512;13149.21104733719;15754.684906302038;17822.134064635695;18828.15273312704;19193;19306.517337066685;6667.566608170453;6772.627505487246;7882.408819338572;7947.721829735931;8035.83928321442;892.7366426904078;1012;1045.7333379988206;1069.6309773128414;1080.3841810168285;30148.54777178344;30378.78484860625;30437;30495.39009219803;30950.380992380477;908.3006085314403;1077.466654006272;1078.1590359519587;1081.7187531241934;1125.5666568371073;15220.695586088215;15648.765268520981;15700.371985120468;15850.920745396199;16064.919675401548;637395;653162.7341863356;655033;655751;667189;48008.5199148011;58045.41954580485;58143.70928145417;58657.41342586605;58672.41327586755;1390.847006829248;1403.7192561487743;1417.4046900301898;1422.8150340455468;1424.6865689548283;29081.85459072691;29826;29911.700882990892;29918.700812991592;30554.236144096576;49731.254031190285;50131;50549.241761372876;50550.241746373096;50638.24042639437;576554;577222;579238;580498;582176;25489.745102549477;26650.866745666146;26935;26987.190384288504;27079.323016924736;44973;46512;46653.30020049634;46866.53133468758;47430.81422964454;38102.80948595239;38258.80870595629;38494.42258366183;38868.61131388763;39110;37783.81108094442;38314.6168538311;38548.97726591051;39459.81620551388;39568.40647390349;33469.83265083659;34815.78144764921;37981.810090949366;38796.6120338793;38923.2215355697;32222.9055111417;34122.829385852914;34824.303513930085;34976.65023349836;35060.47409288914;22153.77846221517;24814.00743970221;26106.86946565255;26213.80057190535;26368 13:52:57 INFO - PROCESS | 1636 | |2;jquery.html;380.65930991762355;386.2195279760303;387.55818367061545;395.58266029339035;413.32008845449235;19111.331103411383;20277.188912443486;20423.080961356718;20479;20568.177272909103;19294;19978.200871965106;20092.497687557818;20158;20158.697619535684;5704.686242256675;5745.741441635126;5881.323647780496;5936.376680448556;5947.375525569818;5864.208331875207;5869.706514674249;5902.616329938562;5907.822765317026;5987.790427335022;5242.737863106849;5797.391273916221;6102.054181601837;6150.415710507495;6187.35032821554;6063.363346848606;6075.878482430348;6121.479674227696;6129.111278864584;6669.933300666979;5859.29688437386;5908.468237858613;5961.731722072517;5972.462478376923;5986.551008674367;12811.359432028454;20596.176152954013;24011.519769604685;24216.668083255416;24301;2147.600339722175;2231.263682984611;2238.2725614175297;2536.492701459697;2994.446027484922;10037.849432258521;10039.24705647072;10055.296129270953;10447;10539.683809485728;1855.1466325490292;1951.8438524917972;1963.9018049097488;1982.2764690887866;2012.5672980309157;127597.36201318934;131643.6835631641;131956;136580.999999999;138448;9094.226990705733;9533.285003624756;10829.458527073615;11639;11779.998700110587;11876.287422754489;12175.573854915212;14759.631009224855;14801.333939972727;14848.554543363716;5915.881682366328;8499.277561407225;8743.125687431333;8762.342824288204;8789.560521973875;6973.546719463218;8480.703175388831;8602.827943441096;8747.956260218658;8826.823463530693;3488.2500262443696;3608.8736894208578;4162.895927601774;4491.775411229425;4620.514845941195;1956.1686283329527;2010.4672261850621;2014.6272939506239;2016.747906511686;2042.7242322286302;796.4424902568226;891.38494438837;897.537768049455;929.6792606550729;946.3517490519016;19790.901045494968;20240.291589794582;20552.794472055386;20680.793192068188;20834.1666333348;736.5727877830846;799.3006119645311;950.1211379473959;966.1497881863914;1015.5683834370363;9989.850152247722;10527.94736026315;10538.367697938149;10580.41807700584;10590.57637694499;616513;619792;629148;631099;635475;99850.50224246642;122804;129748.3512582431;140936;157795.89918453697;1016.227666973091;1027.1833892055984;1032.200044965158;1057.619257067455;1061.3578784835063;17385;17809.020503872413;18431.26274948987;18471.630567388307;18564.628707426047;55726.72136639291;56106.719466404036;56795.71602141963;57707.26878193661;58850;64947.675261623386;84395.15604843873;86379;86548;87366;6397.936020639921;7901.288884000468;7986.326289906708;8174.959125204336;8205.83588328242;12472.87527124717;12483.438245278803;12517.624471265877;12543.623691289276;12750.68123296925;10748.570057197625;10749.247552671552;10895.836562451728;11082;11163.106951444028;9367.718968430958;10884.782304354027;10909.83635245456;10987.175961802737;11129.610463634059;9492.810143796947;10252.794944100928;10679.839802403125;11071.944640276746;11214;6414.358564143548;7334.486585938933;7830;8161.795955100933;8227.79430514218;6483.4164925156965;9200.35597508168;9202.401843880127;10315.638952636622;11290.15323850698 13:52:57 INFO - PROCESS | 1636 | |3;mootools.html;1362.611655678132;1510.9395624175033;1670.1315316035661;1792.6235490546985;1830.432565904569;7633.923660763391;7887.250711182429;8149.185081491848;8628.266597339218;8645.13548645136;8114.310283625884;8363.247307742302;8372.079071302167;8533.018702849175;8539.103394143604;2359.1978727232736;2371.300466362419;2387.1883559589737;2389.9761002390014;2399.0883464283634;2380.6905102336673;2414.4326083370393;2416.734159242482;2429.186222615426;2452.9632055519182;2377.512609914972;2377.8692171930625;2401.519696060786;2402.1712509184304;2409.3856066703056;2329.650552417151;2355.0462062864567;2366.8698221597806;2377.524495100978;2390.6653068570413;1987.3541099142838;2373.311739595515;2376.7979721723673;2381.1903952656007;2401.4836810085917;8390.958045209734;8552.27305679018;8553.914460855436;8555.016173140044;8562.957185214096;5144.974275128638;5305;5309.787608495655;5312.1766126250495;5369.114096174127;3504.737144714157;3557.875474358411;3561.305545418644;3584.9103772405897;3589.964100358989;1047.0942634621;1054.6045233037612;1076.5424694504804;1083.5557421457243;1084.5173897615564;11124.332540047622;11144.777104457946;11148;11153.442327883573;11195.160362972729;4525.253333199985;4683.1336202802595;4762.857114286577;4762.999770048329;4834.129856625841;9430.669926552675;9570;9590.808183836285;9633.662821801203;9657.082577155159;5248.6588371755715;5296.417394086648;5301.310829592128;5310.097283461821;5336.439673834269;4370.759608221579;4387.802548885308;4827.25177597473;4871.0014447038275;4901.995091006335;3335.6831101045364;3875.748076375083;3890.1636148228267;3961.5246170459154;3990.7605543667473;1267.9492820287085;1283.5250957145915;1286.0740267007739;1297.3124244150426;1297.5199176304639;852.2840813716508;904.0707859790137;926.6756635177634;926.837803384405;957.5068839547639;5730.828075157752;5852.268466441695;5924.170616113747;5955.910661340084;6145.84635384119;908.836409446306;945.2154711589365;952.7903861150675;959.6737109382843;962.225408546113;3262.771605987558;3718.5909549949483;3884.6309600587897;3911.041794760245;3948.1511475033008;8590.613422396007;9988.750281243027;10047.346922450017;10191.388516689023;10257;9971;10031.247656425798;10031.398116113056;10042.748931276776;10079.596816127272;7644.159142494321;7977.840443191104;8024.277814996678;8132.064812546633;8152.470089444286;5698.572607054404;5758.913616295675;5761.876434095311;5780.537556995346;5851;9537.570809313736;9639.421634701941;9686.128248457673;9691.612335506501;9696.5151742414;9255.120763527455;9498.19265362452;9518.571664274985;9542.952285238529;9622.51887405641;7322;7332.560046397233;7357.963210183915;7413.703451861865;7418.146913105062;8004.399670024888;8066.596670166351;8088.514689118671;8090.919090809017;8121.4721043132;7216.278372162742;7338.596377199306;7397.927300541283;7465.850682986418;7485.588292643739;7114.253003434772;7226.566406015656;7230.240824713329;7235.384992275715;7275.818104547428;6740.528163028541;6865.347791959756;6877.346652068046;6908.205556361083;6912.654367281515;4898.044881248123;4914.0908931847725;5024.472430394756;5055.7219352935945;5120.923186152137;4825.10735513917;4877.878053048702;4993.3259010034635;5035.697858128524;5114.539691427789 13:52:57 INFO - PROCESS | 1636 | |4;prototype.html;275.34055936033195;313.87288148299945;322.9370272796805;326.7484037291287;328.35969858775394;5329.866753331169;5467.906418716253;5480.479354461325;5573.8885222295585;5608.467195616415;5305.761240744167;5425.647332923357;5454.672719636815;5482.314710661168;5485.6982865942455;3887.436321733347;4238.321868501041;4246.426732391134;4246.596573325544;4267.551907049746;3395.864165433392;3505.7370697197684;3894.559013165133;4254.553271906451;4260.3822445745345;3563.8752643657476;3572.8034958077296;4108.876733697994;4131.545529991714;4133.689973252003;3874.5350557932948;4103.4710149271605;4114.238865809834;4136.214119317335;4154.771487568182;3237.14215732831;3331.433656278414;3433.759636825423;3605.8737944171826;3640.381135207021;4772.785224664898;4904.803807847682;4997.525235102659;5336.585804761741;5409.486098820645;4745.623769106955;4751.835800228966;4754.524547545252;4775.164346239394;4778.4982576829625;5720.628159169641;5743.282089738783;5752.884942301131;5780.913286300709;5792.507636850873;3671.7429779915415;3812.5234345706785;3833.578306386323;4008.378701301303;4076.7757773322455;4942.948676299331;5409.350877894639;6088.4215999479975;6096.464050850541;6139.907901381483;4140.254754144223;4166.375043743402;4173.372384769881;4175.707700460938;4184.539700632928;3920.255151521259;4130.112025914443;4178.931428942693;4184.225918205142;4217.219814334297;4789.928151077736;4801;4816.638752093537;4817.542333478314;4827.08285425768;4622.445306563234;5427.43011983744;5428.5385742211565;5738.540916726652;5789.247397838254;1341.8591047940022;1370.3011464153153;1387.5559820857432;1389.8957578181678;1393.7282229965263;769.7760560708389;809.9595020248964;844.4173520270994;856.5845564901018;958.8561715742694;4518.661100417482;4601.447826260804;4666.370040044619;5007.119482401168;5132.07471741104;4728.645351598644;5134.813838023623;5177.689338639693;5229.241759944863;5507.703990887115;4335.349697545394;4466.754328511963;4666.813327466931;4893.510648935078;5098;2574.575195092826;2828.8076740526258;2874.856257187132;2931.9267018324713;2934.8532573371244;5078.273387048422;5347.786088556492;5662.85842853932;5804.4775970162045;5828.795992140254;5405.889019225786;5688.724510195872;5689.857753556194;5699.857503562444;5716.657000579895;5771.68255745938;5780.364159942403;5798.9420105799245;5806.44838740319;5823.854403639943;4534.299637635887;5533.5849811263515;5541.473560011793;5565.1095824667855;5580.396173157243;4800.807967681254;5203.5576975955955;5234.607404444758;5473.808416705556;5520.62613076381;5511.972440137773;5778.306603207642;5791.13133030032;5820.534357251495;5823.223916705276;3643.872464463837;3902.2975864343557;3904.902377440587;3932.8230229640308;3954.525456945185;4497.482789479121;4772.570468657698;4892.730899800546;5022.347094877789;5849.181114643869;4696.426697056524;5881.823545293648;5905.372109411271;5911.497522710618;5936.376680448663;5414.29614150158;5851.297844258546;5874.295084589877;5887.852803679943;5896.262967129109;4786.521347865325;5549.778008879761;5722.998475266895;5747.913781293368;5751.626144300774;5839.708014599338;5873.324567674772;5874.676892770939;5876.41235876409;5931.021381472009;5473.781048758005;5734.480362703804;5748.6550806950045;5777.591221179524;5793.507551858139 13:52:57 INFO - PROCESS | 1636 | |5;yui.html;676.24936320684;709.6380845768658;718.877790775568;721.476929226311;738.7045181927232;14529.636759081028;14866.628334291621;15263.618409539738;15383.69232615347;15446.382144714213;13724.656883577916;13726.656833579165;13845.238511881842;13856.307184640778;13866.168029918186;825.8389614025283;840.197611281228;843.3674743942044;843.7468759372194;845.9830803383928;691.7855464805901;701.6000879498688;828.3331917806164;835.4026870787416;838.4969018588858;885.5970533407317;886.5212785096072;887.183790912359;890.5458216309664;891.4027601506973;872.9039805621377;880.9824652526343;882.8170251862502;886.3529623374908;895.2569367425021;652.3900153356627;655.1908393134476;655.3053763011176;656.3403779201919;657.1293036726308;13970.231637259947;14095.436182552685;14163.929180354135;14177.574672759834;14229.28853557318;13170.661031090547;13418.329083545783;13463;13536.729265414735;14157.929210353985;11573.710657233552;11636.883631163664;11728.589499367481;11804.173707840455;11902.58340958071;3720.1815600567834;3720.6093360197333;3752.2683076800035;3752.831122599462;3799.7150213733803;105148;106293;109406.45296773466;109576;110165;10396.116330111874;10439.425831579336;10594.417307048187;11050.392228427514;11185.552577896793;21270.149194032067;21456.034478448506;21501.354959351243;21547.138114475558;21579.2447264345;8005.879911801328;8026.117127116013;8085.757427277191;8102.108768035511;8178.713745019015;4303.935440968388;4321.783910804447;4454.844080457168;4576.58810707038;4584.358189853423;3477;3561.28774245152;3569.37535931211;3581.6418358164497;3595.7303202259936;639.1371648274885;644.7453255963868;646.9902951455732;653.7189008726293;658.5159907468103;601.885641728079;667.436016566001;669.715370967337;671.771597656799;679.711023442082;9126;9469.289803264783;9523.380980236263;9545.427274363561;9736.805263894683;609.2262826210776;655.1254075808848;672.5548181629316;685.6331862453563;696.9686364113627;4337.8264869404875;4653.906921861544;4691.577758001797;4723.655672724498;4766.737829419346;85960;96618.58453538718;100707.4823129413;101045.98954010366;114726;64162.358376415636;68170.97743533851;68471.63056738838;68632.3136768626;93943.84062476656;75245.24754752601;94273;94430.05569944212;95259;95963;8684;8866.379353445454;8985.955070224869;9019.909800902169;9110.590023449093;60270.79458410719;60662.090068648125;60812.69593652003;60840.08739868994;61316.38683613285;60987;82601;85280.72078918945;86256;87122.25755484728;11157.66527004191;11496.54013839437;11559.942200288944;11615.128865335302;12139.332336721212;12478.563250286197;12670.303133327756;12742.936285318514;14185.361658725176;14833.258337083318;11787.390763404374;13566.93216533911;13908.860911390757;14129.081609695748;14222.431102755774;13126.60620181396;13182.406791694206;13574.59276221715;13786.655333616338;14283.28583570838;13382;13797.65424993512;13952.023358364817;14076.366563504462;14392.496262630757;11128.276662016942;11349.886501134883;11441.14191435629;11600.30398176112;11654.242474239147;9672.70981870545;10913.345199288067;11083.889161108607;11644.475998580254;11799.82300265514 13:52:57 INFO - PROCESS | 1636 | __end_tp_report 13:52:57 INFO - PROCESS | 1636 | __start_cc_report 13:52:57 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,356 13:52:57 INFO - PROCESS | 1636 | __end_cc_report 13:52:57 INFO - PROCESS | 1636 | __startTimestamp1486677177478__endTimestamp 13:52:57 INFO - PROCESS | 1636 | 13:52:57 INFO - PROCESS | 1636 | ------- Summary: start ------- 13:52:57 INFO - PROCESS | 1636 | Number of tests: 6 13:52:57 INFO - PROCESS | 1636 | 13:52:57 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5679.10 Median:5894.62 stddev:656.13 (11.1%) stddev-sans-first:634.99 13:52:57 INFO - PROCESS | 1636 | Values: 3476.7 3488.1 3494.6 3506.8 3520.7 5619.4 5625.2 5644.5 5673.8 5688.9 4864.2 5625.7 5684.3 5744.3 5748.0 4197.5 5098.0 5115.6 5173.3 5203.2 4381.7 4690.6 5156.4 5161.1 5206.8 5053.3 5110.0 5164.0 5166.9 5170.0 5117.9 5119.0 5176.7 5208.8 5256.7 5082.2 5130.4 5136.8 5137.8 5139.3 5509.4 5692.8 5694.0 5798.5 5845.5 6054.4 6105.4 6133.2 6134.1 6245.7 6226.0 6226.6 6230.6 6231.1 6238.9 5751.3 5756.2 5770.3 5772.3 5833.6 6169.1 6193.3 6221.9 6225.9 6226.9 6068.9 6096.3 6111.5 6115.8 6142.5 6129.1 6171.6 6178.4 6202.9 6232.4 5979.9 6055.4 6065.5 6115.3 6132.1 6126.6 6149.4 6161.6 6165.3 6171.0 4156.4 4930.7 4940.6 4945.0 4980.5 3613.0 4363.3 4374.9 4418.7 4433.1 5588.3 5703.5 5760.0 5793.5 5806.0 6182.4 6184.4 6216.4 6223.6 6240.7 5578.8 5669.1 5669.6 5694.8 5727.1 5367.4 5383.1 5386.6 5388.6 5420.6 6274.3 6278.3 6281.9 6310.5 6317.0 6126.8 6150.2 6170.3 6171.5 6224.2 6294.7 6365.5 6377.9 6381.2 6381.6 5980.8 6104.6 6107.0 6162.6 6186.0 5925.2 6128.4 6128.5 6237.9 6278.0 5940.8 6033.8 6034.2 6060.6 6064.6 5987.7 6022.0 6022.6 6027.9 6030.6 5658.7 5712.8 5780.0 5792.2 5843.9 5987.6 6048.5 6054.1 6056.5 6078.8 5868.9 5889.2 5894.6 5921.6 5936.5 13:52:57 INFO - PROCESS | 1636 | 13:52:57 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:71372.73 Median:39619.00 stddev:156665.45 (395.4%) stddev-sans-first:157014.50 13:52:57 INFO - PROCESS | 1636 | Values: 473.8 492.8 510.6 573.7 581.1 37259.3 39669.6 39727.4 39732.2 39809.2 40721.8 40993.8 41393.2 41471.6 41496.8 9450.7 9510.2 9667.5 9670.0 9675.9 9575.8 9685.7 9699.6 9712.8 9753.3 9638.8 9723.9 9779.5 9794.8 9806.4 9672.4 9765.2 9771.8 9785.7 9908.2 9569.9 9608.1 9688.2 9711.6 9719.0 38844.0 39315.8 39731.8 39781.6 39784.2 3197.3 3308.3 3353.1 3378.6 3385.9 29713.0 29997.9 30611.7 30693.4 31170.5 3158.9 3251.9 3271.3 3302.2 3310.8 511958.0 516881.0 517948.0 518697.0 520536.4 57051.0 59127.7 59143.7 59207.8 59420.0 65312.0 66206.0 66572.3 66577.7 66583.7 16452.7 16966.9 17225.3 17239.2 17249.7 12653.3 12782.7 13078.7 13142.9 13149.2 15754.7 17822.1 18828.2 19193.0 19306.5 6667.6 6772.6 7882.4 7947.7 8035.8 892.7 1012.0 1045.7 1069.6 1080.4 30148.5 30378.8 30437.0 30495.4 30950.4 908.3 1077.5 1078.2 1081.7 1125.6 15220.7 15648.8 15700.4 15850.9 16064.9 637395.0 653162.7 655033.0 655751.0 667189.0 48008.5 58045.4 58143.7 58657.4 58672.4 1390.8 1403.7 1417.4 1422.8 1424.7 29081.9 29826.0 29911.7 29918.7 30554.2 49731.3 50131.0 50549.2 50550.2 50638.2 576554.0 577222.0 579238.0 580498.0 582176.0 25489.7 26650.9 26935.0 26987.2 27079.3 44973.0 46512.0 46653.3 46866.5 47430.8 38102.8 38258.8 38494.4 38868.6 39110.0 37783.8 38314.6 38549.0 39459.8 39568.4 33469.8 34815.8 37981.8 38796.6 38923.2 32222.9 34122.8 34824.3 34976.7 35060.5 22153.8 24814.0 26106.9 26213.8 26368.0 13:52:57 INFO - PROCESS | 1636 | 13:52:57 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:36191.04 Median:2765.47 stddev:104909.41 (3793.5%) stddev-sans-first:105169.25 13:52:57 INFO - PROCESS | 1636 | Values: 380.7 386.2 387.6 395.6 413.3 19111.3 20277.2 20423.1 20479.0 20568.2 19294.0 19978.2 20092.5 20158.0 20158.7 5704.7 5745.7 5881.3 5936.4 5947.4 5864.2 5869.7 5902.6 5907.8 5987.8 5242.7 5797.4 6102.1 6150.4 6187.4 6063.4 6075.9 6121.5 6129.1 6669.9 5859.3 5908.5 5961.7 5972.5 5986.6 12811.4 20596.2 24011.5 24216.7 24301.0 2147.6 2231.3 2238.3 2536.5 2994.4 10037.8 10039.2 10055.3 10447.0 10539.7 1855.1 1951.8 1963.9 1982.3 2012.6 127597.4 131643.7 131956.0 136581.0 138448.0 9094.2 9533.3 10829.5 11639.0 11780.0 11876.3 12175.6 14759.6 14801.3 14848.6 5915.9 8499.3 8743.1 8762.3 8789.6 6973.5 8480.7 8602.8 8748.0 8826.8 3488.3 3608.9 4162.9 4491.8 4620.5 1956.2 2010.5 2014.6 2016.7 2042.7 796.4 891.4 897.5 929.7 946.4 19790.9 20240.3 20552.8 20680.8 20834.2 736.6 799.3 950.1 966.1 1015.6 9989.9 10527.9 10538.4 10580.4 10590.6 616513.0 619792.0 629148.0 631099.0 635475.0 99850.5 122804.0 129748.4 140936.0 157795.9 1016.2 1027.2 1032.2 1057.6 1061.4 17385.0 17809.0 18431.3 18471.6 18564.6 55726.7 56106.7 56795.7 57707.3 58850.0 64947.7 84395.2 86379.0 86548.0 87366.0 6397.9 7901.3 7986.3 8175.0 8205.8 12472.9 12483.4 12517.6 12543.6 12750.7 10748.6 10749.2 10895.8 11082.0 11163.1 9367.7 10884.8 10909.8 10987.2 11129.6 9492.8 10252.8 10679.8 11071.9 11214.0 6414.4 7334.5 7830.0 8161.8 8227.8 6483.4 9200.4 9202.4 10315.6 11290.2 13:52:57 INFO - PROCESS | 1636 | 13:52:57 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5559.97 Median:5303.16 stddev:3017.15 (56.9%) stddev-sans-first:3009.12 13:52:57 INFO - PROCESS | 1636 | Values: 1362.6 1510.9 1670.1 1792.6 1830.4 7633.9 7887.3 8149.2 8628.3 8645.1 8114.3 8363.2 8372.1 8533.0 8539.1 2359.2 2371.3 2387.2 2390.0 2399.1 2380.7 2414.4 2416.7 2429.2 2453.0 2377.5 2377.9 2401.5 2402.2 2409.4 2329.7 2355.0 2366.9 2377.5 2390.7 1987.4 2373.3 2376.8 2381.2 2401.5 8391.0 8552.3 8553.9 8555.0 8563.0 5145.0 5305.0 5309.8 5312.2 5369.1 3504.7 3557.9 3561.3 3584.9 3590.0 1047.1 1054.6 1076.5 1083.6 1084.5 11124.3 11144.8 11148.0 11153.4 11195.2 4525.3 4683.1 4762.9 4763.0 4834.1 9430.7 9570.0 9590.8 9633.7 9657.1 5248.7 5296.4 5301.3 5310.1 5336.4 4370.8 4387.8 4827.3 4871.0 4902.0 3335.7 3875.7 3890.2 3961.5 3990.8 1267.9 1283.5 1286.1 1297.3 1297.5 852.3 904.1 926.7 926.8 957.5 5730.8 5852.3 5924.2 5955.9 6145.8 908.8 945.2 952.8 959.7 962.2 3262.8 3718.6 3884.6 3911.0 3948.2 8590.6 9988.8 10047.3 10191.4 10257.0 9971.0 10031.2 10031.4 10042.7 10079.6 7644.2 7977.8 8024.3 8132.1 8152.5 5698.6 5758.9 5761.9 5780.5 5851.0 9537.6 9639.4 9686.1 9691.6 9696.5 9255.1 9498.2 9518.6 9543.0 9622.5 7322.0 7332.6 7358.0 7413.7 7418.1 8004.4 8066.6 8088.5 8090.9 8121.5 7216.3 7338.6 7397.9 7465.9 7485.6 7114.3 7226.6 7230.2 7235.4 7275.8 6740.5 6865.3 6877.3 6908.2 6912.7 4898.0 4914.1 5024.5 5055.7 5120.9 4825.1 4877.9 4993.3 5035.7 5114.5 13:52:57 INFO - PROCESS | 1636 | 13:52:57 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4579.49 Median:5014.73 stddev:1395.58 (27.8%) stddev-sans-first:1361.59 13:52:57 INFO - PROCESS | 1636 | Values: 275.3 313.9 322.9 326.7 328.4 5329.9 5467.9 5480.5 5573.9 5608.5 5305.8 5425.6 5454.7 5482.3 5485.7 3887.4 4238.3 4246.4 4246.6 4267.6 3395.9 3505.7 3894.6 4254.6 4260.4 3563.9 3572.8 4108.9 4131.5 4133.7 3874.5 4103.5 4114.2 4136.2 4154.8 3237.1 3331.4 3433.8 3605.9 3640.4 4772.8 4904.8 4997.5 5336.6 5409.5 4745.6 4751.8 4754.5 4775.2 4778.5 5720.6 5743.3 5752.9 5780.9 5792.5 3671.7 3812.5 3833.6 4008.4 4076.8 4942.9 5409.4 6088.4 6096.5 6139.9 4140.3 4166.4 4173.4 4175.7 4184.5 3920.3 4130.1 4178.9 4184.2 4217.2 4789.9 4801.0 4816.6 4817.5 4827.1 4622.4 5427.4 5428.5 5738.5 5789.2 1341.9 1370.3 1387.6 1389.9 1393.7 769.8 810.0 844.4 856.6 958.9 4518.7 4601.4 4666.4 5007.1 5132.1 4728.6 5134.8 5177.7 5229.2 5507.7 4335.3 4466.8 4666.8 4893.5 5098.0 2574.6 2828.8 2874.9 2931.9 2934.9 5078.3 5347.8 5662.9 5804.5 5828.8 5405.9 5688.7 5689.9 5699.9 5716.7 5771.7 5780.4 5798.9 5806.4 5823.9 4534.3 5533.6 5541.5 5565.1 5580.4 4800.8 5203.6 5234.6 5473.8 5520.6 5512.0 5778.3 5791.1 5820.5 5823.2 3643.9 3902.3 3904.9 3932.8 3954.5 4497.5 4772.6 4892.7 5022.3 5849.2 4696.4 5881.8 5905.4 5911.5 5936.4 5414.3 5851.3 5874.3 5887.9 5896.3 4786.5 5549.8 5723.0 5747.9 5751.6 5839.7 5873.3 5874.7 5876.4 5931.0 5473.8 5734.5 5748.7 5777.6 5793.5 13:52:57 INFO - PROCESS | 1636 | 13:52:57 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20873.90 Median:4515.72 stddev:30370.18 (672.5%) stddev-sans-first:30417.51 13:52:57 INFO - PROCESS | 1636 | Values: 676.2 709.6 718.9 721.5 738.7 14529.6 14866.6 15263.6 15383.7 15446.4 13724.7 13726.7 13845.2 13856.3 13866.2 825.8 840.2 843.4 843.7 846.0 691.8 701.6 828.3 835.4 838.5 885.6 886.5 887.2 890.5 891.4 872.9 881.0 882.8 886.4 895.3 652.4 655.2 655.3 656.3 657.1 13970.2 14095.4 14163.9 14177.6 14229.3 13170.7 13418.3 13463.0 13536.7 14157.9 11573.7 11636.9 11728.6 11804.2 11902.6 3720.2 3720.6 3752.3 3752.8 3799.7 105148.0 106293.0 109406.5 109576.0 110165.0 10396.1 10439.4 10594.4 11050.4 11185.6 21270.1 21456.0 21501.4 21547.1 21579.2 8005.9 8026.1 8085.8 8102.1 8178.7 4303.9 4321.8 4454.8 4576.6 4584.4 3477.0 3561.3 3569.4 3581.6 3595.7 639.1 644.7 647.0 653.7 658.5 601.9 667.4 669.7 671.8 679.7 9126.0 9469.3 9523.4 9545.4 9736.8 609.2 655.1 672.6 685.6 697.0 4337.8 4653.9 4691.6 4723.7 4766.7 85960.0 96618.6 100707.5 101046.0 114726.0 64162.4 68171.0 68471.6 68632.3 93943.8 75245.2 94273.0 94430.1 95259.0 95963.0 8684.0 8866.4 8986.0 9019.9 9110.6 60270.8 60662.1 60812.7 60840.1 61316.4 60987.0 82601.0 85280.7 86256.0 87122.3 11157.7 11496.5 11559.9 11615.1 12139.3 12478.6 12670.3 12742.9 14185.4 14833.3 11787.4 13566.9 13908.9 14129.1 14222.4 13126.6 13182.4 13574.6 13786.7 14283.3 13382.0 13797.7 13952.0 14076.4 14392.5 11128.3 11349.9 11441.1 11600.3 11654.2 9672.7 10913.3 11083.9 11644.5 11799.8 13:52:57 INFO - PROCESS | 1636 | -------- Summary: end -------- 13:52:57 INFO - PROCESS | 1636 | 13:52:58 INFO - TEST-INFO | 1636: exit 0 13:52:58 INFO - TEST-OK | dromaeo_css | took 1113562ms 13:52:58 INFO - TEST-START | kraken 13:52:58 INFO - operating with platform_type : mac_ 13:52:58 INFO - Initialising browser for kraken test... 13:52:58 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpYsnEkP/profile http://localhost:49243/getInfo.html) 13:53:00 INFO - PROCESS | 1648 | 2017-02-09 13:53:00.810 plugin-container[1650:9817] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 13:53:00 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:53:00 INFO - PROCESS | 1648 | 2017-02-09 13:53:00.811 plugin-container[1650:9817] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8813, name = 'com.apple.CFPasteboardClient' 13:53:00 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:53:00 INFO - PROCESS | 1648 | 2017-02-09 13:53:00.811 plugin-container[1650:9817] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:53:00 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 13:53:00 INFO - PROCESS | 1648 | colorDepth:24 13:53:00 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 13:53:00 INFO - PROCESS | 1648 | __metrics 13:53:01 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 13:53:01 INFO - TEST-INFO | 1648: exit 0 13:53:01 INFO - Browser initialized. 13:53:01 INFO - Running cycle 1/1 for kraken test... 13:53:01 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpYsnEkP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:04 INFO - PROCESS | 1651 | 2017-02-09 13:53:04.063 plugin-container[1652:9937] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 13:53:04 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:53:04 INFO - PROCESS | 1651 | 2017-02-09 13:53:04.063 plugin-container[1652:9937] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b03, name = 'com.apple.CFPasteboardClient' 13:53:04 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:53:04 INFO - PROCESS | 1651 | 2017-02-09 13:53:04.063 plugin-container[1652:9937] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:53:13 INFO - PROCESS | 1651 | RSS: Main: 177405952 13:53:13 INFO - PROCESS | 1651 | 13:53:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 13:53:17 INFO - PROCESS | 1651 | RSS: Main: 190189568 13:53:17 INFO - PROCESS | 1651 | 13:53:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 13:53:20 INFO - PROCESS | 1651 | RSS: Main: 198209536 13:53:20 INFO - PROCESS | 1651 | 13:53:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 13:53:24 INFO - PROCESS | 1651 | RSS: Main: 202035200 13:53:24 INFO - PROCESS | 1651 | 13:53:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 13:53:27 INFO - PROCESS | 1651 | RSS: Main: 203214848 13:53:27 INFO - PROCESS | 1651 | 13:53:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:53:29 INFO - PROCESS | 1651 | RSS: Main: 203575296 13:53:29 INFO - PROCESS | 1651 | 13:53:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 13:53:33 INFO - PROCESS | 1651 | RSS: Main: 207589376 13:53:33 INFO - PROCESS | 1651 | 13:53:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 13:53:36 INFO - PROCESS | 1651 | RSS: Main: 207720448 13:53:36 INFO - PROCESS | 1651 | 13:53:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 13:53:39 INFO - PROCESS | 1651 | RSS: Main: 207073280 13:53:39 INFO - PROCESS | 1651 | 13:53:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:53:42 INFO - PROCESS | 1651 | RSS: Main: 206860288 13:53:42 INFO - PROCESS | 1651 | 13:53:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:53:44 INFO - PROCESS | 1651 | RSS: Main: 206249984 13:53:44 INFO - PROCESS | 1651 | 13:53:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:53:47 INFO - PROCESS | 1651 | RSS: Main: 206237696 13:53:47 INFO - PROCESS | 1651 | 13:53:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:53:51 INFO - PROCESS | 1651 | RSS: Main: 206286848 13:53:51 INFO - PROCESS | 1651 | 13:53:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:53:54 INFO - PROCESS | 1651 | RSS: Main: 206626816 13:53:54 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 13:53:56 INFO - PROCESS | 1651 | RSS: Main: 208490496 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | __start_tp_report 13:53:56 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 13:53:56 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 13:53:56 INFO - PROCESS | 1651 | |i|pagename|runs| 13:53:56 INFO - PROCESS | 1651 | |0;ai-astar;107;118;118;117;119;130;139;174;170;155 13:53:56 INFO - PROCESS | 1651 | |1;audio-beat-detection;144;104;96;167;140;140;139;110;134;119 13:53:56 INFO - PROCESS | 1651 | |2;audio-dft;194;231;272;198;194;199;197;194;198;198 13:53:56 INFO - PROCESS | 1651 | |3;audio-fft;81;57;58;82;59;59;60;66;88;81 13:53:56 INFO - PROCESS | 1651 | |4;audio-oscillator;75;69;91;71;70;69;86;68;70;88 13:53:56 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;90;87;89;85;88;85;91;86;98;86 13:53:56 INFO - PROCESS | 1651 | |6;imaging-darkroom;94;95;94;95;96;95;95;103;94;95 13:53:56 INFO - PROCESS | 1651 | |7;imaging-desaturate;87;90;85;84;88;87;94;90;89;97 13:53:56 INFO - PROCESS | 1651 | |8;json-parse-financial;54;56;53;57;58;58;60;59;59;58 13:53:56 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;66;69;70;75;75;67;67;75;94;59 13:53:56 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;82;81;82;80;83;103;81;85;83;87 13:53:56 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;152;162;167;152;149;137;143;142;175;141 13:53:56 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;167;164;150;224;171;179;222;202;161;164 13:53:56 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;67;68;67;60;60;70;82;85;89;86 13:53:56 INFO - PROCESS | 1651 | __end_tp_report 13:53:56 INFO - PROCESS | 1651 | __start_cc_report 13:53:56 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,898 13:53:56 INFO - PROCESS | 1651 | __end_cc_report 13:53:56 INFO - PROCESS | 1651 | __startTimestamp1486677236593__endTimestamp 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | ------- Summary: start ------- 13:53:56 INFO - PROCESS | 1651 | Number of tests: 14 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:134.70 Median:134.50 stddev:23.87 (17.7%) stddev-sans-first:23.12 13:53:56 INFO - PROCESS | 1651 | Values: 107.0 118.0 118.0 117.0 119.0 130.0 139.0 174.0 170.0 155.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:140.00 stddev:21.63 (15.4%) stddev-sans-first:22.28 13:53:56 INFO - PROCESS | 1651 | Values: 144.0 104.0 96.0 167.0 140.0 140.0 139.0 110.0 134.0 119.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:207.50 Median:198.00 stddev:25.19 (12.7%) stddev-sans-first:26.24 13:53:56 INFO - PROCESS | 1651 | Values: 194.0 231.0 272.0 198.0 194.0 199.0 197.0 194.0 198.0 198.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:69.10 Median:73.50 stddev:12.35 (16.8%) stddev-sans-first:12.33 13:53:56 INFO - PROCESS | 1651 | Values: 81.0 57.0 58.0 82.0 59.0 59.0 60.0 66.0 88.0 81.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:73.00 stddev:8.99 (12.3%) stddev-sans-first:9.54 13:53:56 INFO - PROCESS | 1651 | Values: 75.0 69.0 91.0 71.0 70.0 69.0 86.0 68.0 70.0 88.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:88.50 stddev:3.92 (4.4%) stddev-sans-first:4.12 13:53:56 INFO - PROCESS | 1651 | Values: 90.0 87.0 89.0 85.0 88.0 85.0 91.0 86.0 98.0 86.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:95.00 stddev:2.67 (2.8%) stddev-sans-first:2.77 13:53:56 INFO - PROCESS | 1651 | Values: 94.0 95.0 94.0 95.0 96.0 95.0 95.0 103.0 94.0 95.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:89.10 Median:89.50 stddev:3.96 (4.4%) stddev-sans-first:4.12 13:53:56 INFO - PROCESS | 1651 | Values: 87.0 90.0 85.0 84.0 88.0 87.0 94.0 90.0 89.0 97.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:2.25 (3.9%) stddev-sans-first:2.07 13:53:56 INFO - PROCESS | 1651 | Values: 54.0 56.0 53.0 57.0 58.0 58.0 60.0 59.0 59.0 58.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.50 stddev:9.30 (12.8%) stddev-sans-first:9.63 13:53:56 INFO - PROCESS | 1651 | Values: 66.0 69.0 70.0 75.0 75.0 67.0 67.0 75.0 94.0 59.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:82.50 stddev:6.75 (8.2%) stddev-sans-first:7.09 13:53:56 INFO - PROCESS | 1651 | Values: 82.0 81.0 82.0 80.0 83.0 103.0 81.0 85.0 83.0 87.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:152.00 stddev:12.43 (8.2%) stddev-sans-first:13.18 13:53:56 INFO - PROCESS | 1651 | Values: 152.0 162.0 167.0 152.0 149.0 137.0 143.0 142.0 175.0 141.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:175.00 stddev:26.26 (15.0%) stddev-sans-first:27.40 13:53:56 INFO - PROCESS | 1651 | Values: 167.0 164.0 150.0 224.0 171.0 179.0 222.0 202.0 161.0 164.0 13:53:56 INFO - PROCESS | 1651 | 13:53:56 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:76.00 stddev:11.02 (14.5%) stddev-sans-first:11.44 13:53:56 INFO - PROCESS | 1651 | Values: 67.0 68.0 67.0 60.0 60.0 70.0 82.0 85.0 89.0 86.0 13:53:56 INFO - PROCESS | 1651 | -------- Summary: end -------- 13:53:56 INFO - PROCESS | 1651 | 13:53:57 INFO - TEST-INFO | 1651: exit 0 13:53:57 INFO - TEST-OK | kraken | took 59463ms 13:53:57 INFO - SUITE-END | took 1173s 13:53:57 INFO - Completed test suite (00:19:33) 13:53:57 INFO - javascript benchmark 13:53:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7279.189201796917, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3476.669716376945, 3488.0930957950927, 3494.598121216061, 3506.842192101355, 3520.6655367740073, 5619.4099619539975, 5625.212470254162, 5644.491995720385, 5673.8297851064435, 5688.914666280009, 4864.246041863508, 5625.6905870177125, 5684.27679869685, 5744.339400968879, 5748.0, 4197.496300443951, 5098.031374038939, 5115.641905066647, 5173.3016042834115, 5203.16749320107, 4381.737095774264, 4690.648201384893, 5156.432792392834, 5161.071007218699, 5206.791728330882, 5053.343065401511, 5110.029094472057, 5163.993021360836, 5166.870828229286, 5170.043541944733, 5117.897642047157, 5119.0, 5176.689398636094, 5208.817691380784, 5256.737163141827, 5082.23766435034, 5130.384353877521, 5136.768845401966, 5137.768800403991, 5139.306193663845, 5509.421510741355, 5692.800751973702, 5694.003549378884, 5798.507126894219, 5845.503132233765, 6054.424829641177, 6105.358937311563, 6133.21225245364, 6134.130457564626, 6245.656488893109, 6226.0, 6226.564140510166, 6230.626162430223, 6231.096491008823, 6238.906416403757, 5751.309842818889, 5756.222909907193, 5770.278715160605, 5772.278465191851, 5833.591648584601, 6169.136320915076, 6193.349698281706, 6221.9377806221355, 6225.906611400833, 6226.906596401058, 6068.878622427526, 6096.29892562361, 6111.54163437744, 6115.785947491905, 6142.508599312045, 6129.11127886454, 6171.643207496286, 6178.351273116348, 6202.875942481125, 6232.407921247474, 5979.923613749567, 6055.424734650202, 6065.484433823174, 6115.296740874767, 6132.110769107974, 6126.578745377165, 6149.446549810449, 6161.630302181883, 6165.260168779775, 6170.969145154246, 4156.43888075112, 4930.679505832181, 4940.567235501736, 4944.98627781304, 4980.477049909779, 3613.0, 4363.345498175299, 4374.8906277342685, 4418.7127836690515, 4433.069055498381, 5588.273524441878, 5703.515201207943, 5760.049591817303, 5793.507551858139, 5806.0, 6182.381761823782, 6184.443400094013, 6216.420185622916, 6223.626582405071, 6240.65676387794, 5578.776848925998, 5669.064604340238, 5669.574781891292, 5694.829155125353, 5727.083666613322, 5367.382750983609, 5383.138697808332, 5386.622936394415, 5388.595855310868, 5420.566354691615, 6274.2784579773, 6278.277998030194, 6281.874362512633, 6310.49516038725, 6316.968415157895, 6126.785562505291, 6150.169727086965, 6170.3212646607935, 6171.506279497719, 6224.221972253468, 6294.685265736786, 6365.522585806176, 6377.87244255103, 6381.202349706286, 6381.553291269566, 5980.820575382745, 6104.603200791934, 6107.0228763397645, 6162.630242185483, 6185.969070154621, 5925.1704761332585, 6128.387161283836, 6128.503123582109, 6237.8752424950335, 6277.96861015692, 5940.7920722776225, 6033.78881739137, 6034.185384972972, 6060.636361818305, 6064.636121832704, 5987.700614969322, 6021.969890150521, 6022.5784195105925, 6027.909581356195, 6030.577859549965, 5658.745356458887, 5712.800051998326, 5779.971100144472, 5792.160136780228, 5843.912341314969, 5987.64074155552, 6048.455638992512, 6054.122152287981, 6056.454919057306, 6078.756849725962, 5868.882622347614, 5889.204957330706, 5894.616849904743, 5921.615095018982, 5936.465718085393], "value": 5637.3880428202665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.7915317260405, 492.8004158315881, 510.6272421132573, 573.6758731316803, 581.1428143488353, 37259.25481490369, 39669.60330396695, 39727.404088938616, 39732.205355892904, 39809.20381592366, 40721.778346649575, 40993.79503102488, 41393.17213655725, 41471.58528414715, 41496.75509734705, 9450.669226577089, 9510.191633711109, 9667.516624168798, 9669.95165024174, 9675.903240967571, 9575.808483830318, 9685.70942871715, 9699.612015519371, 9712.757181070494, 9753.268504862128, 9638.759031024245, 9723.902760972405, 9779.46212958287, 9794.755131121708, 9806.411615303105, 9672.419654820698, 9765.169960553361, 9771.804563908752, 9785.657501987467, 9908.157806586449, 9569.856452153223, 9608.135267825859, 9688.224942004694, 9711.61153553857, 9718.979507151718, 38844.0, 39315.803420983, 39731.80134099311, 39781.60218397837, 39784.20431591381, 3197.2646291353117, 3308.3052558962645, 3353.1281866714585, 3378.577677790276, 3385.9492107618407, 29713.0, 29997.850010750026, 30611.69388306133, 30693.386132277454, 31170.532442013387, 3158.921026974321, 3251.886183983549, 3271.263965607743, 3302.1909632140278, 3310.784798988058, 511958.0, 516881.0, 517948.0, 518697.0, 520536.39731801476, 57051.0, 59127.70436147792, 59143.70428147832, 59207.81584368288, 59420.0, 65312.0, 66206.0, 66572.33427665758, 66577.66711166414, 66583.66708166429, 16452.670946581, 16966.915165424092, 17225.31098756061, 17239.22423490946, 17249.655006899793, 12653.30406827615, 12782.744345113231, 13078.738425231442, 13142.934285328512, 13149.21104733719, 15754.684906302038, 17822.134064635695, 18828.15273312704, 19193.0, 19306.517337066685, 6667.566608170453, 6772.627505487246, 7882.408819338572, 7947.721829735931, 8035.83928321442, 892.7366426904078, 1012.0, 1045.7333379988206, 1069.6309773128414, 1080.3841810168285, 30148.54777178344, 30378.78484860625, 30437.0, 30495.39009219803, 30950.380992380477, 908.3006085314403, 1077.466654006272, 1078.1590359519587, 1081.7187531241934, 1125.5666568371073, 15220.695586088215, 15648.765268520981, 15700.371985120468, 15850.920745396199, 16064.919675401548, 637395.0, 653162.7341863356, 655033.0, 655751.0, 667189.0, 48008.5199148011, 58045.41954580485, 58143.70928145417, 58657.41342586605, 58672.41327586755, 1390.847006829248, 1403.7192561487743, 1417.4046900301898, 1422.8150340455468, 1424.6865689548283, 29081.85459072691, 29826.0, 29911.700882990892, 29918.700812991592, 30554.236144096576, 49731.254031190285, 50131.0, 50549.241761372876, 50550.241746373096, 50638.24042639437, 576554.0, 577222.0, 579238.0, 580498.0, 582176.0, 25489.745102549477, 26650.866745666146, 26935.0, 26987.190384288504, 27079.323016924736, 44973.0, 46512.0, 46653.30020049634, 46866.53133468758, 47430.81422964454, 38102.80948595239, 38258.80870595629, 38494.42258366183, 38868.61131388763, 39110.0, 37783.81108094442, 38314.6168538311, 38548.97726591051, 39459.81620551388, 39568.40647390349, 33469.83265083659, 34815.78144764921, 37981.810090949366, 38796.6120338793, 38923.2215355697, 32222.9055111417, 34122.829385852914, 34824.303513930085, 34976.65023349836, 35060.47409288914, 22153.77846221517, 24814.00743970221, 26106.86946565255, 26213.80057190535, 26368.0], "value": 20072.97948056082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.65930991762355, 386.2195279760303, 387.55818367061545, 395.58266029339035, 413.32008845449235, 19111.331103411383, 20277.188912443486, 20423.080961356718, 20479.0, 20568.177272909103, 19294.0, 19978.200871965106, 20092.497687557818, 20158.0, 20158.697619535684, 5704.686242256675, 5745.741441635126, 5881.323647780496, 5936.376680448556, 5947.375525569818, 5864.208331875207, 5869.706514674249, 5902.616329938562, 5907.822765317026, 5987.790427335022, 5242.737863106849, 5797.391273916221, 6102.054181601837, 6150.415710507495, 6187.35032821554, 6063.363346848606, 6075.878482430348, 6121.479674227696, 6129.111278864584, 6669.933300666979, 5859.29688437386, 5908.468237858613, 5961.731722072517, 5972.462478376923, 5986.551008674367, 12811.359432028454, 20596.176152954013, 24011.519769604685, 24216.668083255416, 24301.0, 2147.600339722175, 2231.263682984611, 2238.2725614175297, 2536.492701459697, 2994.446027484922, 10037.849432258521, 10039.24705647072, 10055.296129270953, 10447.0, 10539.683809485728, 1855.1466325490292, 1951.8438524917972, 1963.9018049097488, 1982.2764690887866, 2012.5672980309157, 127597.36201318934, 131643.6835631641, 131956.0, 136580.999999999, 138448.0, 9094.226990705733, 9533.285003624756, 10829.458527073615, 11639.0, 11779.998700110587, 11876.287422754489, 12175.573854915212, 14759.631009224855, 14801.333939972727, 14848.554543363716, 5915.881682366328, 8499.277561407225, 8743.125687431333, 8762.342824288204, 8789.560521973875, 6973.546719463218, 8480.703175388831, 8602.827943441096, 8747.956260218658, 8826.823463530693, 3488.2500262443696, 3608.8736894208578, 4162.895927601774, 4491.775411229425, 4620.514845941195, 1956.1686283329527, 2010.4672261850621, 2014.6272939506239, 2016.747906511686, 2042.7242322286302, 796.4424902568226, 891.38494438837, 897.537768049455, 929.6792606550729, 946.3517490519016, 19790.901045494968, 20240.291589794582, 20552.794472055386, 20680.793192068188, 20834.1666333348, 736.5727877830846, 799.3006119645311, 950.1211379473959, 966.1497881863914, 1015.5683834370363, 9989.850152247722, 10527.94736026315, 10538.367697938149, 10580.41807700584, 10590.57637694499, 616513.0, 619792.0, 629148.0, 631099.0, 635475.0, 99850.50224246642, 122804.0, 129748.3512582431, 140936.0, 157795.89918453697, 1016.227666973091, 1027.1833892055984, 1032.200044965158, 1057.619257067455, 1061.3578784835063, 17385.0, 17809.020503872413, 18431.26274948987, 18471.630567388307, 18564.628707426047, 55726.72136639291, 56106.719466404036, 56795.71602141963, 57707.26878193661, 58850.0, 64947.675261623386, 84395.15604843873, 86379.0, 86548.0, 87366.0, 6397.936020639921, 7901.288884000468, 7986.326289906708, 8174.959125204336, 8205.83588328242, 12472.87527124717, 12483.438245278803, 12517.624471265877, 12543.623691289276, 12750.68123296925, 10748.570057197625, 10749.247552671552, 10895.836562451728, 11082.0, 11163.106951444028, 9367.718968430958, 10884.782304354027, 10909.83635245456, 10987.175961802737, 11129.610463634059, 9492.810143796947, 10252.794944100928, 10679.839802403125, 11071.944640276746, 11214.0, 6414.358564143548, 7334.486585938933, 7830.0, 8161.795955100933, 8227.79430514218, 6483.4164925156965, 9200.35597508168, 9202.401843880127, 10315.638952636622, 11290.15323850698], "value": 9458.542734516674, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.611655678132, 1510.9395624175033, 1670.1315316035661, 1792.6235490546985, 1830.432565904569, 7633.923660763391, 7887.250711182429, 8149.185081491848, 8628.266597339218, 8645.13548645136, 8114.310283625884, 8363.247307742302, 8372.079071302167, 8533.018702849175, 8539.103394143604, 2359.1978727232736, 2371.300466362419, 2387.1883559589737, 2389.9761002390014, 2399.0883464283634, 2380.6905102336673, 2414.4326083370393, 2416.734159242482, 2429.186222615426, 2452.9632055519182, 2377.512609914972, 2377.8692171930625, 2401.519696060786, 2402.1712509184304, 2409.3856066703056, 2329.650552417151, 2355.0462062864567, 2366.8698221597806, 2377.524495100978, 2390.6653068570413, 1987.3541099142838, 2373.311739595515, 2376.7979721723673, 2381.1903952656007, 2401.4836810085917, 8390.958045209734, 8552.27305679018, 8553.914460855436, 8555.016173140044, 8562.957185214096, 5144.974275128638, 5305.0, 5309.787608495655, 5312.1766126250495, 5369.114096174127, 3504.737144714157, 3557.875474358411, 3561.305545418644, 3584.9103772405897, 3589.964100358989, 1047.0942634621, 1054.6045233037612, 1076.5424694504804, 1083.5557421457243, 1084.5173897615564, 11124.332540047622, 11144.777104457946, 11148.0, 11153.442327883573, 11195.160362972729, 4525.253333199985, 4683.1336202802595, 4762.857114286577, 4762.999770048329, 4834.129856625841, 9430.669926552675, 9570.0, 9590.808183836285, 9633.662821801203, 9657.082577155159, 5248.6588371755715, 5296.417394086648, 5301.310829592128, 5310.097283461821, 5336.439673834269, 4370.759608221579, 4387.802548885308, 4827.25177597473, 4871.0014447038275, 4901.995091006335, 3335.6831101045364, 3875.748076375083, 3890.1636148228267, 3961.5246170459154, 3990.7605543667473, 1267.9492820287085, 1283.5250957145915, 1286.0740267007739, 1297.3124244150426, 1297.5199176304639, 852.2840813716508, 904.0707859790137, 926.6756635177634, 926.837803384405, 957.5068839547639, 5730.828075157752, 5852.268466441695, 5924.170616113747, 5955.910661340084, 6145.84635384119, 908.836409446306, 945.2154711589365, 952.7903861150675, 959.6737109382843, 962.225408546113, 3262.771605987558, 3718.5909549949483, 3884.6309600587897, 3911.041794760245, 3948.1511475033008, 8590.613422396007, 9988.750281243027, 10047.346922450017, 10191.388516689023, 10257.0, 9971.0, 10031.247656425798, 10031.398116113056, 10042.748931276776, 10079.596816127272, 7644.159142494321, 7977.840443191104, 8024.277814996678, 8132.064812546633, 8152.470089444286, 5698.572607054404, 5758.913616295675, 5761.876434095311, 5780.537556995346, 5851.0, 9537.570809313736, 9639.421634701941, 9686.128248457673, 9691.612335506501, 9696.5151742414, 9255.120763527455, 9498.19265362452, 9518.571664274985, 9542.952285238529, 9622.51887405641, 7322.0, 7332.560046397233, 7357.963210183915, 7413.703451861865, 7418.146913105062, 8004.399670024888, 8066.596670166351, 8088.514689118671, 8090.919090809017, 8121.4721043132, 7216.278372162742, 7338.596377199306, 7397.927300541283, 7465.850682986418, 7485.588292643739, 7114.253003434772, 7226.566406015656, 7230.240824713329, 7235.384992275715, 7275.818104547428, 6740.528163028541, 6865.347791959756, 6877.346652068046, 6908.205556361083, 6912.654367281515, 4898.044881248123, 4914.0908931847725, 5024.472430394756, 5055.7219352935945, 5120.923186152137, 4825.10735513917, 4877.878053048702, 4993.3259010034635, 5035.697858128524, 5114.539691427789], "value": 4518.748584313785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.34055936033195, 313.87288148299945, 322.9370272796805, 326.7484037291287, 328.35969858775394, 5329.866753331169, 5467.906418716253, 5480.479354461325, 5573.8885222295585, 5608.467195616415, 5305.761240744167, 5425.647332923357, 5454.672719636815, 5482.314710661168, 5485.6982865942455, 3887.436321733347, 4238.321868501041, 4246.426732391134, 4246.596573325544, 4267.551907049746, 3395.864165433392, 3505.7370697197684, 3894.559013165133, 4254.553271906451, 4260.3822445745345, 3563.8752643657476, 3572.8034958077296, 4108.876733697994, 4131.545529991714, 4133.689973252003, 3874.5350557932948, 4103.4710149271605, 4114.238865809834, 4136.214119317335, 4154.771487568182, 3237.14215732831, 3331.433656278414, 3433.759636825423, 3605.8737944171826, 3640.381135207021, 4772.785224664898, 4904.803807847682, 4997.525235102659, 5336.585804761741, 5409.486098820645, 4745.623769106955, 4751.835800228966, 4754.524547545252, 4775.164346239394, 4778.4982576829625, 5720.628159169641, 5743.282089738783, 5752.884942301131, 5780.913286300709, 5792.507636850873, 3671.7429779915415, 3812.5234345706785, 3833.578306386323, 4008.378701301303, 4076.7757773322455, 4942.948676299331, 5409.350877894639, 6088.4215999479975, 6096.464050850541, 6139.907901381483, 4140.254754144223, 4166.375043743402, 4173.372384769881, 4175.707700460938, 4184.539700632928, 3920.255151521259, 4130.112025914443, 4178.931428942693, 4184.225918205142, 4217.219814334297, 4789.928151077736, 4801.0, 4816.638752093537, 4817.542333478314, 4827.08285425768, 4622.445306563234, 5427.43011983744, 5428.5385742211565, 5738.540916726652, 5789.247397838254, 1341.8591047940022, 1370.3011464153153, 1387.5559820857432, 1389.8957578181678, 1393.7282229965263, 769.7760560708389, 809.9595020248964, 844.4173520270994, 856.5845564901018, 958.8561715742694, 4518.661100417482, 4601.447826260804, 4666.370040044619, 5007.119482401168, 5132.07471741104, 4728.645351598644, 5134.813838023623, 5177.689338639693, 5229.241759944863, 5507.703990887115, 4335.349697545394, 4466.754328511963, 4666.813327466931, 4893.510648935078, 5098.0, 2574.575195092826, 2828.8076740526258, 2874.856257187132, 2931.9267018324713, 2934.8532573371244, 5078.273387048422, 5347.786088556492, 5662.85842853932, 5804.4775970162045, 5828.795992140254, 5405.889019225786, 5688.724510195872, 5689.857753556194, 5699.857503562444, 5716.657000579895, 5771.68255745938, 5780.364159942403, 5798.9420105799245, 5806.44838740319, 5823.854403639943, 4534.299637635887, 5533.5849811263515, 5541.473560011793, 5565.1095824667855, 5580.396173157243, 4800.807967681254, 5203.5576975955955, 5234.607404444758, 5473.808416705556, 5520.62613076381, 5511.972440137773, 5778.306603207642, 5791.13133030032, 5820.534357251495, 5823.223916705276, 3643.872464463837, 3902.2975864343557, 3904.902377440587, 3932.8230229640308, 3954.525456945185, 4497.482789479121, 4772.570468657698, 4892.730899800546, 5022.347094877789, 5849.181114643869, 4696.426697056524, 5881.823545293648, 5905.372109411271, 5911.497522710618, 5936.376680448663, 5414.29614150158, 5851.297844258546, 5874.295084589877, 5887.852803679943, 5896.262967129109, 4786.521347865325, 5549.778008879761, 5722.998475266895, 5747.913781293368, 5751.626144300774, 5839.708014599338, 5873.324567674772, 5874.676892770939, 5876.41235876409, 5931.021381472009, 5473.781048758005, 5734.480362703804, 5748.6550806950045, 5777.591221179524, 5793.507551858139], "value": 4131.249984997476, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.24936320684, 709.6380845768658, 718.877790775568, 721.476929226311, 738.7045181927232, 14529.636759081028, 14866.628334291621, 15263.618409539738, 15383.69232615347, 15446.382144714213, 13724.656883577916, 13726.656833579165, 13845.238511881842, 13856.307184640778, 13866.168029918186, 825.8389614025283, 840.197611281228, 843.3674743942044, 843.7468759372194, 845.9830803383928, 691.7855464805901, 701.6000879498688, 828.3331917806164, 835.4026870787416, 838.4969018588858, 885.5970533407317, 886.5212785096072, 887.183790912359, 890.5458216309664, 891.4027601506973, 872.9039805621377, 880.9824652526343, 882.8170251862502, 886.3529623374908, 895.2569367425021, 652.3900153356627, 655.1908393134476, 655.3053763011176, 656.3403779201919, 657.1293036726308, 13970.231637259947, 14095.436182552685, 14163.929180354135, 14177.574672759834, 14229.28853557318, 13170.661031090547, 13418.329083545783, 13463.0, 13536.729265414735, 14157.929210353985, 11573.710657233552, 11636.883631163664, 11728.589499367481, 11804.173707840455, 11902.58340958071, 3720.1815600567834, 3720.6093360197333, 3752.2683076800035, 3752.831122599462, 3799.7150213733803, 105148.0, 106293.0, 109406.45296773466, 109576.0, 110165.0, 10396.116330111874, 10439.425831579336, 10594.417307048187, 11050.392228427514, 11185.552577896793, 21270.149194032067, 21456.034478448506, 21501.354959351243, 21547.138114475558, 21579.2447264345, 8005.879911801328, 8026.117127116013, 8085.757427277191, 8102.108768035511, 8178.713745019015, 4303.935440968388, 4321.783910804447, 4454.844080457168, 4576.58810707038, 4584.358189853423, 3477.0, 3561.28774245152, 3569.37535931211, 3581.6418358164497, 3595.7303202259936, 639.1371648274885, 644.7453255963868, 646.9902951455732, 653.7189008726293, 658.5159907468103, 601.885641728079, 667.436016566001, 669.715370967337, 671.771597656799, 679.711023442082, 9126.0, 9469.289803264783, 9523.380980236263, 9545.427274363561, 9736.805263894683, 609.2262826210776, 655.1254075808848, 672.5548181629316, 685.6331862453563, 696.9686364113627, 4337.8264869404875, 4653.906921861544, 4691.577758001797, 4723.655672724498, 4766.737829419346, 85960.0, 96618.58453538718, 100707.4823129413, 101045.98954010366, 114726.0, 64162.358376415636, 68170.97743533851, 68471.63056738838, 68632.3136768626, 93943.84062476656, 75245.24754752601, 94273.0, 94430.05569944212, 95259.0, 95963.0, 8684.0, 8866.379353445454, 8985.955070224869, 9019.909800902169, 9110.590023449093, 60270.79458410719, 60662.090068648125, 60812.69593652003, 60840.08739868994, 61316.38683613285, 60987.0, 82601.0, 85280.72078918945, 86256.0, 87122.25755484728, 11157.66527004191, 11496.54013839437, 11559.942200288944, 11615.128865335302, 12139.332336721212, 12478.563250286197, 12670.303133327756, 12742.936285318514, 14185.361658725176, 14833.258337083318, 11787.390763404374, 13566.93216533911, 13908.860911390757, 14129.081609695748, 14222.431102755774, 13126.60620181396, 13182.406791694206, 13574.59276221715, 13786.655333616338, 14283.28583570838, 13382.0, 13797.65424993512, 13952.023358364817, 14076.366563504462, 14392.496262630757, 11128.276662016942, 11349.886501134883, 11441.14191435629, 11600.30398176112, 11654.242474239147, 9672.70981870545, 10913.345199288067, 11083.889161108607, 11644.475998580254, 11799.82300265514], "value": 7444.546014584885, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 118.0, 117.0, 119.0, 130.0, 139.0, 174.0, 170.0, 155.0], "value": 134.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 104.0, 96.0, 167.0, 140.0, 140.0, 139.0, 110.0, 134.0, 119.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 231.0, 272.0, 198.0, 194.0, 199.0, 197.0, 194.0, 198.0, 198.0], "value": 207.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 58.0, 82.0, 59.0, 59.0, 60.0, 66.0, 88.0, 81.0], "value": 69.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 69.0, 91.0, 71.0, 70.0, 69.0, 86.0, 68.0, 70.0, 88.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 85.0, 88.0, 85.0, 91.0, 86.0, 98.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 103.0, 94.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 85.0, 84.0, 88.0, 87.0, 94.0, 90.0, 89.0, 97.0], "value": 89.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 53.0, 57.0, 58.0, 58.0, 60.0, 59.0, 59.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 70.0, 75.0, 75.0, 67.0, 67.0, 75.0, 94.0, 59.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 80.0, 83.0, 103.0, 81.0, 85.0, 83.0, 87.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 162.0, 167.0, 152.0, 149.0, 137.0, 143.0, 142.0, 175.0, 141.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 150.0, 224.0, 171.0, 179.0, 222.0, 202.0, 161.0, 164.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 60.0, 60.0, 70.0, 82.0, 85.0, 89.0, 86.0], "value": 73.4, "unit": "score"}]}]} 13:53:57 INFO - Return code: 0 13:53:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:53:57 ERROR - # TBPL SUCCESS # 13:53:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:53:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:53:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:53:57 INFO - 2017-02-09 13:53:57.938 screenresolution[1656:10327] starting screenresolution argv=screenresolution get 13:53:57 INFO - 2017-02-09 13:53:57.942 screenresolution[1656:10327] Display 0: 1600x1200x32@60 13:53:57 INFO - 2017-02-09 13:53:57.949 screenresolution[1657:10330] starting screenresolution argv=screenresolution list 13:53:57 INFO - Available Modes on Display 0 13:53:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:53:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:53:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:53:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:53:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:53:58 INFO - Intel Iris: 13:53:58 INFO - Chipset Model: Intel Iris 13:53:58 INFO - Type: GPU 13:53:58 INFO - Bus: Built-In 13:53:58 INFO - VRAM (Dynamic, Max): 1536 MB 13:53:58 INFO - Vendor: Intel (0x8086) 13:53:58 INFO - Device ID: 0x0a2e 13:53:58 INFO - Revision ID: 0x0009 13:53:58 INFO - Displays: 13:53:58 INFO - Display: 13:53:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:53:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:53:58 INFO - Display Serial Number: 1600x1200 60 13:53:58 INFO - Main Display: Yes 13:53:58 INFO - Mirror: Off 13:53:58 INFO - Online: Yes 13:53:58 INFO - Rotation: Supported 13:53:58 INFO - Return code: 0 13:53:58 INFO - Running post-action listener: _resource_record_post_action 13:53:58 INFO - [mozharness: 2017-02-09 21:53:58.190231Z] Finished run-tests step (success) 13:53:58 INFO - Running post-run listener: _resource_record_post_run 13:53:58 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 40318976; Write bytes: 502269440; Read time: 384; Write time: 3382 13:53:58 INFO - TinderboxPrint: CPU usage
54.2% 13:53:58 INFO - TinderboxPrint: I/O read bytes / time
40,318,976 / 384 13:53:58 INFO - TinderboxPrint: I/O write bytes / time
502,269,440 / 3,382 13:53:58 INFO - TinderboxPrint: CPU idle
2,192.2 (45.8%) 13:53:58 INFO - TinderboxPrint: CPU system
962.6 (20.1%) 13:53:58 INFO - TinderboxPrint: CPU user
1,627.0 (34.0%) 13:53:58 INFO - TinderboxPrint: Swap in / out
232,112,128 / 0 13:53:58 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 187052544; Write bytes: 187737600; Read time: 16847; Write time: 400 13:53:58 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 38348800; Write bytes: 307617792; Read time: 363; Write time: 2954 13:53:58 INFO - Running post-run listener: _upload_blobber_files 13:53:58 INFO - Blob upload gear active. 13:53:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:53:58 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 13:53:58 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:53:58 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:53:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:53:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:53:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:00 INFO - (blobuploader) - INFO - Done attempting. 13:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:01 INFO - (blobuploader) - INFO - Done attempting. 13:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:54:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:03 INFO - (blobuploader) - INFO - Done attempting. 13:54:03 INFO - (blobuploader) - INFO - Iteration through files over. 13:54:03 INFO - Return code: 0 13:54:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:54:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:54:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/530b535af00831bec45d880025ea362926281cc84e77348a2fac4469a2acccc93b1eb944decc87827aa509612dc004b52cdad23673f297e1ea0a3361d793b969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11bb40bb2f7e020ab9906316928407bfadfa305a72b4749aee45308050eca4f604170b5ff2b512f6e58d3146ac475ef84c676031b9a378c35ad0d582ebe9253c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a88d6f8f2b5b9748d2d0868575c8db1e14ed05af124482ab0ed65c64ccbaee1df93f24a88bb6a3064d9e51dc008d508f1fd01847d630012af7d9a3cb2564120"} 13:54:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:54:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:54:03 INFO - Contents: 13:54:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/530b535af00831bec45d880025ea362926281cc84e77348a2fac4469a2acccc93b1eb944decc87827aa509612dc004b52cdad23673f297e1ea0a3361d793b969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11bb40bb2f7e020ab9906316928407bfadfa305a72b4749aee45308050eca4f604170b5ff2b512f6e58d3146ac475ef84c676031b9a378c35ad0d582ebe9253c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a88d6f8f2b5b9748d2d0868575c8db1e14ed05af124482ab0ed65c64ccbaee1df93f24a88bb6a3064d9e51dc008d508f1fd01847d630012af7d9a3cb2564120"} 13:54:03 INFO - Running post-run listener: copy_logs_to_upload_dir 13:54:03 INFO - Copying logs to upload dir... 13:54:03 INFO - mkdir: /builds/slave/test/build/upload/logs 13:54:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.397328 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-02-09 13:54:03.872274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 13:54:03.878733) ========= 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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/530b535af00831bec45d880025ea362926281cc84e77348a2fac4469a2acccc93b1eb944decc87827aa509612dc004b52cdad23673f297e1ea0a3361d793b969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11bb40bb2f7e020ab9906316928407bfadfa305a72b4749aee45308050eca4f604170b5ff2b512f6e58d3146ac475ef84c676031b9a378c35ad0d582ebe9253c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a88d6f8f2b5b9748d2d0868575c8db1e14ed05af124482ab0ed65c64ccbaee1df93f24a88bb6a3064d9e51dc008d508f1fd01847d630012af7d9a3cb2564120"} build_url:https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010962 build_url: 'https://queue.taskcluster.net/v1/task/RUUVh4x_QqC0nzkAawoG8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/530b535af00831bec45d880025ea362926281cc84e77348a2fac4469a2acccc93b1eb944decc87827aa509612dc004b52cdad23673f297e1ea0a3361d793b969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11bb40bb2f7e020ab9906316928407bfadfa305a72b4749aee45308050eca4f604170b5ff2b512f6e58d3146ac475ef84c676031b9a378c35ad0d582ebe9253c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a88d6f8f2b5b9748d2d0868575c8db1e14ed05af124482ab0ed65c64ccbaee1df93f24a88bb6a3064d9e51dc008d508f1fd01847d630012af7d9a3cb2564120"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 13:54:03.917965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:54:03.918342) ========= 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.Zkj9mJ8rBS/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.4Vh8w5YpQW/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005043 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:54:03.967581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 13:54:03.967910) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 13:54:03.968243) ========= ========= Total master_lag: 0.20 =========