builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0071 starttime: 1475554975.6 results: success (0) buildid: 20161003184057 builduid: f99803206465440db248c73de1156541 revision: 3df9873b4a0d97b8005476b6e45d23dca1422495 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.604328) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.604802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.605092) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.629416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:55.629686) ========= 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.5XcWMpBx2d/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.bkR2absSqE/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-03 21:22:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.45M=0.001s 2016-10-03 21:22:56 (9.45 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.560688 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:56.448734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:56.449089) ========= 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.5XcWMpBx2d/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.bkR2absSqE/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.028410 ========= master_lag: 0.76 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:57.239700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 21:22:57.240092) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3df9873b4a0d97b8005476b6e45d23dca1422495 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 3df9873b4a0d97b8005476b6e45d23dca1422495 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5XcWMpBx2d/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.bkR2absSqE/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-03 21:22:57,890 truncating revision to first 12 chars 2016-10-03 21:22:57,890 Setting DEBUG logging. 2016-10-03 21:22:57,890 attempt 1/10 2016-10-03 21:22:57,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3df9873b4a0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 21:22:58,679 unpacking tar archive at: autoland-3df9873b4a0d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.055911 ========= master_lag: 0.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 21:22:58.897693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:58.897974) ========= script_repo_revision: 3df9873b4a0d97b8005476b6e45d23dca1422495 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:58.898325) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:58.898610) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 21:22:58.920357) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-03 21:22:58.921099) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5XcWMpBx2d/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.bkR2absSqE/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:22:59 INFO - MultiFileLogger online at 20161003 21:22:59 in /builds/slave/test 21:22:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:22:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:22:59 INFO - {'append_to_log': False, 21:22:59 INFO - 'base_work_dir': '/builds/slave/test', 21:22:59 INFO - 'blob_upload_branch': 'Autoland', 21:22:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:22:59 INFO - 'branch': 'Autoland', 21:22:59 INFO - 'buildbot_json_path': 'buildprops.json', 21:22:59 INFO - 'config_files': ('talos/mac_config.py',), 21:22:59 INFO - 'default_actions': ('clobber', 21:22:59 INFO - 'read-buildbot-config', 21:22:59 INFO - 'download-and-extract', 21:22:59 INFO - 'populate-webroot', 21:22:59 INFO - 'create-virtualenv', 21:22:59 INFO - 'install', 21:22:59 INFO - 'run-tests'), 21:22:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:22:59 INFO - 'download_minidump_stackwalk': True, 21:22:59 INFO - 'download_symbols': 'ondemand', 21:22:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:22:59 INFO - 'tooltool.py': '/tools/tooltool.py', 21:22:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:22:59 INFO - '/tools/misc-python/virtualenv.py')}, 21:22:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:22:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:22:59 INFO - 'installer_path': 'installer.exe', 21:22:59 INFO - 'log_level': 'info', 21:22:59 INFO - 'log_name': 'talos', 21:22:59 INFO - 'log_to_console': True, 21:22:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:22:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:22:59 INFO - 'opt_config_files': (), 21:22:59 INFO - 'pip_index': False, 21:22:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:22:59 INFO - 'cmd': ('bash', 21:22:59 INFO - '-c', 21:22:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:22:59 INFO - 'enabled': True, 21:22:59 INFO - 'halt_on_failure': False, 21:22:59 INFO - 'name': 'check_screen_resolution'},), 21:22:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:22:59 INFO - 'cmd': ('bash', 21:22:59 INFO - '-c', 21:22:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:22:59 INFO - 'enabled': True, 21:22:59 INFO - 'halt_on_failure': False, 21:22:59 INFO - 'name': 'check_screen_resolution'},), 21:22:59 INFO - 'run_cmd_checks_enabled': True, 21:22:59 INFO - 'sps_profile': False, 21:22:59 INFO - 'sps_profile_interval': 0, 21:22:59 INFO - 'suite': 'dromaeojs-e10s', 21:22:59 INFO - 'system_bits': '32', 21:22:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:22:59 INFO - 'title': 't-yosemite-r7-0071', 21:22:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:22:59 INFO - 'use_talos_json': True, 21:22:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:22:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:22:59 INFO - 'work_dir': 'build'} 21:22:59 INFO - [mozharness: 2016-10-04 04:22:59.129951Z] Running clobber step. 21:22:59 INFO - Running pre-action listener: _resource_record_pre_action 21:22:59 INFO - Running main action method: clobber 21:22:59 INFO - rmtree: /builds/slave/test/build 21:22:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:23:01 INFO - Running post-action listener: _resource_record_post_action 21:23:01 INFO - [mozharness: 2016-10-04 04:23:01.571069Z] Finished clobber step (success) 21:23:01 INFO - [mozharness: 2016-10-04 04:23:01.571197Z] Running read-buildbot-config step. 21:23:01 INFO - Running pre-action listener: _resource_record_pre_action 21:23:01 INFO - Running main action method: read_buildbot_config 21:23:01 INFO - Using buildbot properties: 21:23:01 INFO - { 21:23:01 INFO - "project": "", 21:23:01 INFO - "product": "firefox", 21:23:01 INFO - "script_repo_revision": "production", 21:23:01 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 21:23:01 INFO - "repository": "", 21:23:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 21:23:01 INFO - "buildid": "20161003184057", 21:23:01 INFO - "pgo_build": "False", 21:23:01 INFO - "basedir": "/builds/slave/test", 21:23:01 INFO - "buildnumber": 202, 21:23:01 INFO - "slavename": "t-yosemite-r7-0071", 21:23:01 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 21:23:01 INFO - "platform": "yosemite_r7", 21:23:01 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 21:23:01 INFO - "branch": "autoland", 21:23:01 INFO - "repo_path": "integration/autoland", 21:23:01 INFO - "revision": "3df9873b4a0d97b8005476b6e45d23dca1422495", 21:23:01 INFO - "stage_platform": "macosx64", 21:23:01 INFO - "builduid": "f99803206465440db248c73de1156541", 21:23:01 INFO - "slavebuilddir": "test" 21:23:01 INFO - } 21:23:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 21:23:01 INFO - Running post-action listener: _resource_record_post_action 21:23:01 INFO - [mozharness: 2016-10-04 04:23:01.574364Z] Finished read-buildbot-config step (success) 21:23:01 INFO - [mozharness: 2016-10-04 04:23:01.574501Z] Running download-and-extract step. 21:23:01 INFO - Running pre-action listener: _resource_record_pre_action 21:23:01 INFO - Running main action method: download_and_extract 21:23:01 INFO - mkdir: /builds/slave/test/build/tests 21:23: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')]} 21:23:01 INFO - trying https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 21:23:01 INFO - Downloading https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 21:23:02 INFO - Downloaded 1199 bytes. 21:23:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:23:02 INFO - Using the following test package requirements: 21:23:02 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:23:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:23:02 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 21:23:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:23:02 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 21:23:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:23:02 INFO - u'jsshell-mac.zip'], 21:23:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:23:02 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 21:23:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:23:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:23:02 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 21:23:02 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:23:02 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 21:23:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:23:02 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 21:23:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:23:02 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 21:23:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:23:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:23:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:23:02 INFO - Fetch https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:23:03 INFO - Http code: 200 21:23:03 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 21:23:03 INFO - x-amz-cf-id: KtO0_ukCjDLRJYzB34X-BpcTnwQ-buXMrqqRgZASt4I9wb6AleyLCA== 21:23:03 INFO - x-amz-version-id: ZXuI4ed9rAWekG9ZuUMCtLUo6bl4IbnN 21:23:03 INFO - Expected file size: 16476355 21:23:03 INFO - Obtained file size: 16476355 21:23:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:23:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:23:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:23:09 INFO - Fetch https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:23:10 INFO - Http code: 200 21:23:10 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 21:23:10 INFO - x-amz-cf-id: jLXff8AxlQXRdzXVlRTgSrRYiqObh_rOms31Yl7SDAlz34BhR_vGWQ== 21:23:10 INFO - x-amz-version-id: ZXuI4ed9rAWekG9ZuUMCtLUo6bl4IbnN 21:23:11 INFO - Expected file size: 16476355 21:23:11 INFO - Obtained file size: 16476355 21:23:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 21:23:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:23:17 INFO - Fetch https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 21:23:17 INFO - Http code: 200 21:23:17 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 21:23:17 INFO - x-amz-cf-id: EveDwA1rpvdukdnbg16rv3AarQrSixnoMOeZX3GR3pE7sn5JMf8eTQ== 21:23:17 INFO - x-amz-version-id: IcaI7X3Ge.Gw8SU6lIqO0OdeplcKONw4 21:23:18 INFO - Expected file size: 14408522 21:23:18 INFO - Obtained file size: 14408522 21:23:18 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')]} 21:23:18 INFO - trying https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:23:18 INFO - Downloading https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 21:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 21:23:22 INFO - Downloaded 111739323 bytes. 21:23:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:23:22 INFO - mkdir: /builds/slave/test/properties 21:23:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:23:22 INFO - Writing to file /builds/slave/test/properties/build_url 21:23:22 INFO - Contents: 21:23:22 INFO - build_url:https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:23:23 INFO - Running post-action listener: _resource_record_post_action 21:23:23 INFO - Running post-action listener: set_extra_try_arguments 21:23:23 INFO - [mozharness: 2016-10-04 04:23:23.179623Z] Finished download-and-extract step (success) 21:23:23 INFO - [mozharness: 2016-10-04 04:23:23.179786Z] Running populate-webroot step. 21:23:23 INFO - Running pre-action listener: _resource_record_pre_action 21:23:23 INFO - Running main action method: populate_webroot 21:23:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:23:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:23:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:23:23 INFO - '--tppagecycles', 21:23:23 INFO - '7'], 21:23:23 INFO - 'tests': ['tsvgm']}}, 21:23:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:23:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:23:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:23:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:23:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:23 INFO - 'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:23 INFO - 'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['damp', 'tps']}, 21:23:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:23 INFO - 'tests': ['damp', 'tps']}, 21:23:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['dromaeo_dom']}, 21:23:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:23:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['basic_compositor_video']}, 21:23:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:23:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['a11yr', 21:23:23 INFO - 'ts_paint', 21:23:23 INFO - 'tpaint', 21:23:23 INFO - 'sessionrestore', 21:23:23 INFO - 'sessionrestore_no_auto_restore', 21:23:23 INFO - 'tabpaint']}, 21:23:23 INFO - 'other-e10s': {'tests': ['a11yr', 21:23:23 INFO - 'ts_paint', 21:23:23 INFO - 'tpaint', 21:23:23 INFO - 'sessionrestore', 21:23:23 INFO - 'sessionrestore_no_auto_restore', 21:23:23 INFO - 'tabpaint']}, 21:23:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:23:23 INFO - 'ts_paint', 21:23:23 INFO - 'tpaint', 21:23:23 INFO - 'sessionrestore', 21:23:23 INFO - 'sessionrestore_no_auto_restore', 21:23:23 INFO - 'tabpaint']}, 21:23:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:23:23 INFO - 'ts_paint', 21:23:23 INFO - 'tpaint', 21:23:23 INFO - 'sessionrestore', 21:23:23 INFO - 'sessionrestore_no_auto_restore', 21:23:23 INFO - 'tabpaint']}, 21:23:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['a11yr', 21:23:23 INFO - 'ts_paint', 21:23:23 INFO - 'tpaint', 21:23:23 INFO - 'sessionrestore', 21:23:23 INFO - 'sessionrestore_no_auto_restore', 21:23:23 INFO - 'tabpaint']}, 21:23:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['a11yr', 21:23:23 INFO - 'ts_paint', 21:23:23 INFO - 'tpaint', 21:23:23 INFO - 'sessionrestore', 21:23:23 INFO - 'sessionrestore_no_auto_restore', 21:23:23 INFO - 'tabpaint']}, 21:23:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['tsvgx', 21:23:23 INFO - 'tsvgr_opacity', 21:23:23 INFO - 'tart', 21:23:23 INFO - 'tscrollx', 21:23:23 INFO - 'cart']}, 21:23:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:23:23 INFO - 'tsvgr_opacity', 21:23:23 INFO - 'tart', 21:23:23 INFO - 'tscrollx', 21:23:23 INFO - 'cart']}, 21:23:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:23 INFO - 'talos_options': ['--disable-e10s'], 21:23:23 INFO - 'tests': ['tp5o']}, 21:23:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:23 INFO - 'tests': ['tp5o']}, 21:23:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:23 INFO - 'talos_options': ['--disable-e10s', 21:23:23 INFO - '--xperf_path', 21:23:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:23 INFO - 'tests': ['tp5n']}, 21:23:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:23 INFO - 'talos_options': ['--xperf_path', 21:23:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:23 INFO - 'tests': ['tp5n']}}, 21:23:23 INFO - 'talos.zip': {'path': '', 21:23:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:23:23 INFO - Running post-action listener: _resource_record_post_action 21:23:23 INFO - [mozharness: 2016-10-04 04:23:23.198985Z] Finished populate-webroot step (success) 21:23:23 INFO - [mozharness: 2016-10-04 04:23:23.199122Z] Running create-virtualenv step. 21:23:23 INFO - Running pre-action listener: _resource_record_pre_action 21:23:23 INFO - Running main action method: create_virtualenv 21:23:23 INFO - Creating virtualenv /builds/slave/test/build/venv 21:23:23 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 21:23:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:23:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:23:23 INFO - Using real prefix '/tools/python27' 21:23:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:23:24 INFO - Installing distribute.............................................................................................................................................................................................done. 21:23:26 INFO - Installing pip.................done. 21:23:26 INFO - Return code: 0 21:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:23:27 INFO - Reading from file tmpfile_stdout 21:23:27 INFO - Output received: 21:23:27 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) 21:23:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:23:27 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')]} 21:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:27 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')]} 21:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:27 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 0x100ee8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40047c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, '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.5XcWMpBx2d/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.bkR2absSqE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:23:27 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 21:23:27 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 21:23:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:23:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:27 INFO - 'HOME': '/Users/cltbld', 21:23:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:27 INFO - 'LOGNAME': 'cltbld', 21:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:27 INFO - 'MOZ_NO_REMOTE': '1', 21:23:27 INFO - 'NO_EM_RESTART': '1', 21:23:27 INFO - 'PAGER': '/bin/cat', 21:23:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:27 INFO - 'PWD': '/builds/slave/test', 21:23:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:27 INFO - 'SHELL': '/bin/bash', 21:23:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:23:27 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:23:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:27 INFO - 'USER': 'cltbld', 21:23:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:27 INFO - 'XPC_FLAGS': '0x0', 21:23:27 INFO - 'XPC_SERVICE_NAME': '0', 21:23:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:27 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 21:23:27 INFO - Cleaning up... 21:23:27 INFO - Return code: 0 21:23:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:23:27 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')]} 21:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:27 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')]} 21:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:27 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 0x100ee8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40047c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, '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.5XcWMpBx2d/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.bkR2absSqE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:23:27 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 21:23:27 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 21:23:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:23:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:27 INFO - 'HOME': '/Users/cltbld', 21:23:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:27 INFO - 'LOGNAME': 'cltbld', 21:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:27 INFO - 'MOZ_NO_REMOTE': '1', 21:23:27 INFO - 'NO_EM_RESTART': '1', 21:23:27 INFO - 'PAGER': '/bin/cat', 21:23:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:27 INFO - 'PWD': '/builds/slave/test', 21:23:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:27 INFO - 'SHELL': '/bin/bash', 21:23:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:23:27 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:23:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:27 INFO - 'USER': 'cltbld', 21:23:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:27 INFO - 'XPC_FLAGS': '0x0', 21:23:27 INFO - 'XPC_SERVICE_NAME': '0', 21:23:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:27 INFO - Downloading/unpacking psutil>=3.1.1 21:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:23:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:31 INFO - Installing collected packages: psutil 21:23:31 INFO - Running setup.py install for psutil 21:23:31 INFO - building 'psutil._psutil_osx' extension 21:23:31 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 21:23:32 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 21:23:32 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 21:23:32 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 21:23:32 INFO - building 'psutil._psutil_posix' extension 21:23:32 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 21:23:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:23:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:23:32 INFO - ^ 21:23:32 INFO - 1 warning generated. 21:23:32 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 21:23:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:32 INFO - Successfully installed psutil 21:23:32 INFO - Cleaning up... 21:23:32 INFO - Return code: 0 21:23:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:23:32 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')]} 21:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:32 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')]} 21:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:32 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 0x100ee8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40047c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, '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.5XcWMpBx2d/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.bkR2absSqE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:23:32 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 21:23:32 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 21:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:32 INFO - 'HOME': '/Users/cltbld', 21:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:32 INFO - 'LOGNAME': 'cltbld', 21:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:32 INFO - 'MOZ_NO_REMOTE': '1', 21:23:32 INFO - 'NO_EM_RESTART': '1', 21:23:32 INFO - 'PAGER': '/bin/cat', 21:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:32 INFO - 'PWD': '/builds/slave/test', 21:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:32 INFO - 'SHELL': '/bin/bash', 21:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:23:32 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:32 INFO - 'USER': 'cltbld', 21:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:32 INFO - 'XPC_FLAGS': '0x0', 21:23:32 INFO - 'XPC_SERVICE_NAME': '0', 21:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:23:33 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 21:23:33 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 21:23:33 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 21:23:33 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 21:23:33 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 21:23:33 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 21:23:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:23:35 INFO - Installing collected packages: mozsystemmonitor 21:23:35 INFO - Running setup.py install for mozsystemmonitor 21:23:35 INFO - Successfully installed mozsystemmonitor 21:23:35 INFO - Cleaning up... 21:23:35 INFO - Return code: 0 21:23:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100ee8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40047c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, '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.5XcWMpBx2d/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.bkR2absSqE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:23:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:23:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:35 INFO - 'HOME': '/Users/cltbld', 21:23:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:35 INFO - 'LOGNAME': 'cltbld', 21:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:35 INFO - 'MOZ_NO_REMOTE': '1', 21:23:35 INFO - 'NO_EM_RESTART': '1', 21:23:35 INFO - 'PAGER': '/bin/cat', 21:23:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:35 INFO - 'PWD': '/builds/slave/test', 21:23:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:35 INFO - 'SHELL': '/bin/bash', 21:23:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:23:35 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:23:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:35 INFO - 'USER': 'cltbld', 21:23:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:35 INFO - 'XPC_FLAGS': '0x0', 21:23:35 INFO - 'XPC_SERVICE_NAME': '0', 21:23:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:36 INFO - Downloading/unpacking jsonschema==2.5.1 21:23:36 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 21:23:36 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 21:23:36 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 21:23:36 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 21:23:36 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 21:23:36 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 21:23:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:23:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:38 INFO - Downloading functools32-3.2.3-2.tar.gz 21:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:23:38 INFO - warning: no files found matching '*.txt' 21:23:39 INFO - no previously-included directories found matching 'build' 21:23:39 INFO - no previously-included directories found matching 'dist' 21:23:39 INFO - no previously-included directories found matching '.git*' 21:23:39 INFO - Installing collected packages: jsonschema, functools32 21:23:39 INFO - Running setup.py install for functools32 21:23:39 INFO - warning: no files found matching '*.txt' 21:23:39 INFO - no previously-included directories found matching 'build' 21:23:39 INFO - no previously-included directories found matching 'dist' 21:23:39 INFO - no previously-included directories found matching '.git*' 21:23:39 INFO - Successfully installed jsonschema functools32 21:23:39 INFO - Cleaning up... 21:23:39 INFO - Return code: 0 21:23:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100ee8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40047c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, '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.5XcWMpBx2d/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.bkR2absSqE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:39 INFO - 'HOME': '/Users/cltbld', 21:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:39 INFO - 'LOGNAME': 'cltbld', 21:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:39 INFO - 'MOZ_NO_REMOTE': '1', 21:23:39 INFO - 'NO_EM_RESTART': '1', 21:23:39 INFO - 'PAGER': '/bin/cat', 21:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:39 INFO - 'PWD': '/builds/slave/test', 21:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:39 INFO - 'SHELL': '/bin/bash', 21:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:23:39 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:39 INFO - 'USER': 'cltbld', 21:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:39 INFO - 'XPC_FLAGS': '0x0', 21:23:39 INFO - 'XPC_SERVICE_NAME': '0', 21:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:23:39 INFO - Cleaning up... 21:23:39 INFO - Return code: 0 21:23:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100ee8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40047c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, '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.5XcWMpBx2d/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.bkR2absSqE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:39 INFO - 'HOME': '/Users/cltbld', 21:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:39 INFO - 'LOGNAME': 'cltbld', 21:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:39 INFO - 'MOZ_NO_REMOTE': '1', 21:23:39 INFO - 'NO_EM_RESTART': '1', 21:23:39 INFO - 'PAGER': '/bin/cat', 21:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:39 INFO - 'PWD': '/builds/slave/test', 21:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:39 INFO - 'SHELL': '/bin/bash', 21:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:23:39 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:39 INFO - 'USER': 'cltbld', 21:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:39 INFO - 'XPC_FLAGS': '0x0', 21:23:39 INFO - 'XPC_SERVICE_NAME': '0', 21:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:39 INFO - Downloading/unpacking blobuploader==1.2.4 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23:42 INFO - Downloading blobuploader-1.2.4.tar.gz 21:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:23:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:23:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23:43 INFO - Downloading docopt-0.6.1.tar.gz 21:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:23:43 INFO - Installing collected packages: blobuploader, requests, docopt 21:23:43 INFO - Running setup.py install for blobuploader 21:23:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:23:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:23:43 INFO - Running setup.py install for requests 21:23:44 INFO - Running setup.py install for docopt 21:23:44 INFO - Successfully installed blobuploader requests docopt 21:23:44 INFO - Cleaning up... 21:23:44 INFO - Return code: 0 21:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:44 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 0x100ee8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40047c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, '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.5XcWMpBx2d/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.bkR2absSqE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:23:44 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 21:23:44 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 21:23:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:23:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:44 INFO - 'HOME': '/Users/cltbld', 21:23:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:44 INFO - 'LOGNAME': 'cltbld', 21:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:44 INFO - 'MOZ_NO_REMOTE': '1', 21:23:44 INFO - 'NO_EM_RESTART': '1', 21:23:44 INFO - 'PAGER': '/bin/cat', 21:23:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:44 INFO - 'PWD': '/builds/slave/test', 21:23:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:44 INFO - 'SHELL': '/bin/bash', 21:23:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:23:44 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:23:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:44 INFO - 'USER': 'cltbld', 21:23:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:44 INFO - 'XPC_FLAGS': '0x0', 21:23:44 INFO - 'XPC_SERVICE_NAME': '0', 21:23:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:44 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-3XR7_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:44 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-U6HxQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:44 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-o3bCSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:44 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-gOmopK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-vChAxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-BZNcql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-06ehhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-eZcl0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZMqWT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ohpRZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-g_6YnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-4575Rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-c53A78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-evLhS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-BvhxDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-nPNUQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-pCEouf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:23:46 INFO - Running setup.py install for manifestparser 21:23:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:23:46 INFO - Running setup.py install for mozcrash 21:23:46 INFO - Running setup.py install for mozdebug 21:23:46 INFO - Running setup.py install for mozdevice 21:23:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:23:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:23:47 INFO - Running setup.py install for mozfile 21:23:47 INFO - Running setup.py install for mozhttpd 21:23:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:23:47 INFO - Running setup.py install for mozinfo 21:23:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:23:47 INFO - Running setup.py install for mozInstall 21:23:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:23:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:23:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:23:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:23:47 INFO - Running setup.py install for mozleak 21:23:47 INFO - Running setup.py install for mozlog 21:23:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:23:47 INFO - Running setup.py install for moznetwork 21:23:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:23:48 INFO - Running setup.py install for mozprocess 21:23:48 INFO - Running setup.py install for mozprofile 21:23:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:23:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:23:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:23:48 INFO - Running setup.py install for mozrunner 21:23:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:23:48 INFO - Running setup.py install for mozscreenshot 21:23:48 INFO - Running setup.py install for moztest 21:23:48 INFO - Running setup.py install for mozversion 21:23:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:23:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:23:48 INFO - Cleaning up... 21:23:48 INFO - Return code: 0 21:23:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:48 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 0x100ee8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40047c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, '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.5XcWMpBx2d/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.bkR2absSqE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:23:48 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 21:23:48 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 21:23:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:23:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:48 INFO - 'HOME': '/Users/cltbld', 21:23:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:48 INFO - 'LOGNAME': 'cltbld', 21:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:48 INFO - 'MOZ_NO_REMOTE': '1', 21:23:48 INFO - 'NO_EM_RESTART': '1', 21:23:49 INFO - 'PAGER': '/bin/cat', 21:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:49 INFO - 'PWD': '/builds/slave/test', 21:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:49 INFO - 'SHELL': '/bin/bash', 21:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:23:49 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:49 INFO - 'USER': 'cltbld', 21:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:49 INFO - 'XPC_FLAGS': '0x0', 21:23:49 INFO - 'XPC_SERVICE_NAME': '0', 21:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-sJMWBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:49 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)) 21:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-egPfYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-zr3OZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:49 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)) 21:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-PHiAPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:49 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)) 21:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_Ae2_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:49 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)) 21:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Zd1YhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:49 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)) 21:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:49 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-k6bVUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:50 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)) 21:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-CcY4Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:50 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)) 21:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-8tqmLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:50 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)) 21:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-QDyk61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:50 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)) 21:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-HINgZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:50 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)) 21:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-fSVpNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:50 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)) 21:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-e9GRsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:50 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)) 21:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Oi1BgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-HjXUsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:50 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)) 21:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_bkSU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:50 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-TAE_lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:51 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)) 21:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:23:51 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)) 21:23:51 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)) 21:23:51 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)) 21:23:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:23:51 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 21:23:51 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 21:23:51 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 21:23:51 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 21:23:51 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 21:23:51 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 21:23:53 INFO - Downloading blessings-1.6.tar.gz 21:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:23:53 INFO - Installing collected packages: blessings 21:23:53 INFO - Running setup.py install for blessings 21:23:53 INFO - Successfully installed blessings 21:23:53 INFO - Cleaning up... 21:23:53 INFO - Return code: 0 21:23:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:54 INFO - Reading from file tmpfile_stdout 21:23:54 INFO - Current package versions: 21:23:54 INFO - blessings == 1.6 21:23:54 INFO - blobuploader == 1.2.4 21:23:54 INFO - docopt == 0.6.1 21:23:54 INFO - functools32 == 3.2.3-2 21:23:54 INFO - jsonschema == 2.5.1 21:23:54 INFO - manifestparser == 1.1 21:23:54 INFO - mozInstall == 1.12 21:23:54 INFO - mozcrash == 0.17 21:23:54 INFO - mozdebug == 0.1 21:23:54 INFO - mozdevice == 0.48 21:23:54 INFO - mozfile == 1.2 21:23:54 INFO - mozhttpd == 0.7 21:23:54 INFO - mozinfo == 0.9 21:23:54 INFO - mozleak == 0.1 21:23:54 INFO - mozlog == 3.4 21:23:54 INFO - moznetwork == 0.27 21:23:54 INFO - mozprocess == 0.23 21:23:54 INFO - mozprofile == 0.28 21:23:54 INFO - mozrunner == 6.12 21:23:54 INFO - mozscreenshot == 0.1 21:23:54 INFO - mozsystemmonitor == 0.3 21:23:54 INFO - moztest == 0.7 21:23:54 INFO - mozversion == 1.4 21:23:54 INFO - psutil == 3.1.1 21:23:54 INFO - requests == 1.2.3 21:23:54 INFO - wsgiref == 0.1.2 21:23:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:54 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')]} 21:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:54 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')]} 21:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:54 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 0x100ee8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40047c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, '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.5XcWMpBx2d/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.bkR2absSqE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:23:54 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 21:23:54 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 21:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:54 INFO - 'HOME': '/Users/cltbld', 21:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:54 INFO - 'LOGNAME': 'cltbld', 21:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:54 INFO - 'MOZ_NO_REMOTE': '1', 21:23:54 INFO - 'NO_EM_RESTART': '1', 21:23:54 INFO - 'PAGER': '/bin/cat', 21:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:54 INFO - 'PWD': '/builds/slave/test', 21:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:54 INFO - 'SHELL': '/bin/bash', 21:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:23:54 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:54 INFO - 'USER': 'cltbld', 21:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:54 INFO - 'XPC_FLAGS': '0x0', 21:23:54 INFO - 'XPC_SERVICE_NAME': '0', 21:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:54 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)) 21:23:54 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)) 21:23:54 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)) 21:23:54 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)) 21:23:54 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)) 21:23:54 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)) 21:23:54 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)) 21:23:54 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)) 21:23:54 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)) 21:23:54 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)) 21:23:54 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)) 21:23:54 INFO - Cleaning up... 21:23:54 INFO - Return code: 0 21:23:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:23:54 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')]} 21:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:54 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')]} 21:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:54 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 0x100ee8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe40047c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, '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.5XcWMpBx2d/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.bkR2absSqE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 21:23:54 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 21:23:54 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 21:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:54 INFO - 'HOME': '/Users/cltbld', 21:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:54 INFO - 'LOGNAME': 'cltbld', 21:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:54 INFO - 'MOZ_NO_REMOTE': '1', 21:23:54 INFO - 'NO_EM_RESTART': '1', 21:23:54 INFO - 'PAGER': '/bin/cat', 21:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:54 INFO - 'PWD': '/builds/slave/test', 21:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:54 INFO - 'SHELL': '/bin/bash', 21:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:23:54 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:54 INFO - 'USER': 'cltbld', 21:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:54 INFO - 'XPC_FLAGS': '0x0', 21:23:54 INFO - 'XPC_SERVICE_NAME': '0', 21:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:23:54 INFO - Cleaning up... 21:23:54 INFO - Return code: 0 21:23:54 INFO - Running post-action listener: _resource_record_post_action 21:23:54 INFO - Running post-action listener: _start_resource_monitoring 21:23:54 INFO - Starting resource monitoring. 21:23:54 INFO - [mozharness: 2016-10-04 04:23:54.697418Z] Finished create-virtualenv step (success) 21:23:54 INFO - [mozharness: 2016-10-04 04:23:54.698388Z] Running install step. 21:23:54 INFO - Running pre-action listener: _resource_record_pre_action 21:23:54 INFO - Running main action method: install 21:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:54 INFO - Reading from file tmpfile_stdout 21:23:54 INFO - Detecting whether we're running mozinstall >=1.0... 21:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:23:55 INFO - Reading from file tmpfile_stdout 21:23:55 INFO - Output received: 21:23:55 INFO - Usage: mozinstall [options] installer 21:23:55 INFO - Options: 21:23:55 INFO - -h, --help show this help message and exit 21:23:55 INFO - -d DEST, --destination=DEST 21:23:55 INFO - Directory to install application into. [default: 21:23:55 INFO - "/builds/slave/test"] 21:23:55 INFO - --app=APP Application being installed. [default: firefox] 21:23:55 INFO - mkdir: /builds/slave/test/build/application 21:23:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:24:29 INFO - Reading from file tmpfile_stdout 21:24:29 INFO - Output received: 21:24:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:24:29 INFO - Running post-action listener: _resource_record_post_action 21:24:29 INFO - [mozharness: 2016-10-04 04:24:29.652564Z] Finished install step (success) 21:24:29 INFO - [mozharness: 2016-10-04 04:24:29.652700Z] Running run-tests step. 21:24:29 INFO - Running pre-action listener: _resource_record_pre_action 21:24:29 INFO - Running main action method: run_tests 21:24:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:24:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:24:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:24:29 INFO - 2016-10-03 21:24:29.667 screenresolution[1641:8327] starting screenresolution argv=screenresolution get 21:24:29 INFO - 2016-10-03 21:24:29.669 screenresolution[1641:8327] Display 0: 1600x1200x32@60 21:24:29 INFO - 2016-10-03 21:24:29.675 screenresolution[1642:8330] starting screenresolution argv=screenresolution list 21:24:29 INFO - Available Modes on Display 0 21:24:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:24:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:24:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:24:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:24:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:24:29 INFO - Intel Iris: 21:24:29 INFO - Chipset Model: Intel Iris 21:24:29 INFO - Type: GPU 21:24:29 INFO - Bus: Built-In 21:24:29 INFO - VRAM (Dynamic, Max): 1536 MB 21:24:29 INFO - Vendor: Intel (0x8086) 21:24:29 INFO - Device ID: 0x0a2e 21:24:29 INFO - Revision ID: 0x0009 21:24:29 INFO - Displays: 21:24:29 INFO - Display: 21:24:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:24:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:24:29 INFO - Display Serial Number: 1600x1200 60 21:24:29 INFO - Main Display: Yes 21:24:29 INFO - Mirror: Off 21:24:29 INFO - Online: Yes 21:24:29 INFO - Rotation: Supported 21:24:29 INFO - Return code: 0 21:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:24:29 INFO - Python 2.7.3 21:24:29 INFO - Return code: 0 21:24:29 INFO - grabbing minidump binary from tooltool 21:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:24:29 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 0x100cfcd30>, '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 0x100b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100cf4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:24:29 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 21:24:29 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 21:24:29 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 21:24:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:24:30 INFO - Return code: 0 21:24:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:24:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:24:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:24:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:24:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 21:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --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 21:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XcWMpBx2d/Render', 21:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:24:30 INFO - 'HOME': '/Users/cltbld', 21:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:24:30 INFO - 'LOGNAME': 'cltbld', 21:24:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:24:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:24:30 INFO - 'MOZ_NO_REMOTE': '1', 21:24:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:24:30 INFO - 'NO_EM_RESTART': '1', 21:24:30 INFO - 'PAGER': '/bin/cat', 21:24:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:24:30 INFO - 'PWD': '/builds/slave/test', 21:24:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:24:30 INFO - 'SHELL': '/bin/bash', 21:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bkR2absSqE/Listeners', 21:24:30 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 21:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:24:30 INFO - 'USER': 'cltbld', 21:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:24:30 INFO - 'XPC_FLAGS': '0x0', 21:24:30 INFO - 'XPC_SERVICE_NAME': '0', 21:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:24:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 21:24:30 INFO - mozversion application_buildid: 20161003184057 21:24:30 INFO - mozversion application_changeset: 3df9873b4a0d97b8005476b6e45d23dca1422495 21:24:30 INFO - mozversion application_display_name: Nightly 21:24:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:24:30 INFO - mozversion application_name: Firefox 21:24:30 INFO - mozversion application_remotingname: firefox 21:24:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:24:30 INFO - mozversion application_vendor: Mozilla 21:24:30 INFO - mozversion application_version: 52.0a1 21:24:30 INFO - mozversion platform_buildid: 20161003184057 21:24:30 INFO - mozversion platform_changeset: 3df9873b4a0d97b8005476b6e45d23dca1422495 21:24:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:24:30 INFO - mozversion platform_version: 52.0a1 21:24:30 INFO - using testdate: 1475555070 21:24:30 INFO - actual date: 1475555070 21:24:30 INFO - starting webserver on 'localhost:49274' 21:24:30 INFO - SUITE-START | Running 2 tests 21:24:30 INFO - TEST-START | dromaeo_css 21:24:30 INFO - operating with platform_type : mac_ 21:24:30 INFO - Initialising browser for dromaeo_css test... 21:24:30 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpc076v2/profile http://localhost:49274/getInfo.html) 21:24:33 INFO - PROCESS | 1652 | 2016-10-03 21:24:33.059 plugin-container[1655:8507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 21:24:33 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:24:33 INFO - PROCESS | 1652 | 2016-10-03 21:24:33.061 plugin-container[1655:8507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 21:24:33 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:24:33 INFO - PROCESS | 1652 | 2016-10-03 21:24:33.062 plugin-container[1655:8507] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:24:33 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 21:24:33 INFO - PROCESS | 1652 | colorDepth:24 21:24:33 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 21:24:33 INFO - PROCESS | 1652 | __metrics 21:24:33 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 21:24:33 INFO - TEST-INFO | 1652: exit 0 21:24:33 INFO - Browser initialized. 21:24:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:24:33 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpc076v2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:24:36 INFO - PROCESS | 1656 | 2016-10-03 21:24:36.246 plugin-container[1657:8629] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1f, name = 'com.apple.tsm.portname' 21:24:36 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:24:36 INFO - PROCESS | 1656 | 2016-10-03 21:24:36.251 plugin-container[1657:8629] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 21:24:36 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:24:36 INFO - PROCESS | 1656 | 2016-10-03 21:24:36.251 plugin-container[1657:8629] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:24:45 INFO - PROCESS | 1656 | RSS: Main: 240447488 21:24:45 INFO - PROCESS | 1656 | 21:25:35 INFO - PROCESS | 1656 | 1475555135514 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:27:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 21:27:49 INFO - PROCESS | 1656 | RSS: Main: 255496192 21:27:49 INFO - PROCESS | 1656 | 21:30:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 21:30:52 INFO - PROCESS | 1656 | RSS: Main: 267247616 21:30:52 INFO - PROCESS | 1656 | 21:33:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 21:33:55 INFO - PROCESS | 1656 | RSS: Main: 272723968 21:33:55 INFO - PROCESS | 1656 | 21:36:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 21:36:57 INFO - PROCESS | 1656 | RSS: Main: 270213120 21:36:57 INFO - PROCESS | 1656 | 21:40:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 21:40:01 INFO - PROCESS | 1656 | RSS: Main: 275742720 21:40:01 INFO - PROCESS | 1656 | 21:43:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 21:43:04 INFO - PROCESS | 1656 | RSS: Main: 278605824 21:43:04 INFO - PROCESS | 1656 | 21:43:04 INFO - PROCESS | 1656 | __start_tp_report 21:43:04 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 21:43:04 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 21:43:04 INFO - PROCESS | 1656 | |i|pagename|runs| 21:43:04 INFO - PROCESS | 1656 | |0;dojo.html;3329.650386709394;3335.9999999999995;3368.747343949203;3375.6118046424667;3387.745919056071;5498.285222921025;5498.862528436786;5505.724713764311;5509.862253443656;5590.413006634296;5525;5532.253145825302;5572.136318870572;5573.693446860431;5632.633878797876;3928.5285765708154;5074.3657042869645;5111.744412779365;5208.609354298424;5219.358968633224;5079.568236699866;5224.138017227153;5239.738013099349;5243.134882744343;5262.578993680497;5045.823396181116;5088.2622019807295;5204.713740744258;5212.895742085156;5248.632595718302;5083;5112.974435127838;5135.12702840518;5151.407588127376;5201.219817027439;5059.468755780664;5075.213341932006;5079.517445842639;5120.190518716968;5120.795168193268;4846.75766211688;5451.890962180773;5612.326520817487;5624.072028115356;5661.688607126606;5583.664980101207;5962.910556341659;6108.053251745987;6117.541184411187;6149.046897730859;5109.259157422153;6173.59871608344;6195.659238741868;6197.473214776749;6235.781747638811;5699.715014249313;5720.742566584514;5735.197072409907;5735.913961290584;5737.885242295172;6090.33006369299;6110.346130329488;6115.724792384353;6129.877402452015;6140.723667434976;6038.516918646497;6063.423974722483;6068.120122582201;6070.514358851281;6071.301800292935;4485.753283569435;4607.884802879955;5417.783288668409;6167.938320616826;6236.126942228092;4851.708897466164;5903.203067585907;5982.431668991526;5986.910196347058;5993.0710739835395;6060.696965151725;6077.118817771487;6080.635161890213;6086.969565152234;6140.846478838065;4316.784160791948;4817.0365926814075;4819.518048195152;4822.493638168012;4863.465018847924;4283.850065247701;4288.978555107205;4301.333293339538;4332.523422423531;4341.761203133858;5744.684042377626;5764.827055188351;5793.507551858055;5800.970995144998;5834.27071616048;6165.136880836686;6219.129321894939;6220.533459990519;6247.468965138014;6259.655718935503;5607.5513958884;5656.717164141776;5716.771329146871;5726.685032323179;5754.338251101177;5274.208868669731;5330.093884039723;5349.919751203735;5370.946290537045;5415.431379705153;6238.095476155932;6266.185395898595;6273.059041143865;6274.435300822948;6484.773032943825;6052.969735151296;6096.919795644952;6213.440790328892;6242.843928901632;6261.530385221035;6172.351903050115;6193.907091393543;6205.596636218812;6243.250809902841;6250.1874756281395;5403.621746477709;5836.037053886062;6045.153678484928;6084;6107.267127944675;5552.805651802168;6006.069059295816;6204.627722336674;6206.472449841814;6222.688865556795;5872.677002764889;5908.05471124618;5960.612560183574;5966.403359663999;6059.939400605937;5915.053591425351;5989.610675306091;5991.610545314541;5991.820245392645;6019.367966363468;5548.195511650707;5725.5992080555625;5740.3685594585395;5846.123081537803;5883.441073098049;5920.200772895604;6002.699865006645;6008.128821320972;6008.639481631116;6032.75868965254;5797.8550536236935;5824.534037276923;5851.736671849862;5853.151293062397;5873 21:43:04 INFO - PROCESS | 1656 | |1;ext.html;491.9286703428001;493.83209708699036;510.4558709902544;519.4312228110219;527.1065543903084;38961.22077558451;41969.79015104928;42106.57893421065;42134.36798448026;42170.36744448836;35802.74690385837;42447;43090.569094309045;43123.13753724931;43312.3503147453;9704.272179586505;9872.703818885446;9916.10755032047;9925.553350099226;9963;9850.950745246264;9940.751481212956;9942.304038717293;9976.301658883882;9976.401415915068;9895.208383329353;9922.057404546556;9926.503674816231;9958.402495850236;9965.501724913762;8411.579421028986;8450.746477605682;9701.223902087817;9886.121636888967;9898.406095634213;8224.753257402228;8249.876251856227;8292.875606865902;9827.803443931152;9829.459379734111;40086.59696910594;40335.596644033474;40426;40504;40651.59348406507;2813.423248234107;3226.838790994004;3365.7643964922463;3384.644612315696;3473.70473509752;31180;31420.528692069638;31871.362572748647;32383.866564670123;32568.185795355304;3245.0589329094532;3257.511373294025;3263.689949454798;3341.114604629775;3343.3981883261004;469552;478272;505096;510413;518494.03764905804;62735;63121;63186;63216.367836321966;63348.366516334245;61368;62452.68773656194;66202.66898665573;66642.66678666575;66794.66602667053;15661.512156345128;15962.36150553988;16853;16867.240974156193;16908.90092144007;12747.872521274669;12935.741285174432;13014.869851301366;13022.47910083586;13059.608211753663;18419.889228323824;19110.61778764417;19298.614027719366;19337.51656208606;19436.90281548583;7253.310935461122;7992.283588131547;8147.674093036212;8154.959225203955;8201.589920503951;694.0734119949924;763.6410886883156;782.4444644302608;799.3046049936593;834.7787836223406;24663;29695.257618559277;29962.951296704512;30830.53754193689;31039;918.9386258871015;935.4153653966271;1036.4972988100765;1055.2349546578669;1081.416035340907;13366.264855433044;14008.299585020708;14185.645358866112;14504;14729.779053314209;612561;613616;615459;621087;621371.8931405314;57844.421555783905;57967.8406431869;58091.12863307054;58297;58463.030642395875;1203.8683637380834;1309.2602679486251;1367.705943222192;1380.9723805524034;1389.708161286121;20359.59280814405;22964.4258893529;24154.91302891339;24280.635790462802;24388.87805561032;51144;51222.74388628033;51393.743031284605;51418;51471;424790;426314;547111;547238;549280;22693.88653056724;25864.353391165372;26624;26864;27116;46113.30830037619;47190;47338.816529587035;47495.28757068716;47720.2841957364;35231.29537409186;38821.41767873427;38936.610633893295;39161.60838391694;40177.79911100426;38646.22707545777;38654.80672596619;39379.80310098546;39957.80021099876;40239;38234.23531529409;38389.04027399337;39009.6099039006;39164;41280.58719412888;31331.84334078315;34516;35268.29463410769;35272.82363588268;35586.82206588951;22893.198738044088;25534.978600855757;26057.869710651325;26238.606420904085;26487.07295244657 21:43:04 INFO - PROCESS | 1656 | |2;jquery.html;317.56493603762846;375.2682269574329;376.3376457434915;382.31183869035726;402.54713447371705;19549;19975.300864469747;20535.897320513413;20873;21013;17352.392666256685;20257.14642366746;20418.69371959418;20781.792182078174;20784.584308313824;5695.686737229451;5809.3900140485275;5983.461488466037;6003.639781613096;6106.572539922207;3910.511186101737;6116.4800991915745;6148.8462788430425;6168.660723660197;6178.289496707869;4085.2850751118585;5877.735501902424;6116.602420842631;6164.7534098636;6202.162708034402;5909.113632955048;6131;6185.969070154621;6189.381061893797;6203.007518796993;6002.579819412643;6016.127661489059;6029.758809647609;6040.758369665208;6052.878942421127;12836.165649232864;13006.024548158926;13060.020498462653;13355.866441335656;13432.126911750705;2171.0772921508456;2290.404494831356;2455.3247856839334;2917.008217206139;3012.9096127116222;8322.542260175687;9561.091696288911;9632.373895696828;9649.179819715333;10009.899901001043;1530.739774238382;1847.2703282203588;1857.2849452960572;1902.876313039648;1930.5656227348875;127324.36337818344;128640;129460;130652.99999999905;131349;9165.358424910326;10332.605098311782;11379.203455758183;11400.657980260605;11525.135614828921;14187.64530886736;14358.497452589108;14367.2098034607;14382.856171438361;14388.712225755635;6988.93011069893;8064.959675201587;8387.370947178986;8559;8684.348673849487;7080.6105664187935;7410.962465254868;7595;8469.618867150994;8686;4412.095520418371;4484.596386325246;4514.277715565494;4573.291139873325;4576.519465456146;1582.2484319947932;1609.1310692226066;1888.6505996390438;1900.5058684741791;1928.3732786844332;724.6304384763808;855.4653341661461;892.5046599137542;916.0335845682736;936.1153709744362;20348.593028139356;21004.159833606485;21042.579148416946;21254.25610103639;21269.46826329354;841.5371545649868;933.1974501928472;948.307735353196;991.023841516106;1008.2841182760176;8650;11174.329540227613;11270.492827822767;11282.887171128348;11286.322820630789;570854;590283;591323;605372;606694;130308.3484582571;131887.34056329657;134597;134896;135620;964.3587014635189;970.7281961050917;988.5255077562811;989.6882482018285;994.6966175316453;15192.848071519586;16777.91611041937;18863.302302792814;18931.242750290385;18980.620387592448;46710.927579414456;49099.75450122727;50526.242106367696;53684.19473707819;54741.72629136988;77454.612726936;77467.22532774825;77700.445991081;77882.22117778749;78031;7221.963890180516;7261.019762332017;7355.154157271768;7420;7526.13449453298;9701.951490242503;12576.559820406243;12692.301923394301;12909.612711618667;13140.73718525605;10920.962508561674;11242.381669008282;11350.262232954832;11389.316641001566;11453.59912403062;10951.671449856518;10955.671329860117;11141.498632561716;11360.715982100513;11485.48315325829;7724;11106.61126860556;11384.316940983568;11482.770344592895;11506.884931150582;7317.085364329459;7328.1938986712485;7418.332350088518;7471.551706897603;7560.395168386406;9899.307048506535;11024.944875275893;11312.321260724382;11354.978051975362;11420.086393088366 21:43:04 INFO - PROCESS | 1656 | |3;mootools.html;1529.1971714849699;1567.4984005118363;1811.2030706489145;1863.6831738604435;1908.828205461509;8069.596520173983;8327.250547450743;8528.403011789178;9114.407563508375;9120.543972801359;8517.488950662964;8865.955670221656;8908.242799362062;8946.955265223682;8953.373263871532;2324.709411323589;2361.9763802362013;2362.3621622162004;2369.206315884181;2382.094803974487;2304.6082166031815;2342.074880422232;2346.9765302346927;2360.3155085025323;2361.315218586608;2300.5283916797016;2338.2634470141934;2345.870977096259;2354.5997180479358;2361.551305251997;1953.5311525233983;2142.0146732503067;2304.5045315257134;2326.720793504773;2331.8017968472614;2321.593721098801;2322.8490148140486;2327.755585663515;2330.5921463743775;2334.4397344637337;8852.51311177885;8982.416142950753;8988.865167022499;9011.05383934684;9051.728448146567;5131.3329267195395;5338.145896656516;5347.491988261109;5350.3312085989255;5357.43746906577;3488.773229740059;3547.2018795770746;3680.2271522980204;3699.6855267302312;3700.703943684499;935.2798345274101;1063.4151216830712;1074.1997212077054;1087.9020888120108;1096.2874131814385;11607;11679.591214307458;11693.649190524298;11778.174382970568;11795.882041179564;4562.657800664963;4616.584507394351;4797.856064318076;4827.61379089672;4830.565249127595;10005.549750261256;10112.898871011343;10137;10152.441615711206;10171;5366.248725178478;5389.083855744533;5389.407165211824;5390.353157621111;5392.083345831218;4445.244308467568;4504.301833215857;4591.311303304531;4882.877928051827;4938.4320803107385;3781.7352785304765;3818.713596480275;3902.375619900802;3903.1608204236227;3976.304146774303;1262.3814330977755;1269.530273798682;1277.9424925878359;1284.7687416264976;1290.0518119182393;857.7941294089374;860.644484936228;892.6786356911507;934.4674733437168;941.8210539997378;5541.002619528524;5738.426157384311;5762;5994.220751302303;6003.879922401527;414.5626364185813;416.22374271982534;425.7828507461155;427.46993727777334;440.74877319927333;3255.2187475006303;3801.3727734923427;3927.9018024549614;3959.48526691534;4015.31739604268;10491.108255798343;10703.983121603434;10737.677869663923;10865.185111116698;10889;10739.409332486632;10800.405977671146;10814.188935829845;10820.02619764225;10826.67519974402;8113.6754529818145;8198.016238051472;8240.50556966572;8288.627011784483;8354.66581336752;5374.57003439716;5527.834164975057;5591.133374326986;5712.285964254468;5973.671448070398;9680.951595241979;9973.102420782165;10021.198304135505;10038.749031273985;10048;8575;10141.84787228207;10245.282830202112;10267.691969240936;10305.433201174008;6675.599464032173;6854.2117656470145;7248.637568121679;7463.6641351140415;7540.396768258636;8261.545614990993;8495.872561911452;8561.743147705578;8564.48613083217;8567.614457349559;7351.191368949304;7439.107307123179;7601.65792539326;7668.348190403878;7701.383889288955;7285.8178545534665;7445.9255407445235;7448.851022979618;7513.699452021858;7576.810579735551;5745.396733342939;6090.634561926298;6532;6997.405220556309;7039.577625342496;4319.244132276902;5067.847964561069;5076.162433198629;5124.666896651705;5152.922706159336;4535.705179163344;4974.303597496281;5040.9918016397605;5214.061468935628;5221.843344699665 21:43:04 INFO - PROCESS | 1656 | |4;prototype.html;271.5492282810535;282.30271230061754;300.44717719396306;307.34995484550177;311.507817648116;4043.393490976355;4201.70588058836;5196.324477817888;5257.684538927667;5291.920621190676;5156.742162891859;5318.867028324294;5383.43473935237;5401.297831281938;5421.83734487965;3772.9812950503347;3919.8432062717457;3930.4693866327966;4143.419921211025;4145.3574695922025;3403.842693484215;3930.528336599612;4120.114175452277;4134.73124246923;4153.439285696438;3353.295807880348;3744.606816284278;4097.91804163918;4103.466549348581;4121.825279795244;4067.2272268268935;4102.138550904314;4112.609302116294;4113.9920719423635;4122.670186385082;3147.8426078695975;3588.1209103769484;3608.350496910555;3616.1321282891918;3624.6194149614175;4786.2581299898575;5173.715445650488;5213.331733845171;5240.34495688039;5254.238135470336;4184.644305234059;4702.623790096784;4728.493898233942;4735.857924262244;4739.73931433771;5237.866890447345;5645.717714114277;5703.7148142592705;5706.629069110494;5718.225970859255;3562.251927095313;3621.8953219268114;3827.75119617224;3887.3391523441082;3888.241792850395;5894.734736936848;5960.493358064569;5977.5815692901515;5999.310079340888;6060.363661815534;3687.2301295377833;3827.6746476549247;3904.1801221743754;3904.6095390461296;3937.7440466369594;3679.3377192105677;3896.2402331545077;3918.8236529356245;3961.485006949136;3997.3004724173734;3993.600639935983;4037.8990525237105;4581.496035436099;4589.79345929434;4594.862154135381;5480.725963701799;5688.459596338341;5717.484866510378;5728.99742545053;5764.193012978187;1079.5573814736078;1182.1204285186595;1272.5228039485194;1307.9346032698327;1348.966275843092;771.2750014985895;832.7259293281289;866.7172584574864;895.3106108296575;911.7219248129384;5245.816396426107;5313.973430132824;5338.46615338463;5339.359276886721;5350.197470379474;4836.758162091881;5176.628193528718;5795.9420405796245;5844.048755378507;5846.619969701956;4615.399998000238;5077.8165388883135;5284.920726189111;5318.680879147263;5367.651102678314;2075.4603803011023;2282.3609389371004;2461.003293666068;2560.655655780693;2574.6009368547907;4616.868867127575;4701.764911754399;4787.874849410386;4892.951070489321;4997.925031124536;4602.884927876763;4633.305004249322;4912.263160525949;4935.802567897315;5008.774605142778;3926.9214615706956;4105.891409319467;4275.444192254987;4838.540338667821;4994.525520075587;4143.6892233083245;4553.704009239521;4632.907341853212;4759.095771803346;4812.446568644511;3714.7555568884727;4732.597729193058;4795.136875362468;4822.42130944289;4831.622987448701;3935.9409608855317;4472.731636101845;4667.8599642010795;4682.859514214579;5019.949800502094;3361.336138611305;3361.8737722863116;3384.712299454574;3394.8981530554124;3395.3379091077004;4306.590873866978;4462.665300102441;4769.809207631656;4856.223004319292;4886.364772579542;4481.574250446202;4951.227312704897;5631.929933312657;5643.5044713151865;5652.85867853307;4735.550122738335;5379.569634429315;5664.649170594157;5699.492223421681;5737.311522617312;5347.251384806208;5413.53984911287;5516.227728117987;5553.250311207935;5617.354004289559;5300.257963884982;5312.140750737211;5660.179274005164;5704.771809127588;5705.515031222392;4930.852074437629;5604.318704388748;5613.270274864241;5619.8595035124445;5638.351589567253 21:43:04 INFO - PROCESS | 1656 | |5;yui.html;637.2050321331976;704.1374316462332;708.2351060854278;792.1761368177096;809.0453265147128;14934.25328733563;15781.526554203378;15801.683966320696;15818.604534886634;15819.84180158198;12052.156349055569;12077.214981026227;12490.875091249085;12751.744965100692;13099.886509646667;663.2969052804019;681.2097966359024;763.5647680821934;822.2271065198709;823.259066839843;855.8630619100945;858.5835869603237;859.4284800607588;859.8710193470966;861.5519929636586;721.6896734404204;807.3097501636105;874.3573473497006;896.5875697179305;911.9133682300204;908.8636704494313;909.9863502047475;910.7176775199644;910.8451563234266;913.4199783137689;559.4042344902666;669.2704951602727;676.5061505101254;678.4030053552891;678.4606238040769;14487.492937747234;14558.854411455855;14565.053271537316;14584.052036617586;14593.9784215105;13863.306834658328;13992;14231;14388;14476.493322733653;10166.796664066751;11687.06503479728;11736.295822250693;11757.059435245159;11816.350100744456;3775.7859158299807;3807.3146833569945;3813.161104556993;3829.617038296148;3856.768593884376;116620.9539274999;120233;120613;120889.99999999913;122689;9290.674826381044;11122.721931951766;11130.49912753928;11303.208775385645;11633.47649355764;21675.241366552094;22007.22974695878;22037.559248814934;22067.889660551595;22107.005184766724;7751;7956.801079972931;8005.679772809139;8043.39674524413;8175.754727358189;4228.112096459717;4357.085012147421;4360.542143074995;4363.738175709467;4559.54404559548;3483.9477407838904;3601.603823579404;3614.1326081740717;3637.254362855608;3646.6171052039685;653.7090994507398;661.2924171136838;662.3442791636245;681.6523572977817;686.8317262270775;506.5036264460849;545.8662627656249;588.7497813429276;614.1299742284754;636.8407898025494;8632.437096470192;9238.676646317346;9278.257739380833;9297.767555811024;9370.95314523423;567.986144731652;574.6839238418853;581.589645110605;583.5739909865822;607.5413063137303;4302.741835489881;4371.934420983688;4466;4554.772261386917;4564.406627138517;90596;126399.73600264064;142823;162042;166057;124283.3785831065;141478;141792;145443;145713;113438;116093.4195329018;117467;119072;122236;6778.491613129134;7013.6526443568655;7455.589942552995;7983.2415920487465;8453.731940208772;44339.77830110829;51524;55407.445925540225;62454.126376208784;64609.41562337642;85921;89924;90978;91227.54386228026;95504;13267.933660331637;13288.335583220995;13486.460541578226;13559.661008474866;13749.243791591158;14680.779788303398;14745.631359216106;15098.54704358871;15280;15374.461893833663;12018.579349722717;12378.75242495163;12526.311052892179;12921.676958076123;12935.547255846;13866.584002479942;13892.23592702411;13932.93033534826;13940.651483712989;14286.214258215898;13508.189508629514;13618.114822536503;13818.723625527233;13831.377588008363;14428.495002674856;9344.439333640003;10631.94684026575;11003.559857605605;11398.487068082122;11524.481398337262;8772.649094036422;10577.576896924036;11417.60038398652;11663.183577149857;11701.76596468083 21:43:04 INFO - PROCESS | 1656 | __end_tp_report 21:43:04 INFO - PROCESS | 1656 | __start_cc_report 21:43:04 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,356 21:43:04 INFO - PROCESS | 1656 | __end_cc_report 21:43:04 INFO - PROCESS | 1656 | __startTimestamp1475556184475__endTimestamp 21:43:04 INFO - PROCESS | 1656 | 21:43:04 INFO - PROCESS | 1656 | ------- Summary: start ------- 21:43:04 INFO - PROCESS | 1656 | Number of tests: 6 21:43:04 INFO - PROCESS | 1656 | 21:43:04 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5597.43 Median:5764.83 stddev:651.44 (11.3%) stddev-sans-first:628.68 21:43:04 INFO - PROCESS | 1656 | Values: 3329.7 3336.0 3368.7 3375.6 3387.7 5498.3 5498.9 5505.7 5509.9 5590.4 5525.0 5532.3 5572.1 5573.7 5632.6 3928.5 5074.4 5111.7 5208.6 5219.4 5079.6 5224.1 5239.7 5243.1 5262.6 5045.8 5088.3 5204.7 5212.9 5248.6 5083.0 5113.0 5135.1 5151.4 5201.2 5059.5 5075.2 5079.5 5120.2 5120.8 4846.8 5451.9 5612.3 5624.1 5661.7 5583.7 5962.9 6108.1 6117.5 6149.0 5109.3 6173.6 6195.7 6197.5 6235.8 5699.7 5720.7 5735.2 5735.9 5737.9 6090.3 6110.3 6115.7 6129.9 6140.7 6038.5 6063.4 6068.1 6070.5 6071.3 4485.8 4607.9 5417.8 6167.9 6236.1 4851.7 5903.2 5982.4 5986.9 5993.1 6060.7 6077.1 6080.6 6087.0 6140.8 4316.8 4817.0 4819.5 4822.5 4863.5 4283.9 4289.0 4301.3 4332.5 4341.8 5744.7 5764.8 5793.5 5801.0 5834.3 6165.1 6219.1 6220.5 6247.5 6259.7 5607.6 5656.7 5716.8 5726.7 5754.3 5274.2 5330.1 5349.9 5370.9 5415.4 6238.1 6266.2 6273.1 6274.4 6484.8 6053.0 6096.9 6213.4 6242.8 6261.5 6172.4 6193.9 6205.6 6243.3 6250.2 5403.6 5836.0 6045.2 6084.0 6107.3 5552.8 6006.1 6204.6 6206.5 6222.7 5872.7 5908.1 5960.6 5966.4 6059.9 5915.1 5989.6 5991.6 5991.8 6019.4 5548.2 5725.6 5740.4 5846.1 5883.4 5920.2 6002.7 6008.1 6008.6 6032.8 5797.9 5824.5 5851.7 5853.2 5873.0 21:43:04 INFO - PROCESS | 1656 | 21:43:04 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:67660.63 Median:42038.18 stddev:144499.41 (343.7%) stddev-sans-first:144816.77 21:43:04 INFO - PROCESS | 1656 | Values: 491.9 493.8 510.5 519.4 527.1 38961.2 41969.8 42106.6 42134.4 42170.4 35802.7 42447.0 43090.6 43123.1 43312.4 9704.3 9872.7 9916.1 9925.6 9963.0 9851.0 9940.8 9942.3 9976.3 9976.4 9895.2 9922.1 9926.5 9958.4 9965.5 8411.6 8450.7 9701.2 9886.1 9898.4 8224.8 8249.9 8292.9 9827.8 9829.5 40086.6 40335.6 40426.0 40504.0 40651.6 2813.4 3226.8 3365.8 3384.6 3473.7 31180.0 31420.5 31871.4 32383.9 32568.2 3245.1 3257.5 3263.7 3341.1 3343.4 469552.0 478272.0 505096.0 510413.0 518494.0 62735.0 63121.0 63186.0 63216.4 63348.4 61368.0 62452.7 66202.7 66642.7 66794.7 15661.5 15962.4 16853.0 16867.2 16908.9 12747.9 12935.7 13014.9 13022.5 13059.6 18419.9 19110.6 19298.6 19337.5 19436.9 7253.3 7992.3 8147.7 8155.0 8201.6 694.1 763.6 782.4 799.3 834.8 24663.0 29695.3 29963.0 30830.5 31039.0 918.9 935.4 1036.5 1055.2 1081.4 13366.3 14008.3 14185.6 14504.0 14729.8 612561.0 613616.0 615459.0 621087.0 621371.9 57844.4 57967.8 58091.1 58297.0 58463.0 1203.9 1309.3 1367.7 1381.0 1389.7 20359.6 22964.4 24154.9 24280.6 24388.9 51144.0 51222.7 51393.7 51418.0 51471.0 424790.0 426314.0 547111.0 547238.0 549280.0 22693.9 25864.4 26624.0 26864.0 27116.0 46113.3 47190.0 47338.8 47495.3 47720.3 35231.3 38821.4 38936.6 39161.6 40177.8 38646.2 38654.8 39379.8 39957.8 40239.0 38234.2 38389.0 39009.6 39164.0 41280.6 31331.8 34516.0 35268.3 35272.8 35586.8 22893.2 25535.0 26057.9 26238.6 26487.1 21:43:04 INFO - PROCESS | 1656 | 21:43:04 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:34786.67 Median:2146.41 stddev:99542.27 (4637.6%) stddev-sans-first:99787.87 21:43:04 INFO - PROCESS | 1656 | Values: 317.6 375.3 376.3 382.3 402.5 19549.0 19975.3 20535.9 20873.0 21013.0 17352.4 20257.1 20418.7 20781.8 20784.6 5695.7 5809.4 5983.5 6003.6 6106.6 3910.5 6116.5 6148.8 6168.7 6178.3 4085.3 5877.7 6116.6 6164.8 6202.2 5909.1 6131.0 6186.0 6189.4 6203.0 6002.6 6016.1 6029.8 6040.8 6052.9 12836.2 13006.0 13060.0 13355.9 13432.1 2171.1 2290.4 2455.3 2917.0 3012.9 8322.5 9561.1 9632.4 9649.2 10009.9 1530.7 1847.3 1857.3 1902.9 1930.6 127324.4 128640.0 129460.0 130653.0 131349.0 9165.4 10332.6 11379.2 11400.7 11525.1 14187.6 14358.5 14367.2 14382.9 14388.7 6988.9 8065.0 8387.4 8559.0 8684.3 7080.6 7411.0 7595.0 8469.6 8686.0 4412.1 4484.6 4514.3 4573.3 4576.5 1582.2 1609.1 1888.7 1900.5 1928.4 724.6 855.5 892.5 916.0 936.1 20348.6 21004.2 21042.6 21254.3 21269.5 841.5 933.2 948.3 991.0 1008.3 8650.0 11174.3 11270.5 11282.9 11286.3 570854.0 590283.0 591323.0 605372.0 606694.0 130308.3 131887.3 134597.0 134896.0 135620.0 964.4 970.7 988.5 989.7 994.7 15192.8 16777.9 18863.3 18931.2 18980.6 46710.9 49099.8 50526.2 53684.2 54741.7 77454.6 77467.2 77700.4 77882.2 78031.0 7222.0 7261.0 7355.2 7420.0 7526.1 9702.0 12576.6 12692.3 12909.6 13140.7 10921.0 11242.4 11350.3 11389.3 11453.6 10951.7 10955.7 11141.5 11360.7 11485.5 7724.0 11106.6 11384.3 11482.8 11506.9 7317.1 7328.2 7418.3 7471.6 7560.4 9899.3 11024.9 11312.3 11355.0 11420.1 21:43:04 INFO - PROCESS | 1656 | 21:43:04 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5688.47 Median:4576.98 stddev:3243.61 (70.9%) stddev-sans-first:3237.66 21:43:04 INFO - PROCESS | 1656 | Values: 1529.2 1567.5 1811.2 1863.7 1908.8 8069.6 8327.3 8528.4 9114.4 9120.5 8517.5 8866.0 8908.2 8947.0 8953.4 2324.7 2362.0 2362.4 2369.2 2382.1 2304.6 2342.1 2347.0 2360.3 2361.3 2300.5 2338.3 2345.9 2354.6 2361.6 1953.5 2142.0 2304.5 2326.7 2331.8 2321.6 2322.8 2327.8 2330.6 2334.4 8852.5 8982.4 8988.9 9011.1 9051.7 5131.3 5338.1 5347.5 5350.3 5357.4 3488.8 3547.2 3680.2 3699.7 3700.7 935.3 1063.4 1074.2 1087.9 1096.3 11607.0 11679.6 11693.6 11778.2 11795.9 4562.7 4616.6 4797.9 4827.6 4830.6 10005.5 10112.9 10137.0 10152.4 10171.0 5366.2 5389.1 5389.4 5390.4 5392.1 4445.2 4504.3 4591.3 4882.9 4938.4 3781.7 3818.7 3902.4 3903.2 3976.3 1262.4 1269.5 1277.9 1284.8 1290.1 857.8 860.6 892.7 934.5 941.8 5541.0 5738.4 5762.0 5994.2 6003.9 414.6 416.2 425.8 427.5 440.7 3255.2 3801.4 3927.9 3959.5 4015.3 10491.1 10704.0 10737.7 10865.2 10889.0 10739.4 10800.4 10814.2 10820.0 10826.7 8113.7 8198.0 8240.5 8288.6 8354.7 5374.6 5527.8 5591.1 5712.3 5973.7 9681.0 9973.1 10021.2 10038.7 10048.0 8575.0 10141.8 10245.3 10267.7 10305.4 6675.6 6854.2 7248.6 7463.7 7540.4 8261.5 8495.9 8561.7 8564.5 8567.6 7351.2 7439.1 7601.7 7668.3 7701.4 7285.8 7445.9 7448.9 7513.7 7576.8 5745.4 6090.6 6532.0 6997.4 7039.6 4319.2 5067.8 5076.2 5124.7 5152.9 4535.7 4974.3 5041.0 5214.1 5221.8 21:43:04 INFO - PROCESS | 1656 | 21:43:04 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4338.60 Median:4735.70 stddev:1345.66 (28.4%) stddev-sans-first:1314.35 21:43:04 INFO - PROCESS | 1656 | Values: 271.5 282.3 300.4 307.3 311.5 4043.4 4201.7 5196.3 5257.7 5291.9 5156.7 5318.9 5383.4 5401.3 5421.8 3773.0 3919.8 3930.5 4143.4 4145.4 3403.8 3930.5 4120.1 4134.7 4153.4 3353.3 3744.6 4097.9 4103.5 4121.8 4067.2 4102.1 4112.6 4114.0 4122.7 3147.8 3588.1 3608.4 3616.1 3624.6 4786.3 5173.7 5213.3 5240.3 5254.2 4184.6 4702.6 4728.5 4735.9 4739.7 5237.9 5645.7 5703.7 5706.6 5718.2 3562.3 3621.9 3827.8 3887.3 3888.2 5894.7 5960.5 5977.6 5999.3 6060.4 3687.2 3827.7 3904.2 3904.6 3937.7 3679.3 3896.2 3918.8 3961.5 3997.3 3993.6 4037.9 4581.5 4589.8 4594.9 5480.7 5688.5 5717.5 5729.0 5764.2 1079.6 1182.1 1272.5 1307.9 1349.0 771.3 832.7 866.7 895.3 911.7 5245.8 5314.0 5338.5 5339.4 5350.2 4836.8 5176.6 5795.9 5844.0 5846.6 4615.4 5077.8 5284.9 5318.7 5367.7 2075.5 2282.4 2461.0 2560.7 2574.6 4616.9 4701.8 4787.9 4893.0 4997.9 4602.9 4633.3 4912.3 4935.8 5008.8 3926.9 4105.9 4275.4 4838.5 4994.5 4143.7 4553.7 4632.9 4759.1 4812.4 3714.8 4732.6 4795.1 4822.4 4831.6 3935.9 4472.7 4667.9 4682.9 5019.9 3361.3 3361.9 3384.7 3394.9 3395.3 4306.6 4462.7 4769.8 4856.2 4886.4 4481.6 4951.2 5631.9 5643.5 5652.9 4735.6 5379.6 5664.6 5699.5 5737.3 5347.3 5413.5 5516.2 5553.3 5617.4 5300.3 5312.1 5660.2 5704.8 5705.5 4930.9 5604.3 5613.3 5619.9 5638.4 21:43:04 INFO - PROCESS | 1656 | 21:43:04 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:25020.88 Median:3711.20 stddev:40749.33 (1098.0%) stddev-sans-first:40822.52 21:43:04 INFO - PROCESS | 1656 | Values: 637.2 704.1 708.2 792.2 809.0 14934.3 15781.5 15801.7 15818.6 15819.8 12052.2 12077.2 12490.9 12751.7 13099.9 663.3 681.2 763.6 822.2 823.3 855.9 858.6 859.4 859.9 861.6 721.7 807.3 874.4 896.6 911.9 908.9 910.0 910.7 910.8 913.4 559.4 669.3 676.5 678.4 678.5 14487.5 14558.9 14565.1 14584.1 14594.0 13863.3 13992.0 14231.0 14388.0 14476.5 10166.8 11687.1 11736.3 11757.1 11816.4 3775.8 3807.3 3813.2 3829.6 3856.8 116621.0 120233.0 120613.0 120890.0 122689.0 9290.7 11122.7 11130.5 11303.2 11633.5 21675.2 22007.2 22037.6 22067.9 22107.0 7751.0 7956.8 8005.7 8043.4 8175.8 4228.1 4357.1 4360.5 4363.7 4559.5 3483.9 3601.6 3614.1 3637.3 3646.6 653.7 661.3 662.3 681.7 686.8 506.5 545.9 588.7 614.1 636.8 8632.4 9238.7 9278.3 9297.8 9371.0 568.0 574.7 581.6 583.6 607.5 4302.7 4371.9 4466.0 4554.8 4564.4 90596.0 126399.7 142823.0 162042.0 166057.0 124283.4 141478.0 141792.0 145443.0 145713.0 113438.0 116093.4 117467.0 119072.0 122236.0 6778.5 7013.7 7455.6 7983.2 8453.7 44339.8 51524.0 55407.4 62454.1 64609.4 85921.0 89924.0 90978.0 91227.5 95504.0 13267.9 13288.3 13486.5 13559.7 13749.2 14680.8 14745.6 15098.5 15280.0 15374.5 12018.6 12378.8 12526.3 12921.7 12935.5 13866.6 13892.2 13932.9 13940.7 14286.2 13508.2 13618.1 13818.7 13831.4 14428.5 9344.4 10631.9 11003.6 11398.5 11524.5 8772.6 10577.6 11417.6 11663.2 11701.8 21:43:04 INFO - PROCESS | 1656 | -------- Summary: end -------- 21:43:04 INFO - PROCESS | 1656 | 21:43:05 INFO - TEST-INFO | 1656: exit 0 21:43:05 INFO - TEST-OK | dromaeo_css | took 1114809ms 21:43:05 INFO - TEST-START | kraken 21:43:05 INFO - operating with platform_type : mac_ 21:43:05 INFO - Initialising browser for kraken test... 21:43:05 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp05VUWx/profile http://localhost:49274/getInfo.html) 21:43:07 INFO - PROCESS | 1664 | 2016-10-03 21:43:07.893 plugin-container[1665:10841] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b27, name = 'com.apple.tsm.portname' 21:43:07 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:43:07 INFO - PROCESS | 1664 | 2016-10-03 21:43:07.896 plugin-container[1665:10841] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f17, name = 'com.apple.CFPasteboardClient' 21:43:07 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:43:07 INFO - PROCESS | 1664 | 2016-10-03 21:43:07.896 plugin-container[1665:10841] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:43:07 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 21:43:07 INFO - PROCESS | 1664 | colorDepth:24 21:43:07 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 21:43:07 INFO - PROCESS | 1664 | __metrics 21:43:08 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 21:43:08 INFO - TEST-INFO | 1664: exit 0 21:43:08 INFO - Browser initialized. 21:43:08 INFO - Running cycle 1/1 for kraken test... 21:43:08 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp05VUWx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:43:11 INFO - PROCESS | 1666 | 2016-10-03 21:43:11.074 plugin-container[1667:10950] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4317, name = 'com.apple.tsm.portname' 21:43:11 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:43:11 INFO - PROCESS | 1666 | 2016-10-03 21:43:11.076 plugin-container[1667:10950] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 21:43:11 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:43:11 INFO - PROCESS | 1666 | 2016-10-03 21:43:11.076 plugin-container[1667:10950] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:43:20 INFO - PROCESS | 1666 | RSS: Main: 240451584 21:43:20 INFO - PROCESS | 1666 | 21:43:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 21:43:24 INFO - PROCESS | 1666 | RSS: Main: 254050304 21:43:24 INFO - PROCESS | 1666 | 21:43:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 21:43:27 INFO - PROCESS | 1666 | RSS: Main: 262676480 21:43:27 INFO - PROCESS | 1666 | 21:43:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 21:43:32 INFO - PROCESS | 1666 | RSS: Main: 262729728 21:43:32 INFO - PROCESS | 1666 | 21:43:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 21:43:34 INFO - PROCESS | 1666 | RSS: Main: 263589888 21:43:34 INFO - PROCESS | 1666 | 21:43:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:43:37 INFO - PROCESS | 1666 | RSS: Main: 265203712 21:43:37 INFO - PROCESS | 1666 | 21:43:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 21:43:40 INFO - PROCESS | 1666 | RSS: Main: 265875456 21:43:40 INFO - PROCESS | 1666 | 21:43:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 21:43:44 INFO - PROCESS | 1666 | RSS: Main: 265789440 21:43:44 INFO - PROCESS | 1666 | 21:43:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 21:43:47 INFO - PROCESS | 1666 | RSS: Main: 266403840 21:43:47 INFO - PROCESS | 1666 | 21:43:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:43:49 INFO - PROCESS | 1666 | RSS: Main: 265977856 21:43:49 INFO - PROCESS | 1666 | 21:43:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:43:52 INFO - PROCESS | 1666 | RSS: Main: 266080256 21:43:52 INFO - PROCESS | 1666 | 21:43:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:43:55 INFO - PROCESS | 1666 | RSS: Main: 266121216 21:43:55 INFO - PROCESS | 1666 | 21:43:58 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:43:58 INFO - PROCESS | 1666 | RSS: Main: 266129408 21:43:58 INFO - PROCESS | 1666 | 21:44:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:44:02 INFO - PROCESS | 1666 | RSS: Main: 266551296 21:44:02 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 21:44:04 INFO - PROCESS | 1666 | RSS: Main: 268234752 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | __start_tp_report 21:44:04 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 21:44:04 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 21:44:04 INFO - PROCESS | 1666 | |i|pagename|runs| 21:44:04 INFO - PROCESS | 1666 | |0;ai-astar;113;119;142;117;119;119;116;118;119;126 21:44:04 INFO - PROCESS | 1666 | |1;audio-beat-detection;170;114;116;149;116;116;115;117;141;113 21:44:04 INFO - PROCESS | 1666 | |2;audio-dft;197;205;211;218;195;196;283;251;210;201 21:44:04 INFO - PROCESS | 1666 | |3;audio-fft;82;59;59;81;63;51;51;51;69;84 21:44:04 INFO - PROCESS | 1666 | |4;audio-oscillator;87;70;87;72;69;71;87;69;71;84 21:44:04 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;91;88;90;87;111;87;91;75;137;130 21:44:04 INFO - PROCESS | 1666 | |6;imaging-darkroom;97;104;96;97;97;95;96;97;97;96 21:44:04 INFO - PROCESS | 1666 | |7;imaging-desaturate;100;90;91;99;89;92;91;93;91;90 21:44:04 INFO - PROCESS | 1666 | |8;json-parse-financial;58;57;56;57;58;83;87;48;49;80 21:44:04 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;69;85;123;111;106;69;71;71;72 21:44:04 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;89;87;92;89;86;90;90;89;96;90 21:44:04 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;147;149;157;166;164;140;147;146;180;148 21:44:04 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;175;178;177;176;182;175;172;175;180;179 21:44:04 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;72;72;69;69;68;69;71;72;68 21:44:04 INFO - PROCESS | 1666 | __end_tp_report 21:44:04 INFO - PROCESS | 1666 | __start_cc_report 21:44:04 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,927 21:44:04 INFO - PROCESS | 1666 | __end_cc_report 21:44:04 INFO - PROCESS | 1666 | __startTimestamp1475556244315__endTimestamp 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | ------- Summary: start ------- 21:44:04 INFO - PROCESS | 1666 | Number of tests: 14 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:120.80 Median:119.00 stddev:8.13 (6.8%) stddev-sans-first:8.12 21:44:04 INFO - PROCESS | 1666 | Values: 113.0 119.0 142.0 117.0 119.0 119.0 116.0 118.0 119.0 126.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:116.50 stddev:19.72 (16.9%) stddev-sans-first:13.31 21:44:04 INFO - PROCESS | 1666 | Values: 170.0 114.0 116.0 149.0 116.0 116.0 115.0 117.0 141.0 113.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:216.70 Median:210.50 stddev:28.52 (13.6%) stddev-sans-first:29.35 21:44:04 INFO - PROCESS | 1666 | Values: 197.0 205.0 211.0 218.0 195.0 196.0 283.0 251.0 210.0 201.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:65.00 Median:66.00 stddev:13.27 (20.1%) stddev-sans-first:12.57 21:44:04 INFO - PROCESS | 1666 | Values: 82.0 59.0 59.0 81.0 63.0 51.0 51.0 51.0 69.0 84.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:78.00 stddev:8.31 (10.7%) stddev-sans-first:7.94 21:44:04 INFO - PROCESS | 1666 | Values: 87.0 70.0 87.0 72.0 69.0 71.0 87.0 69.0 71.0 84.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:98.70 Median:87.50 stddev:20.39 (23.3%) stddev-sans-first:21.44 21:44:04 INFO - PROCESS | 1666 | Values: 91.0 88.0 90.0 87.0 111.0 87.0 91.0 75.0 137.0 130.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:97.20 Median:97.00 stddev:2.49 (2.6%) stddev-sans-first:2.64 21:44:04 INFO - PROCESS | 1666 | Values: 97.0 104.0 96.0 97.0 97.0 95.0 96.0 97.0 97.0 96.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:91.00 stddev:3.81 (4.2%) stddev-sans-first:2.95 21:44:04 INFO - PROCESS | 1666 | Values: 100.0 90.0 91.0 99.0 89.0 92.0 91.0 93.0 91.0 90.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:58.00 stddev:14.36 (24.8%) stddev-sans-first:15.10 21:44:04 INFO - PROCESS | 1666 | Values: 58.0 57.0 56.0 57.0 58.0 83.0 87.0 48.0 49.0 80.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:84.40 Median:70.00 stddev:20.96 (29.9%) stddev-sans-first:21.27 21:44:04 INFO - PROCESS | 1666 | Values: 67.0 69.0 85.0 123.0 111.0 106.0 69.0 71.0 71.0 72.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:90.00 stddev:2.74 (3.0%) stddev-sans-first:2.89 21:44:04 INFO - PROCESS | 1666 | Values: 89.0 87.0 92.0 89.0 86.0 90.0 90.0 89.0 96.0 90.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:154.40 Median:153.00 stddev:12.23 (8.0%) stddev-sans-first:12.68 21:44:04 INFO - PROCESS | 1666 | Values: 147.0 149.0 157.0 166.0 164.0 140.0 147.0 146.0 180.0 148.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:177.50 stddev:2.92 (1.6%) stddev-sans-first:3.02 21:44:04 INFO - PROCESS | 1666 | Values: 175.0 178.0 177.0 176.0 182.0 175.0 172.0 175.0 180.0 179.0 21:44:04 INFO - PROCESS | 1666 | 21:44:04 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.66 (2.4%) stddev-sans-first:1.73 21:44:04 INFO - PROCESS | 1666 | Values: 69.0 72.0 72.0 69.0 69.0 68.0 69.0 71.0 72.0 68.0 21:44:04 INFO - PROCESS | 1666 | -------- Summary: end -------- 21:44:04 INFO - PROCESS | 1666 | 21:44:05 INFO - TEST-INFO | 1666: exit 0 21:44:05 INFO - TEST-OK | kraken | took 60273ms 21:44:05 INFO - SUITE-END | took 1175s 21:44:05 INFO - Completed test suite (00:19:35) 21:44:05 INFO - javascript benchmark 21:44:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7169.0320567683275, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.650386709394, 3335.9999999999995, 3368.747343949203, 3375.6118046424667, 3387.745919056071, 5498.285222921025, 5498.862528436786, 5505.724713764311, 5509.862253443656, 5590.413006634296, 5525.0, 5532.253145825302, 5572.136318870572, 5573.693446860431, 5632.633878797876, 3928.5285765708154, 5074.3657042869645, 5111.744412779365, 5208.609354298424, 5219.358968633224, 5079.568236699866, 5224.138017227153, 5239.738013099349, 5243.134882744343, 5262.578993680497, 5045.823396181116, 5088.2622019807295, 5204.713740744258, 5212.895742085156, 5248.632595718302, 5083.0, 5112.974435127838, 5135.12702840518, 5151.407588127376, 5201.219817027439, 5059.468755780664, 5075.213341932006, 5079.517445842639, 5120.190518716968, 5120.795168193268, 4846.75766211688, 5451.890962180773, 5612.326520817487, 5624.072028115356, 5661.688607126606, 5583.664980101207, 5962.910556341659, 6108.053251745987, 6117.541184411187, 6149.046897730859, 5109.259157422153, 6173.59871608344, 6195.659238741868, 6197.473214776749, 6235.781747638811, 5699.715014249313, 5720.742566584514, 5735.197072409907, 5735.913961290584, 5737.885242295172, 6090.33006369299, 6110.346130329488, 6115.724792384353, 6129.877402452015, 6140.723667434976, 6038.516918646497, 6063.423974722483, 6068.120122582201, 6070.514358851281, 6071.301800292935, 4485.753283569435, 4607.884802879955, 5417.783288668409, 6167.938320616826, 6236.126942228092, 4851.708897466164, 5903.203067585907, 5982.431668991526, 5986.910196347058, 5993.0710739835395, 6060.696965151725, 6077.118817771487, 6080.635161890213, 6086.969565152234, 6140.846478838065, 4316.784160791948, 4817.0365926814075, 4819.518048195152, 4822.493638168012, 4863.465018847924, 4283.850065247701, 4288.978555107205, 4301.333293339538, 4332.523422423531, 4341.761203133858, 5744.684042377626, 5764.827055188351, 5793.507551858055, 5800.970995144998, 5834.27071616048, 6165.136880836686, 6219.129321894939, 6220.533459990519, 6247.468965138014, 6259.655718935503, 5607.5513958884, 5656.717164141776, 5716.771329146871, 5726.685032323179, 5754.338251101177, 5274.208868669731, 5330.093884039723, 5349.919751203735, 5370.946290537045, 5415.431379705153, 6238.095476155932, 6266.185395898595, 6273.059041143865, 6274.435300822948, 6484.773032943825, 6052.969735151296, 6096.919795644952, 6213.440790328892, 6242.843928901632, 6261.530385221035, 6172.351903050115, 6193.907091393543, 6205.596636218812, 6243.250809902841, 6250.1874756281395, 5403.621746477709, 5836.037053886062, 6045.153678484928, 6084.0, 6107.267127944675, 5552.805651802168, 6006.069059295816, 6204.627722336674, 6206.472449841814, 6222.688865556795, 5872.677002764889, 5908.05471124618, 5960.612560183574, 5966.403359663999, 6059.939400605937, 5915.053591425351, 5989.610675306091, 5991.610545314541, 5991.820245392645, 6019.367966363468, 5548.195511650707, 5725.5992080555625, 5740.3685594585395, 5846.123081537803, 5883.441073098049, 5920.200772895604, 6002.699865006645, 6008.128821320972, 6008.639481631116, 6032.75868965254, 5797.8550536236935, 5824.534037276923, 5851.736671849862, 5853.151293062397, 5873.0], "value": 5558.1149824513595, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.9286703428001, 493.83209708699036, 510.4558709902544, 519.4312228110219, 527.1065543903084, 38961.22077558451, 41969.79015104928, 42106.57893421065, 42134.36798448026, 42170.36744448836, 35802.74690385837, 42447.0, 43090.569094309045, 43123.13753724931, 43312.3503147453, 9704.272179586505, 9872.703818885446, 9916.10755032047, 9925.553350099226, 9963.0, 9850.950745246264, 9940.751481212956, 9942.304038717293, 9976.301658883882, 9976.401415915068, 9895.208383329353, 9922.057404546556, 9926.503674816231, 9958.402495850236, 9965.501724913762, 8411.579421028986, 8450.746477605682, 9701.223902087817, 9886.121636888967, 9898.406095634213, 8224.753257402228, 8249.876251856227, 8292.875606865902, 9827.803443931152, 9829.459379734111, 40086.59696910594, 40335.596644033474, 40426.0, 40504.0, 40651.59348406507, 2813.423248234107, 3226.838790994004, 3365.7643964922463, 3384.644612315696, 3473.70473509752, 31180.0, 31420.528692069638, 31871.362572748647, 32383.866564670123, 32568.185795355304, 3245.0589329094532, 3257.511373294025, 3263.689949454798, 3341.114604629775, 3343.3981883261004, 469552.0, 478272.0, 505096.0, 510413.0, 518494.03764905804, 62735.0, 63121.0, 63186.0, 63216.367836321966, 63348.366516334245, 61368.0, 62452.68773656194, 66202.66898665573, 66642.66678666575, 66794.66602667053, 15661.512156345128, 15962.36150553988, 16853.0, 16867.240974156193, 16908.90092144007, 12747.872521274669, 12935.741285174432, 13014.869851301366, 13022.47910083586, 13059.608211753663, 18419.889228323824, 19110.61778764417, 19298.614027719366, 19337.51656208606, 19436.90281548583, 7253.310935461122, 7992.283588131547, 8147.674093036212, 8154.959225203955, 8201.589920503951, 694.0734119949924, 763.6410886883156, 782.4444644302608, 799.3046049936593, 834.7787836223406, 24663.0, 29695.257618559277, 29962.951296704512, 30830.53754193689, 31039.0, 918.9386258871015, 935.4153653966271, 1036.4972988100765, 1055.2349546578669, 1081.416035340907, 13366.264855433044, 14008.299585020708, 14185.645358866112, 14504.0, 14729.779053314209, 612561.0, 613616.0, 615459.0, 621087.0, 621371.8931405314, 57844.421555783905, 57967.8406431869, 58091.12863307054, 58297.0, 58463.030642395875, 1203.8683637380834, 1309.2602679486251, 1367.705943222192, 1380.9723805524034, 1389.708161286121, 20359.59280814405, 22964.4258893529, 24154.91302891339, 24280.635790462802, 24388.87805561032, 51144.0, 51222.74388628033, 51393.743031284605, 51418.0, 51471.0, 424790.0, 426314.0, 547111.0, 547238.0, 549280.0, 22693.88653056724, 25864.353391165372, 26624.0, 26864.0, 27116.0, 46113.30830037619, 47190.0, 47338.816529587035, 47495.28757068716, 47720.2841957364, 35231.29537409186, 38821.41767873427, 38936.610633893295, 39161.60838391694, 40177.79911100426, 38646.22707545777, 38654.80672596619, 39379.80310098546, 39957.80021099876, 40239.0, 38234.23531529409, 38389.04027399337, 39009.6099039006, 39164.0, 41280.58719412888, 31331.84334078315, 34516.0, 35268.29463410769, 35272.82363588268, 35586.82206588951, 22893.198738044088, 25534.978600855757, 26057.869710651325, 26238.606420904085, 26487.07295244657], "value": 19660.79937089788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.56493603762846, 375.2682269574329, 376.3376457434915, 382.31183869035726, 402.54713447371705, 19549.0, 19975.300864469747, 20535.897320513413, 20873.0, 21013.0, 17352.392666256685, 20257.14642366746, 20418.69371959418, 20781.792182078174, 20784.584308313824, 5695.686737229451, 5809.3900140485275, 5983.461488466037, 6003.639781613096, 6106.572539922207, 3910.511186101737, 6116.4800991915745, 6148.8462788430425, 6168.660723660197, 6178.289496707869, 4085.2850751118585, 5877.735501902424, 6116.602420842631, 6164.7534098636, 6202.162708034402, 5909.113632955048, 6131.0, 6185.969070154621, 6189.381061893797, 6203.007518796993, 6002.579819412643, 6016.127661489059, 6029.758809647609, 6040.758369665208, 6052.878942421127, 12836.165649232864, 13006.024548158926, 13060.020498462653, 13355.866441335656, 13432.126911750705, 2171.0772921508456, 2290.404494831356, 2455.3247856839334, 2917.008217206139, 3012.9096127116222, 8322.542260175687, 9561.091696288911, 9632.373895696828, 9649.179819715333, 10009.899901001043, 1530.739774238382, 1847.2703282203588, 1857.2849452960572, 1902.876313039648, 1930.5656227348875, 127324.36337818344, 128640.0, 129460.0, 130652.99999999905, 131349.0, 9165.358424910326, 10332.605098311782, 11379.203455758183, 11400.657980260605, 11525.135614828921, 14187.64530886736, 14358.497452589108, 14367.2098034607, 14382.856171438361, 14388.712225755635, 6988.93011069893, 8064.959675201587, 8387.370947178986, 8559.0, 8684.348673849487, 7080.6105664187935, 7410.962465254868, 7595.0, 8469.618867150994, 8686.0, 4412.095520418371, 4484.596386325246, 4514.277715565494, 4573.291139873325, 4576.519465456146, 1582.2484319947932, 1609.1310692226066, 1888.6505996390438, 1900.5058684741791, 1928.3732786844332, 724.6304384763808, 855.4653341661461, 892.5046599137542, 916.0335845682736, 936.1153709744362, 20348.593028139356, 21004.159833606485, 21042.579148416946, 21254.25610103639, 21269.46826329354, 841.5371545649868, 933.1974501928472, 948.307735353196, 991.023841516106, 1008.2841182760176, 8650.0, 11174.329540227613, 11270.492827822767, 11282.887171128348, 11286.322820630789, 570854.0, 590283.0, 591323.0, 605372.0, 606694.0, 130308.3484582571, 131887.34056329657, 134597.0, 134896.0, 135620.0, 964.3587014635189, 970.7281961050917, 988.5255077562811, 989.6882482018285, 994.6966175316453, 15192.848071519586, 16777.91611041937, 18863.302302792814, 18931.242750290385, 18980.620387592448, 46710.927579414456, 49099.75450122727, 50526.242106367696, 53684.19473707819, 54741.72629136988, 77454.612726936, 77467.22532774825, 77700.445991081, 77882.22117778749, 78031.0, 7221.963890180516, 7261.019762332017, 7355.154157271768, 7420.0, 7526.13449453298, 9701.951490242503, 12576.559820406243, 12692.301923394301, 12909.612711618667, 13140.73718525605, 10920.962508561674, 11242.381669008282, 11350.262232954832, 11389.316641001566, 11453.59912403062, 10951.671449856518, 10955.671329860117, 11141.498632561716, 11360.715982100513, 11485.48315325829, 7724.0, 11106.61126860556, 11384.316940983568, 11482.770344592895, 11506.884931150582, 7317.085364329459, 7328.1938986712485, 7418.332350088518, 7471.551706897603, 7560.395168386406, 9899.307048506535, 11024.944875275893, 11312.321260724382, 11354.978051975362, 11420.086393088366], "value": 9260.156489318626, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1529.1971714849699, 1567.4984005118363, 1811.2030706489145, 1863.6831738604435, 1908.828205461509, 8069.596520173983, 8327.250547450743, 8528.403011789178, 9114.407563508375, 9120.543972801359, 8517.488950662964, 8865.955670221656, 8908.242799362062, 8946.955265223682, 8953.373263871532, 2324.709411323589, 2361.9763802362013, 2362.3621622162004, 2369.206315884181, 2382.094803974487, 2304.6082166031815, 2342.074880422232, 2346.9765302346927, 2360.3155085025323, 2361.315218586608, 2300.5283916797016, 2338.2634470141934, 2345.870977096259, 2354.5997180479358, 2361.551305251997, 1953.5311525233983, 2142.0146732503067, 2304.5045315257134, 2326.720793504773, 2331.8017968472614, 2321.593721098801, 2322.8490148140486, 2327.755585663515, 2330.5921463743775, 2334.4397344637337, 8852.51311177885, 8982.416142950753, 8988.865167022499, 9011.05383934684, 9051.728448146567, 5131.3329267195395, 5338.145896656516, 5347.491988261109, 5350.3312085989255, 5357.43746906577, 3488.773229740059, 3547.2018795770746, 3680.2271522980204, 3699.6855267302312, 3700.703943684499, 935.2798345274101, 1063.4151216830712, 1074.1997212077054, 1087.9020888120108, 1096.2874131814385, 11607.0, 11679.591214307458, 11693.649190524298, 11778.174382970568, 11795.882041179564, 4562.657800664963, 4616.584507394351, 4797.856064318076, 4827.61379089672, 4830.565249127595, 10005.549750261256, 10112.898871011343, 10137.0, 10152.441615711206, 10171.0, 5366.248725178478, 5389.083855744533, 5389.407165211824, 5390.353157621111, 5392.083345831218, 4445.244308467568, 4504.301833215857, 4591.311303304531, 4882.877928051827, 4938.4320803107385, 3781.7352785304765, 3818.713596480275, 3902.375619900802, 3903.1608204236227, 3976.304146774303, 1262.3814330977755, 1269.530273798682, 1277.9424925878359, 1284.7687416264976, 1290.0518119182393, 857.7941294089374, 860.644484936228, 892.6786356911507, 934.4674733437168, 941.8210539997378, 5541.002619528524, 5738.426157384311, 5762.0, 5994.220751302303, 6003.879922401527, 414.5626364185813, 416.22374271982534, 425.7828507461155, 427.46993727777334, 440.74877319927333, 3255.2187475006303, 3801.3727734923427, 3927.9018024549614, 3959.48526691534, 4015.31739604268, 10491.108255798343, 10703.983121603434, 10737.677869663923, 10865.185111116698, 10889.0, 10739.409332486632, 10800.405977671146, 10814.188935829845, 10820.02619764225, 10826.67519974402, 8113.6754529818145, 8198.016238051472, 8240.50556966572, 8288.627011784483, 8354.66581336752, 5374.57003439716, 5527.834164975057, 5591.133374326986, 5712.285964254468, 5973.671448070398, 9680.951595241979, 9973.102420782165, 10021.198304135505, 10038.749031273985, 10048.0, 8575.0, 10141.84787228207, 10245.282830202112, 10267.691969240936, 10305.433201174008, 6675.599464032173, 6854.2117656470145, 7248.637568121679, 7463.6641351140415, 7540.396768258636, 8261.545614990993, 8495.872561911452, 8561.743147705578, 8564.48613083217, 8567.614457349559, 7351.191368949304, 7439.107307123179, 7601.65792539326, 7668.348190403878, 7701.383889288955, 7285.8178545534665, 7445.9255407445235, 7448.851022979618, 7513.699452021858, 7576.810579735551, 5745.396733342939, 6090.634561926298, 6532.0, 6997.405220556309, 7039.577625342496, 4319.244132276902, 5067.847964561069, 5076.162433198629, 5124.666896651705, 5152.922706159336, 4535.705179163344, 4974.303597496281, 5040.9918016397605, 5214.061468935628, 5221.843344699665], "value": 4477.652280434301, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.5492282810535, 282.30271230061754, 300.44717719396306, 307.34995484550177, 311.507817648116, 4043.393490976355, 4201.70588058836, 5196.324477817888, 5257.684538927667, 5291.920621190676, 5156.742162891859, 5318.867028324294, 5383.43473935237, 5401.297831281938, 5421.83734487965, 3772.9812950503347, 3919.8432062717457, 3930.4693866327966, 4143.419921211025, 4145.3574695922025, 3403.842693484215, 3930.528336599612, 4120.114175452277, 4134.73124246923, 4153.439285696438, 3353.295807880348, 3744.606816284278, 4097.91804163918, 4103.466549348581, 4121.825279795244, 4067.2272268268935, 4102.138550904314, 4112.609302116294, 4113.9920719423635, 4122.670186385082, 3147.8426078695975, 3588.1209103769484, 3608.350496910555, 3616.1321282891918, 3624.6194149614175, 4786.2581299898575, 5173.715445650488, 5213.331733845171, 5240.34495688039, 5254.238135470336, 4184.644305234059, 4702.623790096784, 4728.493898233942, 4735.857924262244, 4739.73931433771, 5237.866890447345, 5645.717714114277, 5703.7148142592705, 5706.629069110494, 5718.225970859255, 3562.251927095313, 3621.8953219268114, 3827.75119617224, 3887.3391523441082, 3888.241792850395, 5894.734736936848, 5960.493358064569, 5977.5815692901515, 5999.310079340888, 6060.363661815534, 3687.2301295377833, 3827.6746476549247, 3904.1801221743754, 3904.6095390461296, 3937.7440466369594, 3679.3377192105677, 3896.2402331545077, 3918.8236529356245, 3961.485006949136, 3997.3004724173734, 3993.600639935983, 4037.8990525237105, 4581.496035436099, 4589.79345929434, 4594.862154135381, 5480.725963701799, 5688.459596338341, 5717.484866510378, 5728.99742545053, 5764.193012978187, 1079.5573814736078, 1182.1204285186595, 1272.5228039485194, 1307.9346032698327, 1348.966275843092, 771.2750014985895, 832.7259293281289, 866.7172584574864, 895.3106108296575, 911.7219248129384, 5245.816396426107, 5313.973430132824, 5338.46615338463, 5339.359276886721, 5350.197470379474, 4836.758162091881, 5176.628193528718, 5795.9420405796245, 5844.048755378507, 5846.619969701956, 4615.399998000238, 5077.8165388883135, 5284.920726189111, 5318.680879147263, 5367.651102678314, 2075.4603803011023, 2282.3609389371004, 2461.003293666068, 2560.655655780693, 2574.6009368547907, 4616.868867127575, 4701.764911754399, 4787.874849410386, 4892.951070489321, 4997.925031124536, 4602.884927876763, 4633.305004249322, 4912.263160525949, 4935.802567897315, 5008.774605142778, 3926.9214615706956, 4105.891409319467, 4275.444192254987, 4838.540338667821, 4994.525520075587, 4143.6892233083245, 4553.704009239521, 4632.907341853212, 4759.095771803346, 4812.446568644511, 3714.7555568884727, 4732.597729193058, 4795.136875362468, 4822.42130944289, 4831.622987448701, 3935.9409608855317, 4472.731636101845, 4667.8599642010795, 4682.859514214579, 5019.949800502094, 3361.336138611305, 3361.8737722863116, 3384.712299454574, 3394.8981530554124, 3395.3379091077004, 4306.590873866978, 4462.665300102441, 4769.809207631656, 4856.223004319292, 4886.364772579542, 4481.574250446202, 4951.227312704897, 5631.929933312657, 5643.5044713151865, 5652.85867853307, 4735.550122738335, 5379.569634429315, 5664.649170594157, 5699.492223421681, 5737.311522617312, 5347.251384806208, 5413.53984911287, 5516.227728117987, 5553.250311207935, 5617.354004289559, 5300.257963884982, 5312.140750737211, 5660.179274005164, 5704.771809127588, 5705.515031222392, 4930.852074437629, 5604.318704388748, 5613.270274864241, 5619.8595035124445, 5638.351589567253], "value": 3909.266857305466, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.2050321331976, 704.1374316462332, 708.2351060854278, 792.1761368177096, 809.0453265147128, 14934.25328733563, 15781.526554203378, 15801.683966320696, 15818.604534886634, 15819.84180158198, 12052.156349055569, 12077.214981026227, 12490.875091249085, 12751.744965100692, 13099.886509646667, 663.2969052804019, 681.2097966359024, 763.5647680821934, 822.2271065198709, 823.259066839843, 855.8630619100945, 858.5835869603237, 859.4284800607588, 859.8710193470966, 861.5519929636586, 721.6896734404204, 807.3097501636105, 874.3573473497006, 896.5875697179305, 911.9133682300204, 908.8636704494313, 909.9863502047475, 910.7176775199644, 910.8451563234266, 913.4199783137689, 559.4042344902666, 669.2704951602727, 676.5061505101254, 678.4030053552891, 678.4606238040769, 14487.492937747234, 14558.854411455855, 14565.053271537316, 14584.052036617586, 14593.9784215105, 13863.306834658328, 13992.0, 14231.0, 14388.0, 14476.493322733653, 10166.796664066751, 11687.06503479728, 11736.295822250693, 11757.059435245159, 11816.350100744456, 3775.7859158299807, 3807.3146833569945, 3813.161104556993, 3829.617038296148, 3856.768593884376, 116620.9539274999, 120233.0, 120613.0, 120889.99999999913, 122689.0, 9290.674826381044, 11122.721931951766, 11130.49912753928, 11303.208775385645, 11633.47649355764, 21675.241366552094, 22007.22974695878, 22037.559248814934, 22067.889660551595, 22107.005184766724, 7751.0, 7956.801079972931, 8005.679772809139, 8043.39674524413, 8175.754727358189, 4228.112096459717, 4357.085012147421, 4360.542143074995, 4363.738175709467, 4559.54404559548, 3483.9477407838904, 3601.603823579404, 3614.1326081740717, 3637.254362855608, 3646.6171052039685, 653.7090994507398, 661.2924171136838, 662.3442791636245, 681.6523572977817, 686.8317262270775, 506.5036264460849, 545.8662627656249, 588.7497813429276, 614.1299742284754, 636.8407898025494, 8632.437096470192, 9238.676646317346, 9278.257739380833, 9297.767555811024, 9370.95314523423, 567.986144731652, 574.6839238418853, 581.589645110605, 583.5739909865822, 607.5413063137303, 4302.741835489881, 4371.934420983688, 4466.0, 4554.772261386917, 4564.406627138517, 90596.0, 126399.73600264064, 142823.0, 162042.0, 166057.0, 124283.3785831065, 141478.0, 141792.0, 145443.0, 145713.0, 113438.0, 116093.4195329018, 117467.0, 119072.0, 122236.0, 6778.491613129134, 7013.6526443568655, 7455.589942552995, 7983.2415920487465, 8453.731940208772, 44339.77830110829, 51524.0, 55407.445925540225, 62454.126376208784, 64609.41562337642, 85921.0, 89924.0, 90978.0, 91227.54386228026, 95504.0, 13267.933660331637, 13288.335583220995, 13486.460541578226, 13559.661008474866, 13749.243791591158, 14680.779788303398, 14745.631359216106, 15098.54704358871, 15280.0, 15374.461893833663, 12018.579349722717, 12378.75242495163, 12526.311052892179, 12921.676958076123, 12935.547255846, 13866.584002479942, 13892.23592702411, 13932.93033534826, 13940.651483712989, 14286.214258215898, 13508.189508629514, 13618.114822536503, 13818.723625527233, 13831.377588008363, 14428.495002674856, 9344.439333640003, 10631.94684026575, 11003.559857605605, 11398.487068082122, 11524.481398337262, 8772.649094036422, 10577.576896924036, 11417.60038398652, 11663.183577149857, 11701.76596468083], "value": 7663.409526665986, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 119.0, 142.0, 117.0, 119.0, 119.0, 116.0, 118.0, 119.0, 126.0], "value": 120.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 114.0, 116.0, 149.0, 116.0, 116.0, 115.0, 117.0, 141.0, 113.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 205.0, 211.0, 218.0, 195.0, 196.0, 283.0, 251.0, 210.0, 201.0], "value": 216.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 81.0, 63.0, 51.0, 51.0, 51.0, 69.0, 84.0], "value": 65.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 87.0, 72.0, 69.0, 71.0, 87.0, 69.0, 71.0, 84.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 87.0, 111.0, 87.0, 91.0, 75.0, 137.0, 130.0], "value": 98.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 104.0, 96.0, 97.0, 97.0, 95.0, 96.0, 97.0, 97.0, 96.0], "value": 97.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 90.0, 91.0, 99.0, 89.0, 92.0, 91.0, 93.0, 91.0, 90.0], "value": 92.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 57.0, 58.0, 83.0, 87.0, 48.0, 49.0, 80.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 85.0, 123.0, 111.0, 106.0, 69.0, 71.0, 71.0, 72.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 92.0, 89.0, 86.0, 90.0, 90.0, 89.0, 96.0, 90.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 157.0, 166.0, 164.0, 140.0, 147.0, 146.0, 180.0, 148.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 177.0, 176.0, 182.0, 175.0, 172.0, 175.0, 180.0, 179.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 72.0, 69.0, 69.0, 68.0, 69.0, 71.0, 72.0, 68.0], "value": 69.9, "unit": "score"}]}]} 21:44:05 INFO - Return code: 0 21:44:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:44:05 ERROR - # TBPL SUCCESS # 21:44:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:44:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:44:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:44:05 INFO - 2016-10-03 21:44:05.661 screenresolution[1671:11332] starting screenresolution argv=screenresolution get 21:44:05 INFO - 2016-10-03 21:44:05.664 screenresolution[1671:11332] Display 0: 1600x1200x32@60 21:44:05 INFO - 2016-10-03 21:44:05.670 screenresolution[1672:11335] starting screenresolution argv=screenresolution list 21:44:05 INFO - Available Modes on Display 0 21:44:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:44:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:44:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:44:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:44:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:44:05 INFO - Intel Iris: 21:44:05 INFO - Chipset Model: Intel Iris 21:44:05 INFO - Type: GPU 21:44:05 INFO - Bus: Built-In 21:44:05 INFO - VRAM (Dynamic, Max): 1536 MB 21:44:05 INFO - Vendor: Intel (0x8086) 21:44:05 INFO - Device ID: 0x0a2e 21:44:05 INFO - Revision ID: 0x0009 21:44:05 INFO - Displays: 21:44:05 INFO - Display: 21:44:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:44:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:44:05 INFO - Display Serial Number: 1600x1200 60 21:44:05 INFO - Main Display: Yes 21:44:05 INFO - Mirror: Off 21:44:05 INFO - Online: Yes 21:44:05 INFO - Rotation: Supported 21:44:05 INFO - Return code: 0 21:44:05 INFO - Running post-action listener: _resource_record_post_action 21:44:05 INFO - [mozharness: 2016-10-04 04:44:05.910149Z] Finished run-tests step (success) 21:44:05 INFO - Running post-run listener: _resource_record_post_run 21:44:05 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 33686016; Write bytes: 710722560; Read time: 314; Write time: 1989 21:44:05 INFO - TinderboxPrint: CPU usage
54.6% 21:44:05 INFO - TinderboxPrint: I/O read bytes / time
33,686,016 / 314 21:44:05 INFO - TinderboxPrint: I/O write bytes / time
710,722,560 / 1,989 21:44:05 INFO - TinderboxPrint: CPU idle
2,199.8 (45.4%) 21:44:05 INFO - TinderboxPrint: CPU system
979.3 (20.2%) 21:44:05 INFO - TinderboxPrint: CPU user
1,662.5 (34.3%) 21:44:05 INFO - TinderboxPrint: Swap in / out
437,030,912 / 0 21:44:05 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 387535360; Write bytes: 381728768; Read time: 29452; Write time: 734 21:44:05 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 32756224; Write bytes: 300493824; Read time: 301; Write time: 1199 21:44:06 INFO - Running post-run listener: _upload_blobber_files 21:44:06 INFO - Blob upload gear active. 21:44:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:44:06 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 21:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:44:06 INFO - (blobuploader) - INFO - Open directory for files ... 21:44:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:44:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:44:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:44:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:44:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:44:08 INFO - (blobuploader) - INFO - Done attempting. 21:44:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:44:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:44:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:44:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:44:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:44:09 INFO - (blobuploader) - INFO - Done attempting. 21:44:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:44:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:44:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:44:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:44:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:44:11 INFO - (blobuploader) - INFO - Done attempting. 21:44:11 INFO - (blobuploader) - INFO - Iteration through files over. 21:44:11 INFO - Return code: 0 21:44:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:44:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:44:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ea87f2820b1209ab5c27ad4177cf6b865221db31c3c3fd62afecf7b1428132d187b173930d6ec731471cb18ec4697f46b9476f72e656698ec57e6498f8955cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a9f00ee1da8a824d0bf9883f03c81d9b28cc56a32b667faba01e0d190d767a8a7aad6a42b9cf6e169ce093d481a7984fb5e841c085f2234eefbf709fcd0829e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/34d22ffbbc440ecc8ea13c24f413c80fb05a812c0d681a9b91b1a50cae2a63c712d399440acaf2ddf146cf4689ad8138f9ebfed5e580db81d7d396ae68192e2a"} 21:44:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:44:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:44:11 INFO - Contents: 21:44:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ea87f2820b1209ab5c27ad4177cf6b865221db31c3c3fd62afecf7b1428132d187b173930d6ec731471cb18ec4697f46b9476f72e656698ec57e6498f8955cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a9f00ee1da8a824d0bf9883f03c81d9b28cc56a32b667faba01e0d190d767a8a7aad6a42b9cf6e169ce093d481a7984fb5e841c085f2234eefbf709fcd0829e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/34d22ffbbc440ecc8ea13c24f413c80fb05a812c0d681a9b91b1a50cae2a63c712d399440acaf2ddf146cf4689ad8138f9ebfed5e580db81d7d396ae68192e2a"} 21:44:11 INFO - Running post-run listener: copy_logs_to_upload_dir 21:44:11 INFO - Copying logs to upload dir... 21:44:11 INFO - mkdir: /builds/slave/test/build/upload/logs 21:44:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.506592 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-03 21:44:11.470046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 21:44:11.473113) ========= 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.5XcWMpBx2d/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.bkR2absSqE/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ea87f2820b1209ab5c27ad4177cf6b865221db31c3c3fd62afecf7b1428132d187b173930d6ec731471cb18ec4697f46b9476f72e656698ec57e6498f8955cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a9f00ee1da8a824d0bf9883f03c81d9b28cc56a32b667faba01e0d190d767a8a7aad6a42b9cf6e169ce093d481a7984fb5e841c085f2234eefbf709fcd0829e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/34d22ffbbc440ecc8ea13c24f413c80fb05a812c0d681a9b91b1a50cae2a63c712d399440acaf2ddf146cf4689ad8138f9ebfed5e580db81d7d396ae68192e2a"} build_url:https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/EGpAOAceQ8iNTG0tp5G7ZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ea87f2820b1209ab5c27ad4177cf6b865221db31c3c3fd62afecf7b1428132d187b173930d6ec731471cb18ec4697f46b9476f72e656698ec57e6498f8955cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a9f00ee1da8a824d0bf9883f03c81d9b28cc56a32b667faba01e0d190d767a8a7aad6a42b9cf6e169ce093d481a7984fb5e841c085f2234eefbf709fcd0829e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/34d22ffbbc440ecc8ea13c24f413c80fb05a812c0d681a9b91b1a50cae2a63c712d399440acaf2ddf146cf4689ad8138f9ebfed5e580db81d7d396ae68192e2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 21:44:11.505674) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:44:11.505972) ========= 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.5XcWMpBx2d/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.bkR2absSqE/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005187 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 21:44:11.554312) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 21:44:11.554620) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 21:44:11.554917) ========= ========= Total master_lag: 1.73 =========