builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0117 starttime: 1492858723.34 results: success (0) buildid: 20170422022220 builduid: b47f40732c8f4e36893d8bf79139e41e revision: 7d85b081bfabe91dbf18a421f1eee2a32f335823 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:43.340510) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:43.340949) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:43.341220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:43.369357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:43.369634) ========= 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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-22 03:58:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.5M=0.001s 2017-04-22 03:58:43 (21.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.523729 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:43.918177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:43.918490) ========= 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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.028271 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:43.969801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-22 03:58:43.970239) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7d85b081bfabe91dbf18a421f1eee2a32f335823 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7d85b081bfabe91dbf18a421f1eee2a32f335823 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.USJrvEcwEE/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.mK3bdY4Ttc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-22 03:58:44,035 truncating revision to first 12 chars 2017-04-22 03:58:44,035 Setting DEBUG logging. 2017-04-22 03:58:44,035 attempt 1/10 2017-04-22 03:58:44,036 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7d85b081bfab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-22 03:58:45,046 unpacking tar archive at: mozilla-central-7d85b081bfab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.288427 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-22 03:58:45.283049) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:45.283344) ========= script_repo_revision: 7d85b081bfabe91dbf18a421f1eee2a32f335823 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:45.283741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:45.284016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-22 03:58:45.303418) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-22 03:58:45.303772) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.USJrvEcwEE/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.mK3bdY4Ttc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:58:45 INFO - MultiFileLogger online at 20170422 03:58:45 in /builds/slave/test 03:58:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:58:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:58:45 INFO - {'append_to_log': False, 03:58:45 INFO - 'base_work_dir': '/builds/slave/test', 03:58:45 INFO - 'blob_upload_branch': 'Firefox', 03:58:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:58:45 INFO - 'branch': 'Firefox', 03:58:45 INFO - 'buildbot_json_path': 'buildprops.json', 03:58:45 INFO - 'config_files': ('talos/mac_config.py',), 03:58:45 INFO - 'default_actions': ('clobber', 03:58:45 INFO - 'read-buildbot-config', 03:58:45 INFO - 'download-and-extract', 03:58:45 INFO - 'populate-webroot', 03:58:45 INFO - 'create-virtualenv', 03:58:45 INFO - 'install', 03:58:45 INFO - 'run-tests'), 03:58:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:58:45 INFO - 'download_minidump_stackwalk': True, 03:58:45 INFO - 'download_symbols': 'ondemand', 03:58:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:58:45 INFO - 'tooltool.py': '/tools/tooltool.py', 03:58:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:58:45 INFO - '/tools/misc-python/virtualenv.py')}, 03:58:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:58:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:58:45 INFO - 'gecko_profile': False, 03:58:45 INFO - 'gecko_profile_interval': 0, 03:58:45 INFO - 'installer_path': 'installer.exe', 03:58:45 INFO - 'log_level': 'info', 03:58:45 INFO - 'log_name': 'talos', 03:58:45 INFO - 'log_to_console': True, 03:58:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:58:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:58:45 INFO - 'opt_config_files': (), 03:58:45 INFO - 'pip_index': False, 03:58:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:58:45 INFO - 'cmd': ('bash', 03:58:45 INFO - '-c', 03:58:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:58:45 INFO - 'enabled': True, 03:58:45 INFO - 'halt_on_failure': False, 03:58:45 INFO - 'name': 'check_screen_resolution'},), 03:58:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:58:45 INFO - 'cmd': ('bash', 03:58:45 INFO - '-c', 03:58:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:58:45 INFO - 'enabled': True, 03:58:45 INFO - 'halt_on_failure': False, 03:58:45 INFO - 'name': 'check_screen_resolution'},), 03:58:45 INFO - 'run_cmd_checks_enabled': True, 03:58:45 INFO - 'suite': 'dromaeojs-e10s', 03:58:45 INFO - 'system_bits': '32', 03:58:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:58:45 INFO - 'title': 't-yosemite-r7-0117', 03:58:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:58:45 INFO - 'use_talos_json': True, 03:58:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:58:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:58:45 INFO - 'work_dir': 'build'} 03:58:45 INFO - [mozharness: 2017-04-22 10:58:45.494463Z] Running clobber step. 03:58:45 INFO - Running pre-action listener: _resource_record_pre_action 03:58:45 INFO - Running main action method: clobber 03:58:45 INFO - rmtree: /builds/slave/test/build 03:58:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:58:47 INFO - Running post-action listener: _resource_record_post_action 03:58:47 INFO - [mozharness: 2017-04-22 10:58:47.931703Z] Finished clobber step (success) 03:58:47 INFO - [mozharness: 2017-04-22 10:58:47.931831Z] Running read-buildbot-config step. 03:58:47 INFO - Running pre-action listener: _resource_record_pre_action 03:58:47 INFO - Running main action method: read_buildbot_config 03:58:47 INFO - Using buildbot properties: 03:58:47 INFO - { 03:58:47 INFO - "project": "", 03:58:47 INFO - "product": "firefox", 03:58:47 INFO - "script_repo_revision": "production", 03:58:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:58:47 INFO - "repository": "", 03:58:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:58:47 INFO - "buildid": "20170422022220", 03:58:47 INFO - "pgo_build": "False", 03:58:47 INFO - "basedir": "/builds/slave/test", 03:58:47 INFO - "buildnumber": 37, 03:58:47 INFO - "slavename": "t-yosemite-r7-0117", 03:58:47 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 03:58:47 INFO - "platform": "yosemite_r7", 03:58:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:58:47 INFO - "branch": "mozilla-central", 03:58:47 INFO - "repo_path": "mozilla-central", 03:58:47 INFO - "revision": "7d85b081bfabe91dbf18a421f1eee2a32f335823", 03:58:47 INFO - "stage_platform": "macosx64", 03:58:47 INFO - "builduid": "b47f40732c8f4e36893d8bf79139e41e", 03:58:47 INFO - "slavebuilddir": "test" 03:58:47 INFO - } 03:58:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:58:47 INFO - Running post-action listener: _resource_record_post_action 03:58:47 INFO - [mozharness: 2017-04-22 10:58:47.935148Z] Finished read-buildbot-config step (success) 03:58:47 INFO - [mozharness: 2017-04-22 10:58:47.935285Z] Running download-and-extract step. 03:58:47 INFO - Running pre-action listener: _resource_record_pre_action 03:58:47 INFO - Running main action method: download_and_extract 03:58:47 INFO - mkdir: /builds/slave/test/build/tests 03:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:47 INFO - trying https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:58:47 INFO - Downloading https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:58:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 03:58:48 INFO - Downloaded 1325 bytes. 03:58:48 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:58:48 INFO - Using the following test package requirements: 03:58:48 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:48 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:58:48 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:58:48 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:48 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:58:48 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:48 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:58:48 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:48 INFO - u'jsshell-mac.zip'], 03:58:48 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:48 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:58:48 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:58:48 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:48 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:58:48 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:48 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:58:48 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:48 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:58:48 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:48 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:58:48 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:58:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:58:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:58:48 INFO - Fetch https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:58:50 INFO - Content-Length response header: 52526012 03:58:50 INFO - Bytes received: 52526012 03:59:06 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:59:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:59:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:59:06 INFO - Fetch https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:59:08 INFO - Content-Length response header: 52526012 03:59:08 INFO - Bytes received: 52526012 03:59:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:59:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:59:24 INFO - Fetch https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:59:25 INFO - Content-Length response header: 14408811 03:59:25 INFO - Bytes received: 14408811 03:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:25 INFO - trying https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:59:25 INFO - Downloading https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 03:59:27 INFO - Downloaded 71041581 bytes. 03:59:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:59:27 INFO - mkdir: /builds/slave/test/properties 03:59:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:59:27 INFO - Writing to file /builds/slave/test/properties/build_url 03:59:27 INFO - Contents: 03:59:27 INFO - build_url:https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:59:28 INFO - Running post-action listener: _resource_record_post_action 03:59:28 INFO - Running post-action listener: set_extra_try_arguments 03:59:28 INFO - [mozharness: 2017-04-22 10:59:28.224857Z] Finished download-and-extract step (success) 03:59:28 INFO - [mozharness: 2017-04-22 10:59:28.224987Z] Running populate-webroot step. 03:59:28 INFO - Running pre-action listener: _resource_record_pre_action 03:59:28 INFO - Running main action method: populate_webroot 03:59:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:59:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:59:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:59:28 INFO - '--tppagecycles', 03:59:28 INFO - '7'], 03:59:28 INFO - 'tests': ['tsvgm']}}, 03:59:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:59:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:59:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:59:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:59:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:59:28 INFO - 'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:59:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:59:28 INFO - 'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['damp', 'tps']}, 03:59:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:59:28 INFO - 'tests': ['damp', 'tps']}, 03:59:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['dromaeo_dom']}, 03:59:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:59:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:59:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['a11yr', 03:59:28 INFO - 'ts_paint', 03:59:28 INFO - 'tpaint', 03:59:28 INFO - 'sessionrestore', 03:59:28 INFO - 'sessionrestore_no_auto_restore', 03:59:28 INFO - 'tabpaint']}, 03:59:28 INFO - 'other-e10s': {'tests': ['a11yr', 03:59:28 INFO - 'ts_paint', 03:59:28 INFO - 'tpaint', 03:59:28 INFO - 'sessionrestore', 03:59:28 INFO - 'sessionrestore_no_auto_restore', 03:59:28 INFO - 'tabpaint']}, 03:59:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:59:28 INFO - 'ts_paint', 03:59:28 INFO - 'tpaint', 03:59:28 INFO - 'sessionrestore', 03:59:28 INFO - 'sessionrestore_no_auto_restore', 03:59:28 INFO - 'tabpaint']}, 03:59:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:59:28 INFO - 'ts_paint', 03:59:28 INFO - 'tpaint', 03:59:28 INFO - 'sessionrestore', 03:59:28 INFO - 'sessionrestore_no_auto_restore', 03:59:28 INFO - 'tabpaint']}, 03:59:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['a11yr', 03:59:28 INFO - 'ts_paint', 03:59:28 INFO - 'tpaint', 03:59:28 INFO - 'sessionrestore', 03:59:28 INFO - 'sessionrestore_no_auto_restore', 03:59:28 INFO - 'tabpaint']}, 03:59:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['a11yr', 03:59:28 INFO - 'ts_paint', 03:59:28 INFO - 'tpaint', 03:59:28 INFO - 'sessionrestore', 03:59:28 INFO - 'sessionrestore_no_auto_restore', 03:59:28 INFO - 'tabpaint']}, 03:59:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:59:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:59:28 INFO - 'bloom_basic_ref']}, 03:59:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['tsvgx', 03:59:28 INFO - 'tsvgr_opacity', 03:59:28 INFO - 'tart', 03:59:28 INFO - 'tscrollx', 03:59:28 INFO - 'cart', 03:59:28 INFO - 'tsvg_static']}, 03:59:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:59:28 INFO - 'tsvgr_opacity', 03:59:28 INFO - 'tart', 03:59:28 INFO - 'tscrollx', 03:59:28 INFO - 'cart', 03:59:28 INFO - 'tsvg_static']}, 03:59:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:59:28 INFO - 'talos_options': ['--disable-e10s'], 03:59:28 INFO - 'tests': ['tp5o']}, 03:59:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:59:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:59:28 INFO - 'talos_options': ['--disable-e10s', 03:59:28 INFO - '--xperf_path', 03:59:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:28 INFO - 'tests': ['tp5n']}, 03:59:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:59:28 INFO - 'talos_options': ['--xperf_path', 03:59:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:28 INFO - 'tests': ['tp5n']}}, 03:59:28 INFO - 'talos.zip': {'path': '', 03:59:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:59:28 INFO - Running post-action listener: _resource_record_post_action 03:59:28 INFO - [mozharness: 2017-04-22 10:59:28.244219Z] Finished populate-webroot step (success) 03:59:28 INFO - [mozharness: 2017-04-22 10:59:28.244330Z] Running create-virtualenv step. 03:59:28 INFO - Running pre-action listener: _resource_record_pre_action 03:59:28 INFO - Running main action method: create_virtualenv 03:59:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:59:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:59:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:59:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:28 INFO - Using real prefix '/tools/python27' 03:59:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:59:29 INFO - Installing distribute.............................................................................................................................................................................................done. 03:59:31 INFO - Installing pip.................done. 03:59:31 INFO - Return code: 0 03:59:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:59:32 INFO - Reading from file tmpfile_stdout 03:59:32 INFO - Output received: 03:59:32 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) 03:59:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98dacbad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, '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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:59: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', 'pip>=1.5'] in /builds/slave/test/build 03:59: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 pip>=1.5 03:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 03:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:32 INFO - 'HOME': '/Users/cltbld', 03:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:32 INFO - 'LOGNAME': 'cltbld', 03:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:32 INFO - 'MOZ_NO_REMOTE': '1', 03:59:32 INFO - 'NO_EM_RESTART': '1', 03:59:32 INFO - 'PAGER': '/bin/cat', 03:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:32 INFO - 'PWD': '/builds/slave/test', 03:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:32 INFO - 'SHELL': '/bin/bash', 03:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 03:59:32 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 03:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:32 INFO - 'USER': 'cltbld', 03:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:32 INFO - 'XPC_FLAGS': '0x0', 03:59:32 INFO - 'XPC_SERVICE_NAME': '0', 03:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:59:32 INFO - Cleaning up... 03:59:32 INFO - Return code: 0 03:59:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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', '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 0x10c4d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98dacbad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, '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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:59: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:59: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 psutil>=3.1.1 03:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 03:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:32 INFO - 'HOME': '/Users/cltbld', 03:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:32 INFO - 'LOGNAME': 'cltbld', 03:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:32 INFO - 'MOZ_NO_REMOTE': '1', 03:59:32 INFO - 'NO_EM_RESTART': '1', 03:59:32 INFO - 'PAGER': '/bin/cat', 03:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:32 INFO - 'PWD': '/builds/slave/test', 03:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:32 INFO - 'SHELL': '/bin/bash', 03:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 03:59:32 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 03:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:32 INFO - 'USER': 'cltbld', 03:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:32 INFO - 'XPC_FLAGS': '0x0', 03:59:32 INFO - 'XPC_SERVICE_NAME': '0', 03:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:32 INFO - Downloading/unpacking psutil>=3.1.1 03:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:36 INFO - Installing collected packages: psutil 03:59:36 INFO - Running setup.py install for psutil 03:59:36 INFO - building 'psutil._psutil_osx' extension 03:59:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:59:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:59:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:59:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:59:37 INFO - building 'psutil._psutil_posix' extension 03:59:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:59:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:59:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:59:37 INFO - ^ 03:59:37 INFO - 1 warning generated. 03:59:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:59:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:37 INFO - Successfully installed psutil 03:59:37 INFO - Cleaning up... 03:59:38 INFO - Return code: 0 03:59:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98dacbad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, '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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 03:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:38 INFO - 'HOME': '/Users/cltbld', 03:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:38 INFO - 'LOGNAME': 'cltbld', 03:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:38 INFO - 'MOZ_NO_REMOTE': '1', 03:59:38 INFO - 'NO_EM_RESTART': '1', 03:59:38 INFO - 'PAGER': '/bin/cat', 03:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:38 INFO - 'PWD': '/builds/slave/test', 03:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:38 INFO - 'SHELL': '/bin/bash', 03:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 03:59:38 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 03:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:38 INFO - 'USER': 'cltbld', 03:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:38 INFO - 'XPC_FLAGS': '0x0', 03:59:38 INFO - 'XPC_SERVICE_NAME': '0', 03:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:59:40 INFO - Installing collected packages: mozsystemmonitor 03:59:40 INFO - Running setup.py install for mozsystemmonitor 03:59:41 INFO - Successfully installed mozsystemmonitor 03:59:41 INFO - Cleaning up... 03:59:41 INFO - Return code: 0 03:59:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98dacbad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, '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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 03:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:41 INFO - 'HOME': '/Users/cltbld', 03:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:41 INFO - 'LOGNAME': 'cltbld', 03:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:41 INFO - 'MOZ_NO_REMOTE': '1', 03:59:41 INFO - 'NO_EM_RESTART': '1', 03:59:41 INFO - 'PAGER': '/bin/cat', 03:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:41 INFO - 'PWD': '/builds/slave/test', 03:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:41 INFO - 'SHELL': '/bin/bash', 03:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 03:59:41 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 03:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:41 INFO - 'USER': 'cltbld', 03:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:41 INFO - 'XPC_FLAGS': '0x0', 03:59:41 INFO - 'XPC_SERVICE_NAME': '0', 03:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:41 INFO - Downloading/unpacking jsonschema==2.5.1 03:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:44 INFO - warning: no files found matching '*.txt' 03:59:44 INFO - no previously-included directories found matching 'build' 03:59:44 INFO - no previously-included directories found matching 'dist' 03:59:44 INFO - no previously-included directories found matching '.git*' 03:59:44 INFO - Installing collected packages: jsonschema, functools32 03:59:44 INFO - Running setup.py install for functools32 03:59:44 INFO - warning: no files found matching '*.txt' 03:59:44 INFO - no previously-included directories found matching 'build' 03:59:44 INFO - no previously-included directories found matching 'dist' 03:59:44 INFO - no previously-included directories found matching '.git*' 03:59:44 INFO - Successfully installed jsonschema functools32 03:59:44 INFO - Cleaning up... 03:59:44 INFO - Return code: 0 03:59:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:44 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 0x10c4d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98dacbad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, '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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 03:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:44 INFO - 'HOME': '/Users/cltbld', 03:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:44 INFO - 'LOGNAME': 'cltbld', 03:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:44 INFO - 'MOZ_NO_REMOTE': '1', 03:59:44 INFO - 'NO_EM_RESTART': '1', 03:59:44 INFO - 'PAGER': '/bin/cat', 03:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:44 INFO - 'PWD': '/builds/slave/test', 03:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:44 INFO - 'SHELL': '/bin/bash', 03:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 03:59:44 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 03:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:44 INFO - 'USER': 'cltbld', 03:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:44 INFO - 'XPC_FLAGS': '0x0', 03:59:44 INFO - 'XPC_SERVICE_NAME': '0', 03:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:59:45 INFO - Cleaning up... 03:59:45 INFO - Return code: 0 03:59:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98dacbad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, '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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:59:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 03:59:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:45 INFO - 'HOME': '/Users/cltbld', 03:59:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:45 INFO - 'LOGNAME': 'cltbld', 03:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:45 INFO - 'MOZ_NO_REMOTE': '1', 03:59:45 INFO - 'NO_EM_RESTART': '1', 03:59:45 INFO - 'PAGER': '/bin/cat', 03:59:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:45 INFO - 'PWD': '/builds/slave/test', 03:59:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:45 INFO - 'SHELL': '/bin/bash', 03:59:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 03:59:45 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 03:59:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:45 INFO - 'USER': 'cltbld', 03:59:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:45 INFO - 'XPC_FLAGS': '0x0', 03:59:45 INFO - 'XPC_SERVICE_NAME': '0', 03:59:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:48 INFO - Downloading blobuploader-1.2.4.tar.gz 03:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:59:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:59:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:49 INFO - Downloading docopt-0.6.1.tar.gz 03:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:59:49 INFO - Installing collected packages: blobuploader, requests, docopt 03:59:49 INFO - Running setup.py install for blobuploader 03:59:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:59:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:59:49 INFO - Running setup.py install for requests 03:59:49 INFO - Running setup.py install for docopt 03:59:50 INFO - Successfully installed blobuploader requests docopt 03:59:50 INFO - Cleaning up... 03:59:50 INFO - Return code: 0 03:59:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98dacbad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, '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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 03:59:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:50 INFO - 'HOME': '/Users/cltbld', 03:59:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:50 INFO - 'LOGNAME': 'cltbld', 03:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:50 INFO - 'MOZ_NO_REMOTE': '1', 03:59:50 INFO - 'NO_EM_RESTART': '1', 03:59:50 INFO - 'PAGER': '/bin/cat', 03:59:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:50 INFO - 'PWD': '/builds/slave/test', 03:59:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:50 INFO - 'SHELL': '/bin/bash', 03:59:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 03:59:50 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 03:59:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:50 INFO - 'USER': 'cltbld', 03:59:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:50 INFO - 'XPC_FLAGS': '0x0', 03:59:50 INFO - 'XPC_SERVICE_NAME': '0', 03:59:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:50 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-yXmJwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:50 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-oN1xmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:50 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-V957JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:50 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-374X59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:50 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Sgnjw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:50 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-xGmT7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:51 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-LaXfhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:51 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-61WImE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:51 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-90j9k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:51 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-C2FH6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:51 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-K5tUOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:51 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-RNuoDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:51 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-zozJcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:51 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-IniioN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:51 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-UIEb9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:52 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-7x90Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:52 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-xyX6Tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:59:52 INFO - Running setup.py install for manifestparser 03:59:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:59:52 INFO - Running setup.py install for mozcrash 03:59:52 INFO - Running setup.py install for mozdebug 03:59:52 INFO - Running setup.py install for mozdevice 03:59:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:59:52 INFO - Running setup.py install for mozfile 03:59:52 INFO - Running setup.py install for mozhttpd 03:59:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:59:53 INFO - Running setup.py install for mozinfo 03:59:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:59:53 INFO - Running setup.py install for mozInstall 03:59:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:59:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:59:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:59:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:59:53 INFO - Running setup.py install for mozleak 03:59:53 INFO - Running setup.py install for mozlog 03:59:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:59:53 INFO - Running setup.py install for moznetwork 03:59:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:59:53 INFO - Running setup.py install for mozprocess 03:59:53 INFO - Running setup.py install for mozprofile 03:59:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:59:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:59:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:59:54 INFO - Running setup.py install for mozrunner 03:59:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:59:54 INFO - Running setup.py install for mozscreenshot 03:59:54 INFO - Running setup.py install for moztest 03:59:54 INFO - Running setup.py install for mozversion 03:59:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:59:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:54 INFO - Cleaning up... 03:59:54 INFO - Return code: 0 03:59:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:54 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 0x10c4d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98dacbad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, '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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 03:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:54 INFO - 'HOME': '/Users/cltbld', 03:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:54 INFO - 'LOGNAME': 'cltbld', 03:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:54 INFO - 'MOZ_NO_REMOTE': '1', 03:59:54 INFO - 'NO_EM_RESTART': '1', 03:59:54 INFO - 'PAGER': '/bin/cat', 03:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:54 INFO - 'PWD': '/builds/slave/test', 03:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:54 INFO - 'SHELL': '/bin/bash', 03:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 03:59:54 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 03:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:54 INFO - 'USER': 'cltbld', 03:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:54 INFO - 'XPC_FLAGS': '0x0', 03:59:54 INFO - 'XPC_SERVICE_NAME': '0', 03:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:55 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-GtNgaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:55 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-_t3jXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:55 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-fXxZdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:55 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-xI6LDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:55 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Ty7hq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:55 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-9CXVVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:55 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-jIdyWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:55 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-AAmU4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:55 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-ARSAQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:55 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-GinwZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:56 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-BjiwUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:56 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-y73Bji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:56 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-VfzDwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:56 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-M8lHbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:56 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-UVf3Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:56 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-C1ZuaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:56 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-ojOh67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:59:56 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:56 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:59 INFO - Downloading blessings-1.6.tar.gz 03:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:59 INFO - Installing collected packages: blessings 03:59:59 INFO - Running setup.py install for blessings 03:59:59 INFO - Successfully installed blessings 03:59:59 INFO - Cleaning up... 03:59:59 INFO - Return code: 0 03:59:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:00 INFO - Reading from file tmpfile_stdout 04:00:00 INFO - Current package versions: 04:00:00 INFO - blessings == 1.6 04:00:00 INFO - blobuploader == 1.2.4 04:00:00 INFO - docopt == 0.6.1 04:00:00 INFO - functools32 == 3.2.3-2 04:00:00 INFO - jsonschema == 2.5.1 04:00:00 INFO - manifestparser == 1.1 04:00:00 INFO - mozInstall == 1.12 04:00:00 INFO - mozcrash == 1.0 04:00:00 INFO - mozdebug == 0.1 04:00:00 INFO - mozdevice == 0.50 04:00:00 INFO - mozfile == 1.2 04:00:00 INFO - mozhttpd == 0.7 04:00:00 INFO - mozinfo == 0.9 04:00:00 INFO - mozleak == 0.1 04:00:00 INFO - mozlog == 3.4 04:00:00 INFO - moznetwork == 0.27 04:00:00 INFO - mozprocess == 0.25 04:00:00 INFO - mozprofile == 0.28 04:00:00 INFO - mozrunner == 6.13 04:00:00 INFO - mozscreenshot == 0.1 04:00:00 INFO - mozsystemmonitor == 0.3 04:00:00 INFO - moztest == 0.8 04:00:00 INFO - mozversion == 1.4 04:00:00 INFO - psutil == 3.1.1 04:00:00 INFO - requests == 1.2.3 04:00:00 INFO - wsgiref == 0.1.2 04:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:00 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 0x10c4d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98dacbad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, '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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 04:00:00 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 04:00:00 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 04:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 04:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:00:00 INFO - 'HOME': '/Users/cltbld', 04:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:00:00 INFO - 'LOGNAME': 'cltbld', 04:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:00 INFO - 'MOZ_NO_REMOTE': '1', 04:00:00 INFO - 'NO_EM_RESTART': '1', 04:00:00 INFO - 'PAGER': '/bin/cat', 04:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:00 INFO - 'PWD': '/builds/slave/test', 04:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:00:00 INFO - 'SHELL': '/bin/bash', 04:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 04:00:00 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 04:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:00:00 INFO - 'USER': 'cltbld', 04:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:00 INFO - 'XPC_FLAGS': '0x0', 04:00:00 INFO - 'XPC_SERVICE_NAME': '0', 04:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 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)) 04:00:00 INFO - Cleaning up... 04:00:00 INFO - Return code: 0 04:00:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:00 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 0x10c4d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98dacbad00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, '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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 04:00:00 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 04:00:00 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 04:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 04:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:00:00 INFO - 'HOME': '/Users/cltbld', 04:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:00:00 INFO - 'LOGNAME': 'cltbld', 04:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:00 INFO - 'MOZ_NO_REMOTE': '1', 04:00:00 INFO - 'NO_EM_RESTART': '1', 04:00:00 INFO - 'PAGER': '/bin/cat', 04:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:00 INFO - 'PWD': '/builds/slave/test', 04:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:00:00 INFO - 'SHELL': '/bin/bash', 04:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 04:00:00 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 04:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:00:00 INFO - 'USER': 'cltbld', 04:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:00 INFO - 'XPC_FLAGS': '0x0', 04:00:00 INFO - 'XPC_SERVICE_NAME': '0', 04:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:00:00 INFO - Cleaning up... 04:00:00 INFO - Return code: 0 04:00:00 INFO - Running post-action listener: _resource_record_post_action 04:00:00 INFO - Running post-action listener: _start_resource_monitoring 04:00:00 INFO - Starting resource monitoring. 04:00:00 INFO - [mozharness: 2017-04-22 11:00:00.655561Z] Finished create-virtualenv step (success) 04:00:00 INFO - [mozharness: 2017-04-22 11:00:00.656519Z] Running install step. 04:00:00 INFO - Running pre-action listener: _resource_record_pre_action 04:00:00 INFO - Running main action method: install 04:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:00 INFO - Reading from file tmpfile_stdout 04:00:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:01 INFO - Reading from file tmpfile_stdout 04:00:01 INFO - Output received: 04:00:01 INFO - Usage: mozinstall [options] installer 04:00:01 INFO - Options: 04:00:01 INFO - -h, --help show this help message and exit 04:00:01 INFO - -d DEST, --destination=DEST 04:00:01 INFO - Directory to install application into. [default: 04:00:01 INFO - "/builds/slave/test"] 04:00:01 INFO - --app=APP Application being installed. [default: firefox] 04:00:01 INFO - mkdir: /builds/slave/test/build/application 04:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:00:20 INFO - Reading from file tmpfile_stdout 04:00:20 INFO - Output received: 04:00:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:00:20 INFO - Running post-action listener: _resource_record_post_action 04:00:20 INFO - [mozharness: 2017-04-22 11:00:20.815367Z] Finished install step (success) 04:00:20 INFO - [mozharness: 2017-04-22 11:00:20.815494Z] Running run-tests step. 04:00:20 INFO - Running pre-action listener: _resource_record_pre_action 04:00:20 INFO - Running main action method: run_tests 04:00:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:00:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:00:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:00:20 INFO - 2017-04-22 04:00:20.830 screenresolution[1658:9114] starting screenresolution argv=screenresolution get 04:00:20 INFO - 2017-04-22 04:00:20.832 screenresolution[1658:9114] Display 0: 1600x1200x32@60 04:00:20 INFO - 2017-04-22 04:00:20.838 screenresolution[1659:9117] starting screenresolution argv=screenresolution list 04:00:20 INFO - Available Modes on Display 0 04:00:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:00:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:00:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:00:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:00:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:00:21 INFO - Intel Iris: 04:00:21 INFO - Chipset Model: Intel Iris 04:00:21 INFO - Type: GPU 04:00:21 INFO - Bus: Built-In 04:00:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:00:21 INFO - Vendor: Intel (0x8086) 04:00:21 INFO - Device ID: 0x0a2e 04:00:21 INFO - Revision ID: 0x0009 04:00:21 INFO - Displays: 04:00:21 INFO - Display: 04:00:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:00:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:00:21 INFO - Display Serial Number: 1600x1200 60 04:00:21 INFO - Main Display: Yes 04:00:21 INFO - Mirror: Off 04:00:21 INFO - Online: Yes 04:00:21 INFO - Rotation: Supported 04:00:21 INFO - Return code: 0 04:00:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:00:21 INFO - Python 2.7.3 04:00:21 INFO - Return code: 0 04:00:21 INFO - grabbing minidump binary from tooltool 04:00:21 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')]} 04:00:21 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 0x10c2b3d30>, '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 0x10c1d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:00:21 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 04:00:21 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 04:00:21 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 04:00:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:21 INFO - Return code: 0 04:00:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:00:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:00:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:00:21 INFO - ENV: RUST_BACKTRACE is now 1 04:00:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:00:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:00:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 04:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0117 --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 04:00:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USJrvEcwEE/Render', 04:00:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:00:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:00:21 INFO - 'HOME': '/Users/cltbld', 04:00:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:00:21 INFO - 'LOGNAME': 'cltbld', 04:00:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:21 INFO - 'MOZ_NO_REMOTE': '1', 04:00:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:21 INFO - 'NO_EM_RESTART': '1', 04:00:21 INFO - 'PAGER': '/bin/cat', 04:00:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:21 INFO - 'PWD': '/builds/slave/test', 04:00:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:00:21 INFO - 'RUST_BACKTRACE': '1', 04:00:21 INFO - 'SHELL': '/bin/bash', 04:00:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mK3bdY4Ttc/Listeners', 04:00:21 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 04:00:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:00:21 INFO - 'USER': 'cltbld', 04:00:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:00:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:21 INFO - 'XPC_FLAGS': '0x0', 04:00:21 INFO - 'XPC_SERVICE_NAME': '0', 04:00:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:00:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 04:00:21 INFO - mozversion application_buildid: 20170422022220 04:00:21 INFO - mozversion application_changeset: 7d85b081bfabe91dbf18a421f1eee2a32f335823 04:00:21 INFO - mozversion application_display_name: Nightly 04:00:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:21 INFO - mozversion application_name: Firefox 04:00:21 INFO - mozversion application_remotingname: firefox 04:00:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:00:21 INFO - mozversion application_vendor: Mozilla 04:00:21 INFO - mozversion application_version: 55.0a1 04:00:21 INFO - mozversion platform_buildid: 20170422022220 04:00:21 INFO - mozversion platform_changeset: 7d85b081bfabe91dbf18a421f1eee2a32f335823 04:00:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:00:21 INFO - mozversion platform_version: 55.0a1 04:00:21 INFO - using testdate: 1492858821 04:00:21 INFO - actual date: 1492858821 04:00:21 INFO - starting webserver on 'localhost:49249' 04:00:21 INFO - SUITE-START | Running 2 tests 04:00:21 INFO - TEST-START | dromaeo_css 04:00:21 INFO - operating with platform_type : mac_ 04:00:21 INFO - Initialising browser for dromaeo_css test... 04:00:21 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmphzdzBB/profile http://localhost:49249/getInfo.html) 04:00:24 INFO - PID 1669 | 2017-04-22 04:00:24.171 plugin-container[1671:9310] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9943, name = 'com.apple.tsm.portname' 04:00:24 INFO - PID 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:00:24 INFO - PID 1669 | 2017-04-22 04:00:24.175 plugin-container[1671:9310] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f03, name = 'com.apple.CFPasteboardClient' 04:00:24 INFO - PID 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:00:24 INFO - PID 1669 | 2017-04-22 04:00:24.175 plugin-container[1671:9310] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:00:24 INFO - PID 1669 | __metrics Screen width/height:1600/1200 04:00:24 INFO - PID 1669 | colorDepth:24 04:00:24 INFO - PID 1669 | Browser inner width/height: 1024/689 04:00:24 INFO - PID 1669 | __metrics 04:00:24 ERROR - PID 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 04:00:25 INFO - TEST-INFO | 1669: exit 0 04:00:25 INFO - Browser initialized. 04:00:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:25 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmphzdzBB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:27 INFO - PID 1673 | 2017-04-22 04:00:27.910 plugin-container[1675:9564] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a43, name = 'com.apple.tsm.portname' 04:00:27 INFO - PID 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:00:27 INFO - PID 1673 | 2017-04-22 04:00:27.911 plugin-container[1675:9564] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 04:00:27 INFO - PID 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:00:27 INFO - PID 1673 | 2017-04-22 04:00:27.911 plugin-container[1675:9564] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:00:37 INFO - PID 1673 | RSS: Main: 237035520 04:00:37 INFO - PID 1673 | 04:03:41 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 04:03:43 INFO - PID 1673 | RSS: Main: 252370944 04:03:43 INFO - PID 1673 | 04:05:25 INFO - PID 1673 | ************************* 04:05:25 INFO - PID 1673 | A coding exception was thrown and uncaught in a Task. 04:05:25 INFO - PID 1673 | 04:05:25 ERROR - PID 1673 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:05:25 INFO - PID 1673 | Full stack: 04:05:25 INFO - PID 1673 | ************************* 04:05:25 INFO - PID 1673 | ************************* 04:05:25 INFO - PID 1673 | A coding exception was thrown and uncaught in a Task. 04:05:25 INFO - PID 1673 | 04:05:25 ERROR - PID 1673 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:05:25 INFO - PID 1673 | Full stack: 04:05:25 INFO - PID 1673 | ************************* 04:05:25 INFO - PID 1673 | ************************* 04:05:25 INFO - PID 1673 | A coding exception was thrown and uncaught in a Task. 04:05:25 INFO - PID 1673 | 04:05:25 ERROR - PID 1673 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:05:25 INFO - PID 1673 | Full stack: 04:05:25 INFO - PID 1673 | ************************* 04:05:25 INFO - PID 1673 | ************************* 04:05:25 INFO - PID 1673 | A coding exception was thrown and uncaught in a Task. 04:05:25 INFO - PID 1673 | 04:05:25 ERROR - PID 1673 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:05:25 INFO - PID 1673 | Full stack: 04:05:25 INFO - PID 1673 | ************************* 04:06:44 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 04:06:45 INFO - PID 1673 | RSS: Main: 258646016 04:06:45 INFO - PID 1673 | 04:09:47 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 04:09:48 INFO - PID 1673 | RSS: Main: 268382208 04:09:48 INFO - PID 1673 | 04:12:49 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 04:12:50 INFO - PID 1673 | RSS: Main: 260771840 04:12:50 INFO - PID 1673 | 04:15:53 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 04:15:53 INFO - PID 1673 | RSS: Main: 270143488 04:15:53 INFO - PID 1673 | 04:18:55 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 04:18:56 INFO - PID 1673 | RSS: Main: 265220096 04:18:56 INFO - PID 1673 | 04:18:56 INFO - PID 1673 | __start_tp_report 04:18:56 INFO - PID 1673 | _x_x_mozilla_page_load 04:18:56 INFO - PID 1673 | _x_x_mozilla_page_load_details 04:18:56 INFO - PID 1673 | |i|pagename|runs| 04:18:56 INFO - PID 1673 | |0;dojo.html;3038.3467554475787;3470.7331823884274;3526.911827204321;3611.1513794258353;3641.28994846005;6034.034554471285;6095.75616975321;6168.845778855531;6211.689415529222;6244.313125556197;6124.289394097922;6132.722655450954;6148.678034222641;6217.5958562693395;6238.689875126218;4268.253055715238;5258.55302299305;5415.160650099241;5437.510624043835;5529.917051244234;5369.973150134244;5430.212619170218;5522.585806064541;5529.115341545354;5560.277163968699;5332.253484512172;5384.892302153935;5470.261514695545;5475.5072043516275;5496.780128794843;5415.9458405415835;5440.6735595864375;5455.018096742585;5456.181572764078;5493.313335833021;5325.094733895208;5396.568274538027;5416.8104116356135;5419.810306639249;5463.808766693186;5973.970130149365;6069.605475644069;6137.846553836145;6137.989923150287;6200.379962003809;6636.402723754837;6702.731890724365;6711.261761206263;6715.630640314781;6717.764878229287;6776.661166941633;6803.455723542154;6811.114555107804;6819.488538359593;6829.043933849265;6121.326654068049;6197.03945888388;6243.43809057178;6352.078948552434;6365.458935990447;6833.692483838239;6856.5200435969;6884.827879303058;6898.620575868375;6901.275366086589;6293.244810622755;6344.333844946306;6377.5216858735785;6511.3163117871945;6574.079628851964;6547.9672601636685;6629.171353580802;6732.730690772412;6748.595084294958;6786.185657721105;6398.744050237939;6657.068010478537;6660.800175994728;6660.966695166493;6680.766173183915;6468.126802881551;6566.67166641666;6574.211094668671;6661;6677.399034086956;4474.194644963938;4488.910221795546;5288.206768984606;5305.761240744176;5305.920411193835;4750.572448479585;4752.643551733634;4761.047790441926;4763.95236047642;4770.069836381872;5098.898022039539;6117.675163990694;6129.8784197560135;6288.182536270256;6312.621242725451;6375.724855029012;6753.257141714407;6784.694688739019;6786.423154031962;6788.456923446112;5530.917036244459;6232.470240029557;6259.937400626027;6300.054991751274;6318.210223722035;4671.299305104261;5652.869426114711;5693.345265294462;5765.769369225184;5879.853003674857;6813.488988325896;6859.794206173823;6880.483963702843;6917.996890450756;6924.169099707866;6745.763898263537;6761.898571521333;6764.120664313607;6774.661266936535;6774.966125169342;6638.937769956784;6865.691043903136;6890.240566577167;6933.341332573397;6949.166100068024;6491.642959637076;6596.373344532261;6619.106420633346;6642.103316052464;6678.966605166943;6650.501212408992;6791.3548212919695;6796.966015169893;6796.966015169893;6805.489588280998;6259.499240060875;6392.584482008655;6498.252700939263;6598.736050557924;6604.108445359815;6325.399087086719;6561.475081993524;6567.605943643397;6572.474202063919;6583.473322134314;6189.690515474298;6340.587861789153;6368.713407896563;6426.742930282736;6431.678416079084;6588.209414870246;6601.240857301472;6602.867942641216;6603.306652801387;6616.272210056986;6384.712687928962;6418.422341989243;6467.579607325509;6469.967650161719;6474.320196379313 04:18:56 INFO - PID 1673 | |1;ext.html;745.817274767682;799.1648727080201;820.8794994832054;952.9904700952989;1108.5731993182621;29071.854640726768;35999.10002249942;37128;37162.81418592907;37164;39075;39404.40893386601;39432.014199645026;39505.80247098768;39520.01199970002;8367.581620918929;8368.832623347529;8519.82960340796;8531.232189102979;8536.8719469208;8436.029856566513;8502.914970850305;8534.317254619615;8535.57322133894;8538.316934645245;8475.660973561051;8546.529940853281;8551.947532592196;8556.315494760403;8571.571421428935;8470.237678608924;8484.618192181366;8485.575721213945;8530.189631984951;8549.95725021374;8329.250367466897;8393.664253429917;8398.328133749286;8428.53643049632;8437.57812109392;37358.81320593407;37398.813005935066;37531.24937501262;37570.812145939366;37646.43530347047;3642.8724994625327;3687.557493100818;3688.022673991368;3701.204241088179;3702.2965636528975;30751.692483075105;30767.538486922713;30823.845880770452;30832;31143.22141946447;3132.6867313268717;3205.0705295464286;3205.983970080158;3215.05489179048;3215.115843143131;241710;243348;243614;243936;308538;49406.75296623566;49919.750401248486;49931.25103123456;49988;50060.499395006314;54031.72984135054;54297;54359;54561.72719136458;54633.1805022925;14044.438222471192;14077.788833167511;14197.716045679028;14200.786988195185;14228.430862765374;11549.826752598718;11558.768824623461;11567.479463424166;11573.652790416301;11574.6527604172;13844.584662459942;13854;13966.930165349107;13968.790468142986;14125.929370353082;5974.312954010257;5974.492168165668;5979.880402392015;5989.31122920861;5990.191324171268;998.495759641391;1012.8885822559513;1047.4919663962971;1076.5263284154946;1082.0802318029769;19700.42396608268;22305.888470557868;23252.95361708727;24405.38986525351;24553.508929821302;963.5856581669809;1105.6627728542871;1134.2173900008968;1154.6709187881413;1174.0842143128373;12182.36098768885;12578.86790188869;12588.30764307972;12610.558630447891;12622.62132136019;308877.4556127205;325595;329317.0602440965;329912;330145;53492;53840.19239711407;53844;53893.191602126;54021.72989135029;1466.7506523890963;1509.0719207687193;1513.833478317384;1520.6806570620072;1541.9514729983493;24140.75859241385;24201;24347.26958191257;24732.38169045788;24896.37759056038;37670;37823.91968441762;37846.62153378541;37960;37993.62006380012;281652;281938;282618;282919;283645;34117.829410852784;35078.47382289216;35108.473372898916;35109.29781404409;35264.47103293504;43864.561354386045;44202.33696494491;44700.88247793701;44782.10435791201;44968.32547511855;29002.854985724935;29668.851655741582;30290.24274393158;30499;30530.542041869834;29843.403131936804;30023.69976300209;30700.84649576738;30767.076987690405;31042.223944400666;36316;36340.90977270686;36354.818225908704;36370.45444318285;36413.817930910176;24752.752472475764;29094.1271761839;29385.41229175362;30502.474876255656;31099.689003110583;18760.513896952623;20547.8972605142;24082;24319;24403 04:18:56 INFO - PID 1673 | |2;jquery.html;403.5581038762555;433.85465868933903;440.6855319330803;441.2652932866777;464.6097278286239;20870.686939695897;21127.68308475372;21496.677549836724;21649.809260490707;21984;21239;21379.465513362175;21572.8921355393;21820.563588728215;22519;6282.999999999988;6495.805125846232;6496.870062598745;6506.60960342381;6592.538522303441;6063.333033366326;6327.272363678167;6357.93642063578;6382.904256436157;6383.202099737533;6110.755569777203;6270.874582508347;6274.027525733519;6347.206599175103;6354.7775827846035;5345.866353341178;6250.9062364064575;6288.968555157241;6290;6333.5749456372405;5478.424765399655;5489.835304940858;5556.444355564452;5566.165075238706;5601.887962240773;26846.731532684815;26985.730142698518;27359.589606155925;27515.449691006066;27558.5866212007;2254.4363909022745;2317.188983855654;2319.489712263299;2324.5467133908896;2325.2210509479346;15884;16469.423570175106;16755.162241887978;17052.914735426366;17787.822121778747;1889.998300900525;2139.743230812297;2184.8907554622206;2198.7251593550805;2233.7207849018873;157412;157861;159222;160381;162264.9999999988;12436.63197048324;12803.935980320039;12969.286689232184;13367;13610.795838062437;13845.376958036912;14408.42366305336;16536.338546458006;16915.407960721317;16922.49232523026;7554.471187016966;8722.476651400937;9059.81880362389;9088.372463825923;9122.635094596275;7987.440879138405;8418.737189421636;8616.48301101936;8763.605637746317;8796.988346340126;8050.476719013245;8106.392020598479;8177.713780017671;8191.180881911761;8210.876836847452;2263.287064574654;2279.247848210087;2281.3840263129196;2282.0529480265504;2475.851448913071;845.9323254139654;925.2366797392178;979.9853002204973;982.1553464020936;1012.1851909213007;21519;21773.34679959604;21933.341999740034;21974.780252197594;22004;972.8909043690198;1020.2501161646184;1041.7239431550645;1043.6034306963306;1047.2826114111858;9747.805043899083;11306.378149201708;11480.827787583194;11494.96545310926;11503;426250;523151;525288;539399;542612;115397.26904096446;119823.801761983;122478.38760806317;131727;136944.6305536932;1082.5020490574266;1191.862935762381;1200.6758175292623;1247.6132398956352;1252.3174869696038;20672.793272067087;22435.887820560794;22621.660675090217;22895;23147.305580832603;43293.35059974166;56785.01252456144;56885.14672279837;57449;57702.422975771384;78175.60912195402;78641.4271714551;78761.60619196868;79081;79910;9033.548322583712;9120.908790912272;9244.445333280024;9252;9256.768580785534;14258.144511329354;14400.99193056476;14462.85537144615;14637.26813659334;14783.334749936494;11795.233309834834;11832.58585949522;12146.93926530397;12181.512739490676;12373.13388062827;11376.772464550828;11560.768784624091;11639.718743961063;11710.238834475731;11838.763224735629;11555.2489088209;12279.69300767488;12379.876201238232;12629.11596188258;12647.557335493582;8423.947006624172;8487.787805304917;9096.135867092615;9238.399504032217;9264.212541934012;11584.478698458759;11992;12210.206336588448;12226.694332641755;12268.754624907631 04:18:56 INFO - PID 1673 | |3;mootools.html;1174.5830230268257;1366.6651670340761;1392.7284179584985;1415.2569900802082;1421.7014426970336;11519.48162332695;11830;12047.036237101021;12074.81887771683;12220.511179552806;11744.236624619394;11940.70148246292;11959.820602690967;12017.759644807098;12097.274163550193;2492.102842976527;2543.059068144789;2548.3756479662507;2562.090457887451;2571.8585477798715;2467.938301542467;2522.709888362834;2527.734587868275;2529.380301826055;2530.7975361971;2472.6661900643453;2504.9874750626223;2527.810414218932;2529.886155123024;2538.5684433646234;2279.1567120165478;2349.0134143659534;2458.889349979246;2468.160825319391;2508.912188073418;2393.317904397256;2471.3450935502105;2491.2650768023477;2499.3126890105186;2503.2740505253637;11751.001164900994;11879.524819007229;11881.5841445549;11882.28706277626;11895.167338286323;5499.312585926759;6787.2534021257625;6861.073755043105;6862.313768623148;6870.106886104774;3791.412331088658;4060.1473690525027;4450.643948484146;4455.242608756519;4465.888352791174;1196.9401529923468;1221.2550344289975;1241.7516496700605;1289.4519829072606;1295.740851829638;15214.239288035555;15777.211139443096;16531.6693666126;16696.165191740365;16731.247093880684;5521.4478552145265;5657.359365783959;5863.267091613463;5904.881902361929;5907.763689452459;12450.626481205398;12513.124081314221;12530.310832904277;12535.686607834878;12548;6634.601923884582;6669.833254168685;6678.899816502756;6679.666016699242;6688.431483323875;5110.872228194251;6051.031834906394;6254.499640028786;6269.843253918689;6276;4281.935770963438;4360.084382279757;4379.386885835986;4416.712913660602;4432.357308190294;1272.211229037984;1272.7009152849073;1291.3406272939228;1299.0060257504686;1309.8362704661918;791.8970533830565;798.5009369144285;819.71310041485;825.6614787936917;849.099954048698;4682.765861706901;6247.312795592481;6444.130042444303;6569;6607.372299631527;589.1751547833068;591.7899145803264;607.520059153264;613.2793967088653;617.7374615788272;3350.798952062884;3710.257948410329;3983.8406463741126;4007.3788562772816;4129.710920235615;14213.644658883404;14427.92786036063;14625.488107916171;14647.633809154857;14950.40198392074;14088.084274522123;14301;14315.427382904567;14317.21255330946;14516.927415362856;8300.916990830014;8378.497290162488;8423.11557286476;8471.703490377808;8494.980602327636;7158.713651454092;7178.210396856446;7365.8158546036775;7398.96300518494;7424.925750742639;13243.47026118983;13480;13717;13746.312684365541;13758.31208439594;12255;13755.83075438599;13833.584992450242;14015.299235038412;14055.789163162764;9631.855522167032;9787.46168960714;9790.559424825757;9809.950950245204;9813.85279220798;10664.786704266027;10947.890521094687;10973.23187376876;11035.668929932115;11063.059639930696;9294.14045605703;9308.394954327947;9316.580753865957;9470.384425012353;9484.95257523708;9121.589528471368;9189.678361257324;9288.58201380953;9308.906910930804;9310.441373517611;8213.95893020531;8404.579771011548;8420.15798420153;8489.320854331761;8504.872426913478;4761.333413322069;6064.666443345658;6109.327973922776;6180.072989051679;6196.256449226122;4920.941997470561;5875.353711091862;6018.097285407224;6261.78083767066;6352.777652782131 04:18:56 INFO - PID 1673 | |4;prototype.html;321.00808501729654;388.4658594432655;405.09663450505354;412.66780241905275;415.0909508177092;5502.449755024496;5704.429557044294;6236.314005459401;6276.027215781555;6327.588706734059;4893.804247830082;5980.431858973401;6014.368491308415;6087;6119.847003824895;3640.2719456108753;3864.6908247340143;4460.5430791136805;4461.018575913294;4468.346711716653;4310.224159651277;4425.513193548707;4430.49049359323;4475.216837053519;4478.798454069574;3789.677877380426;4393.384926110347;4395.86812395627;4409.037978099747;4417.889552761175;4373.882557407825;4394.1870753910625;4412.925924815364;4424.424824772759;4440.644748420119;3159.4786860168047;3712.7215458840697;3770.7171962102952;3810.961890381116;3829.8361425794337;4473.753943533105;5107.182850743863;5325.600579956519;5675.836453527058;5923;5215.947840521584;5328.147496400596;5333.599980001515;5343.438938911436;5359.892802143974;5304.6286759926825;5582.637128586629;6231.003039513701;6451.51613628975;6497.837554061139;3973.562908080109;4363.400194839239;4363.912721745579;4369.847055353048;4383.627391671712;6727.2482027866445;6867.484938629623;6905.205901321312;6940.201876784184;6970;4387.3857659927635;4395.164918665443;4396.648268138541;4418.381426600278;4420.916875365556;3752.4558938954247;4329.895876551459;4485.8112600160985;4489.967307519289;4491.550844915548;4575.7483338416705;4594.793234304464;5260.408452925418;5285.55072818807;5366.892662146735;6525.412712855866;6543.1821022372205;6560.343965603402;6562.9827376756675;6586.242582103024;1351.7431687979251;1391.7494850926728;1532.2338830584708;1535.109636410879;1536.9231538423035;995.8207522645994;1008.7276435362411;1011.4234886114843;1013.5844303835393;1026.0662796854826;5016.322796422436;5225.372955245319;6002.039673652194;6259.749610015549;6293.874122517524;5596.776128954796;6124.6325220486915;6495.512836537278;6750.3249675033085;6757.763478278237;5637.436256374412;5762.625429347163;5879.353271140171;6245.688405434818;6292.46514046302;3041.874506432634;3170.556122142902;3515.5605549306338;3549.467579863041;3557.288542291552;5422.213779002022;5765.913511297334;6736.292689267556;6926.238113807477;6993.622168462747;5723.370429252779;6057.151998720183;6457.2896981332015;6473.676316184172;6572.441342485942;5972.432618901197;6417.518686098561;6475.805725828232;6819.681308355183;6953.582785032914;5448.645838020516;6809.897851532132;6843;6857.457072158724;6878.518503704692;6131.294901086254;6140.907886381798;6517.250516190698;6744.7976560703255;6769.526133170828;6021.939780602138;6645.840101966784;7030.367266945795;7057.752978645723;7064.364207221375;4408;4426.15902978433;4432.423784907941;4455.598996090367;4458.665600079942;5530.861728456821;6142;6389.2971773105855;6837.931620683729;6844;5852.561057920588;6196.442320191204;6603.306652801579;6606.636634985122;6611.446310117022;6167.374469148139;6207.317195108625;6253.78111766086;6539.869202616016;6574.276829548841;6103.870783904992;6499.5775274607;6505.73977040932;6511.38141876521;6524.347565243438;5834.562407819515;5999;6363.6499992499;6596.241432235162;6606.339366063356;6391.909178126096;6445.6454894981225;6479.157709497924;6490.123833282635;6506.674666266573 04:18:56 INFO - PID 1673 | |5;yui.html;827.255470076931;838.1743982177555;838.39635462467;859.5788063848712;863.8747381629665;16033.679326413465;16767.83232167678;16826.990380577157;18315.725264121047;19029.904850475727;17505.299788008466;17761.555961100978;17803.931764094163;17960.9223446593;18143;928.2805825485269;935.780091678455;947.4362754161263;951.3863558005082;952.9993506817848;943.9480828554426;960.2462067277189;963.2197919685043;967.3615413826876;968.0368033806373;1038.3043360948184;1042.7445275907376;1044.8171569975261;1045.0855501436242;1051.1695760349353;1015.781606954501;1035.404642330663;1039.4127318065307;1040.1314902056754;1048.4128887822844;722.53396559219;743.4535616321999;754.2457542457543;757.5909009135061;768.8154842837735;16295.103769292684;16383.344666213337;16417.58956026097;16482.75275870863;16484.587885302844;16160.353585856552;16469.670606587923;16782.83217167825;16787.992720436814;16904.323827046905;13648.112872663245;13778.862211377858;14046.71906561863;14081.225532595703;14082.577522674335;2951.631046119235;3079.9846000769853;3519.8240087995496;3541.8937431877084;3541.9291614167573;109746;109914.45042774735;110731.44634276857;110890.44554777256;111874;13008.804867926989;13307.600771976857;13377.73244535104;13425.597232083053;13460.798088028687;24231.878840605685;24576.87711561431;24841.130560430298;25158.993640254186;25174.874125629256;7846.293833554893;7911.525308481395;7932.08780990182;7954.840903181904;7968.402369822286;3867.207222519377;3908.9804550977065;3937.822797974098;3938.232044751246;3941.0935484838647;4205.957940420618;4255.404243405926;4297.806598703066;4300.161468513672;4321.503027151855;918.4948278446827;948.9572969216401;953.909378609031;958.8130314588727;959.2278216036158;551.7489542258263;610.3133974278936;634.508256101525;643.6492111799081;652.7617419641797;11061;11410.315381077162;11846.111541634413;12059.336736479403;12131.5147394105;627.883841489326;648.1800522339245;649.9220093588799;675.6148995072762;690.7444245629149;5263.26314315996;5558.305211848519;5592.552595792326;5626.859328516738;5639.6334238274385;108031.45984270028;108788;108815.45592271988;109002.90997090086;109296.4535177319;97385.5130724356;98230.52654210193;98269;98294;98426;83955;85487;85689.14310856936;86271;86787;8415.789605259917;10813.134949203888;11167.664970050912;11381.918717721803;11466.598669046543;42515.7874210627;42651.57348426476;42749.145017100105;43074.70775876729;43172.56827431811;38844;55015;55122.72438637781;55435.16847247375;55597.44402555923;13966;13994.440222390991;14060.648483787987;14186.432542698176;14211.431542738175;15237.085774853102;15565.92217038953;15588.610284742519;15606.687866242839;15759.527214183592;14525.055871368328;14536.200508971686;14583.197924114276;14614.415423382945;14699;11988.700282493008;14362.784558231844;14392.352344144329;14539.273036348352;14603.415863365772;14215.147091174562;14254.928725356307;14262.57212283633;14308.856911431169;14382.065165764192;10355.896441035493;10509.479324426402;10598.841017384899;10830.025297723243;10835.783284334428;11190.32858028521;13051.738965220833;13189.208647481182;13644.454221831016;14186.858131418967 04:18:56 INFO - PID 1673 | __end_tp_report 04:18:56 INFO - PID 1673 | __start_cc_report 04:18:56 INFO - PID 1673 | _x_x_mozilla_cycle_collect,426 04:18:56 INFO - PID 1673 | __end_cc_report 04:18:56 INFO - PID 1673 | __startTimestamp1492859936115__endTimestamp 04:18:56 INFO - PID 1673 | 04:18:56 INFO - PID 1673 | ------- Summary: start ------- 04:18:56 INFO - PID 1673 | Number of tests: 6 04:18:56 INFO - PID 1673 | 04:18:56 INFO - PID 1673 | [#0] dojo.html Cycles:165 Average:6125.04 Median:6375.72 stddev:778.38 (12.2%) stddev-sans-first:742.15 04:18:56 INFO - PID 1673 | Values: 3038.3 3470.7 3526.9 3611.2 3641.3 6034.0 6095.8 6168.8 6211.7 6244.3 6124.3 6132.7 6148.7 6217.6 6238.7 4268.3 5258.6 5415.2 5437.5 5529.9 5370.0 5430.2 5522.6 5529.1 5560.3 5332.3 5384.9 5470.3 5475.5 5496.8 5415.9 5440.7 5455.0 5456.2 5493.3 5325.1 5396.6 5416.8 5419.8 5463.8 5974.0 6069.6 6137.8 6138.0 6200.4 6636.4 6702.7 6711.3 6715.6 6717.8 6776.7 6803.5 6811.1 6819.5 6829.0 6121.3 6197.0 6243.4 6352.1 6365.5 6833.7 6856.5 6884.8 6898.6 6901.3 6293.2 6344.3 6377.5 6511.3 6574.1 6548.0 6629.2 6732.7 6748.6 6786.2 6398.7 6657.1 6660.8 6661.0 6680.8 6468.1 6566.7 6574.2 6661.0 6677.4 4474.2 4488.9 5288.2 5305.8 5305.9 4750.6 4752.6 4761.0 4764.0 4770.1 5098.9 6117.7 6129.9 6288.2 6312.6 6375.7 6753.3 6784.7 6786.4 6788.5 5530.9 6232.5 6259.9 6300.1 6318.2 4671.3 5652.9 5693.3 5765.8 5879.9 6813.5 6859.8 6880.5 6918.0 6924.2 6745.8 6761.9 6764.1 6774.7 6775.0 6638.9 6865.7 6890.2 6933.3 6949.2 6491.6 6596.4 6619.1 6642.1 6679.0 6650.5 6791.4 6797.0 6797.0 6805.5 6259.5 6392.6 6498.3 6598.7 6604.1 6325.4 6561.5 6567.6 6572.5 6583.5 6189.7 6340.6 6368.7 6426.7 6431.7 6588.2 6601.2 6602.9 6603.3 6616.3 6384.7 6418.4 6467.6 6470.0 6474.3 04:18:56 INFO - PID 1673 | 04:18:56 INFO - PID 1673 | [#1] ext.html Cycles:180 Average:44152.79 Median:34598.15 stddev:75932.50 (219.5%) stddev-sans-first:76075.57 04:18:56 INFO - PID 1673 | Values: 745.8 799.2 820.9 953.0 1108.6 29071.9 35999.1 37128.0 37162.8 37164.0 39075.0 39404.4 39432.0 39505.8 39520.0 8367.6 8368.8 8519.8 8531.2 8536.9 8436.0 8502.9 8534.3 8535.6 8538.3 8475.7 8546.5 8551.9 8556.3 8571.6 8470.2 8484.6 8485.6 8530.2 8550.0 8329.3 8393.7 8398.3 8428.5 8437.6 37358.8 37398.8 37531.2 37570.8 37646.4 3642.9 3687.6 3688.0 3701.2 3702.3 30751.7 30767.5 30823.8 30832.0 31143.2 3132.7 3205.1 3206.0 3215.1 3215.1 241710.0 243348.0 243614.0 243936.0 308538.0 49406.8 49919.8 49931.3 49988.0 50060.5 54031.7 54297.0 54359.0 54561.7 54633.2 14044.4 14077.8 14197.7 14200.8 14228.4 11549.8 11558.8 11567.5 11573.7 11574.7 13844.6 13854.0 13966.9 13968.8 14125.9 5974.3 5974.5 5979.9 5989.3 5990.2 998.5 1012.9 1047.5 1076.5 1082.1 19700.4 22305.9 23253.0 24405.4 24553.5 963.6 1105.7 1134.2 1154.7 1174.1 12182.4 12578.9 12588.3 12610.6 12622.6 308877.5 325595.0 329317.1 329912.0 330145.0 53492.0 53840.2 53844.0 53893.2 54021.7 1466.8 1509.1 1513.8 1520.7 1542.0 24140.8 24201.0 24347.3 24732.4 24896.4 37670.0 37823.9 37846.6 37960.0 37993.6 281652.0 281938.0 282618.0 282919.0 283645.0 34117.8 35078.5 35108.5 35109.3 35264.5 43864.6 44202.3 44700.9 44782.1 44968.3 29002.9 29668.9 30290.2 30499.0 30530.5 29843.4 30023.7 30700.8 30767.1 31042.2 36316.0 36340.9 36354.8 36370.5 36413.8 24752.8 29094.1 29385.4 30502.5 31099.7 18760.5 20547.9 24082.0 24319.0 24403.0 04:18:56 INFO - PID 1673 | 04:18:56 INFO - PID 1673 | [#2] jquery.html Cycles:180 Average:34657.80 Median:2281.72 stddev:87699.21 (3843.6%) stddev-sans-first:87907.52 04:18:56 INFO - PID 1673 | Values: 403.6 433.9 440.7 441.3 464.6 20870.7 21127.7 21496.7 21649.8 21984.0 21239.0 21379.5 21572.9 21820.6 22519.0 6283.0 6495.8 6496.9 6506.6 6592.5 6063.3 6327.3 6357.9 6382.9 6383.2 6110.8 6270.9 6274.0 6347.2 6354.8 5345.9 6250.9 6289.0 6290.0 6333.6 5478.4 5489.8 5556.4 5566.2 5601.9 26846.7 26985.7 27359.6 27515.4 27558.6 2254.4 2317.2 2319.5 2324.5 2325.2 15884.0 16469.4 16755.2 17052.9 17787.8 1890.0 2139.7 2184.9 2198.7 2233.7 157412.0 157861.0 159222.0 160381.0 162265.0 12436.6 12803.9 12969.3 13367.0 13610.8 13845.4 14408.4 16536.3 16915.4 16922.5 7554.5 8722.5 9059.8 9088.4 9122.6 7987.4 8418.7 8616.5 8763.6 8797.0 8050.5 8106.4 8177.7 8191.2 8210.9 2263.3 2279.2 2281.4 2282.1 2475.9 845.9 925.2 980.0 982.2 1012.2 21519.0 21773.3 21933.3 21974.8 22004.0 972.9 1020.3 1041.7 1043.6 1047.3 9747.8 11306.4 11480.8 11495.0 11503.0 426250.0 523151.0 525288.0 539399.0 542612.0 115397.3 119823.8 122478.4 131727.0 136944.6 1082.5 1191.9 1200.7 1247.6 1252.3 20672.8 22435.9 22621.7 22895.0 23147.3 43293.4 56785.0 56885.1 57449.0 57702.4 78175.6 78641.4 78761.6 79081.0 79910.0 9033.5 9120.9 9244.4 9252.0 9256.8 14258.1 14401.0 14462.9 14637.3 14783.3 11795.2 11832.6 12146.9 12181.5 12373.1 11376.8 11560.8 11639.7 11710.2 11838.8 11555.2 12279.7 12379.9 12629.1 12647.6 8423.9 8487.8 9096.1 9238.4 9264.2 11584.5 11992.0 12210.2 12226.7 12268.8 04:18:56 INFO - PID 1673 | 04:18:56 INFO - PID 1673 | [#3] mootools.html Cycles:180 Average:7140.27 Median:3530.53 stddev:4527.75 (128.2%) stddev-sans-first:4518.26 04:18:56 INFO - PID 1673 | Values: 1174.6 1366.7 1392.7 1415.3 1421.7 11519.5 11830.0 12047.0 12074.8 12220.5 11744.2 11940.7 11959.8 12017.8 12097.3 2492.1 2543.1 2548.4 2562.1 2571.9 2467.9 2522.7 2527.7 2529.4 2530.8 2472.7 2505.0 2527.8 2529.9 2538.6 2279.2 2349.0 2458.9 2468.2 2508.9 2393.3 2471.3 2491.3 2499.3 2503.3 11751.0 11879.5 11881.6 11882.3 11895.2 5499.3 6787.3 6861.1 6862.3 6870.1 3791.4 4060.1 4450.6 4455.2 4465.9 1196.9 1221.3 1241.8 1289.5 1295.7 15214.2 15777.2 16531.7 16696.2 16731.2 5521.4 5657.4 5863.3 5904.9 5907.8 12450.6 12513.1 12530.3 12535.7 12548.0 6634.6 6669.8 6678.9 6679.7 6688.4 5110.9 6051.0 6254.5 6269.8 6276.0 4281.9 4360.1 4379.4 4416.7 4432.4 1272.2 1272.7 1291.3 1299.0 1309.8 791.9 798.5 819.7 825.7 849.1 4682.8 6247.3 6444.1 6569.0 6607.4 589.2 591.8 607.5 613.3 617.7 3350.8 3710.3 3983.8 4007.4 4129.7 14213.6 14427.9 14625.5 14647.6 14950.4 14088.1 14301.0 14315.4 14317.2 14516.9 8300.9 8378.5 8423.1 8471.7 8495.0 7158.7 7178.2 7365.8 7399.0 7424.9 13243.5 13480.0 13717.0 13746.3 13758.3 12255.0 13755.8 13833.6 14015.3 14055.8 9631.9 9787.5 9790.6 9810.0 9813.9 10664.8 10947.9 10973.2 11035.7 11063.1 9294.1 9308.4 9316.6 9470.4 9485.0 9121.6 9189.7 9288.6 9308.9 9310.4 8214.0 8404.6 8420.2 8489.3 8504.9 4761.3 6064.7 6109.3 6180.1 6196.3 4920.9 5875.4 6018.1 6261.8 6352.8 04:18:56 INFO - PID 1673 | 04:18:56 INFO - PID 1673 | [#4] prototype.html Cycles:180 Average:5188.81 Median:5743.00 stddev:1645.80 (28.7%) stddev-sans-first:1609.35 04:18:56 INFO - PID 1673 | Values: 321.0 388.5 405.1 412.7 415.1 5502.4 5704.4 6236.3 6276.0 6327.6 4893.8 5980.4 6014.4 6087.0 6119.8 3640.3 3864.7 4460.5 4461.0 4468.3 4310.2 4425.5 4430.5 4475.2 4478.8 3789.7 4393.4 4395.9 4409.0 4417.9 4373.9 4394.2 4412.9 4424.4 4440.6 3159.5 3712.7 3770.7 3811.0 3829.8 4473.8 5107.2 5325.6 5675.8 5923.0 5215.9 5328.1 5333.6 5343.4 5359.9 5304.6 5582.6 6231.0 6451.5 6497.8 3973.6 4363.4 4363.9 4369.8 4383.6 6727.2 6867.5 6905.2 6940.2 6970.0 4387.4 4395.2 4396.6 4418.4 4420.9 3752.5 4329.9 4485.8 4490.0 4491.6 4575.7 4594.8 5260.4 5285.6 5366.9 6525.4 6543.2 6560.3 6563.0 6586.2 1351.7 1391.7 1532.2 1535.1 1536.9 995.8 1008.7 1011.4 1013.6 1026.1 5016.3 5225.4 6002.0 6259.7 6293.9 5596.8 6124.6 6495.5 6750.3 6757.8 5637.4 5762.6 5879.4 6245.7 6292.5 3041.9 3170.6 3515.6 3549.5 3557.3 5422.2 5765.9 6736.3 6926.2 6993.6 5723.4 6057.2 6457.3 6473.7 6572.4 5972.4 6417.5 6475.8 6819.7 6953.6 5448.6 6809.9 6843.0 6857.5 6878.5 6131.3 6140.9 6517.3 6744.8 6769.5 6021.9 6645.8 7030.4 7057.8 7064.4 4408.0 4426.2 4432.4 4455.6 4458.7 5530.9 6142.0 6389.3 6837.9 6844.0 5852.6 6196.4 6603.3 6606.6 6611.4 6167.4 6207.3 6253.8 6539.9 6574.3 6103.9 6499.6 6505.7 6511.4 6524.3 5834.6 5999.0 6363.6 6596.2 6606.3 6391.9 6445.6 6479.2 6490.1 6506.7 04:18:56 INFO - PID 1673 | 04:18:56 INFO - PID 1673 | [#5] yui.html Cycles:180 Average:21378.30 Median:18051.96 stddev:30386.40 (168.3%) stddev-sans-first:30432.46 04:18:56 INFO - PID 1673 | Values: 827.3 838.2 838.4 859.6 863.9 16033.7 16767.8 16827.0 18315.7 19029.9 17505.3 17761.6 17803.9 17960.9 18143.0 928.3 935.8 947.4 951.4 953.0 943.9 960.2 963.2 967.4 968.0 1038.3 1042.7 1044.8 1045.1 1051.2 1015.8 1035.4 1039.4 1040.1 1048.4 722.5 743.5 754.2 757.6 768.8 16295.1 16383.3 16417.6 16482.8 16484.6 16160.4 16469.7 16782.8 16788.0 16904.3 13648.1 13778.9 14046.7 14081.2 14082.6 2951.6 3080.0 3519.8 3541.9 3541.9 109746.0 109914.5 110731.4 110890.4 111874.0 13008.8 13307.6 13377.7 13425.6 13460.8 24231.9 24576.9 24841.1 25159.0 25174.9 7846.3 7911.5 7932.1 7954.8 7968.4 3867.2 3909.0 3937.8 3938.2 3941.1 4206.0 4255.4 4297.8 4300.2 4321.5 918.5 949.0 953.9 958.8 959.2 551.7 610.3 634.5 643.6 652.8 11061.0 11410.3 11846.1 12059.3 12131.5 627.9 648.2 649.9 675.6 690.7 5263.3 5558.3 5592.6 5626.9 5639.6 108031.5 108788.0 108815.5 109002.9 109296.5 97385.5 98230.5 98269.0 98294.0 98426.0 83955.0 85487.0 85689.1 86271.0 86787.0 8415.8 10813.1 11167.7 11381.9 11466.6 42515.8 42651.6 42749.1 43074.7 43172.6 38844.0 55015.0 55122.7 55435.2 55597.4 13966.0 13994.4 14060.6 14186.4 14211.4 15237.1 15565.9 15588.6 15606.7 15759.5 14525.1 14536.2 14583.2 14614.4 14699.0 11988.7 14362.8 14392.4 14539.3 14603.4 14215.1 14254.9 14262.6 14308.9 14382.1 10355.9 10509.5 10598.8 10830.0 10835.8 11190.3 13051.7 13189.2 13644.5 14186.9 04:18:56 INFO - PID 1673 | -------- Summary: end -------- 04:18:56 INFO - PID 1673 | 04:18:56 INFO - TEST-INFO | 1673: exit 0 04:18:56 INFO - TEST-OK | dromaeo_css | took 1115463ms 04:18:56 INFO - TEST-START | kraken 04:18:56 INFO - operating with platform_type : mac_ 04:18:56 INFO - Initialising browser for kraken test... 04:18:56 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpdqzo4J/profile http://localhost:49249/getInfo.html) 04:18:59 INFO - PID 1682 | 2017-04-22 04:18:59.516 plugin-container[1683:11653] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 04:18:59 INFO - PID 1682 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:18:59 INFO - PID 1682 | 2017-04-22 04:18:59.519 plugin-container[1683:11653] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 04:18:59 INFO - PID 1682 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:18:59 INFO - PID 1682 | 2017-04-22 04:18:59.519 plugin-container[1683:11653] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:18:59 INFO - PID 1682 | __metrics Screen width/height:1600/1200 04:18:59 INFO - PID 1682 | colorDepth:24 04:18:59 INFO - PID 1682 | Browser inner width/height: 1024/689 04:18:59 INFO - PID 1682 | __metrics 04:18:59 ERROR - PID 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 04:19:00 INFO - TEST-INFO | 1682: exit 0 04:19:00 INFO - Browser initialized. 04:19:00 INFO - Running cycle 1/1 for kraken test... 04:19:00 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpdqzo4J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:02 INFO - PID 1684 | 2017-04-22 04:19:02.985 plugin-container[1685:11776] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 04:19:02 INFO - PID 1684 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:19:02 INFO - PID 1684 | 2017-04-22 04:19:02.985 plugin-container[1685:11776] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923b, name = 'com.apple.CFPasteboardClient' 04:19:02 INFO - PID 1684 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:19:02 INFO - PID 1684 | 2017-04-22 04:19:02.986 plugin-container[1685:11776] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:19:12 INFO - PID 1684 | RSS: Main: 237613056 04:19:12 INFO - PID 1684 | 04:19:15 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:16 INFO - PID 1684 | RSS: Main: 249618432 04:19:16 INFO - PID 1684 | 04:19:18 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 04:19:19 INFO - PID 1684 | RSS: Main: 257773568 04:19:19 INFO - PID 1684 | 04:19:22 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 04:19:23 INFO - PID 1684 | RSS: Main: 260100096 04:19:23 INFO - PID 1684 | 04:19:25 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 04:19:25 INFO - PID 1684 | RSS: Main: 261603328 04:19:25 INFO - PID 1684 | 04:19:27 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:28 INFO - PID 1684 | RSS: Main: 261885952 04:19:28 INFO - PID 1684 | 04:19:31 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:31 INFO - PID 1684 | RSS: Main: 267292672 04:19:31 INFO - PID 1684 | 04:19:34 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:35 INFO - PID 1684 | RSS: Main: 268873728 04:19:35 INFO - PID 1684 | 04:19:38 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 04:19:39 INFO - PID 1684 | RSS: Main: 269770752 04:19:39 INFO - PID 1684 | 04:19:40 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:41 INFO - PID 1684 | RSS: Main: 269475840 04:19:41 INFO - PID 1684 | 04:19:43 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:43 INFO - PID 1684 | RSS: Main: 269275136 04:19:43 INFO - PID 1684 | 04:19:45 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:46 INFO - PID 1684 | RSS: Main: 268763136 04:19:46 INFO - PID 1684 | 04:19:49 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:50 INFO - PID 1684 | RSS: Main: 268898304 04:19:50 INFO - PID 1684 | 04:19:53 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:54 INFO - PID 1684 | RSS: Main: 266088448 04:19:54 INFO - PID 1684 | 04:19:55 INFO - PID 1684 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 04:19:56 INFO - PID 1684 | RSS: Main: 267993088 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | __start_tp_report 04:19:56 INFO - PID 1684 | _x_x_mozilla_page_load 04:19:56 INFO - PID 1684 | _x_x_mozilla_page_load_details 04:19:56 INFO - PID 1684 | |i|pagename|runs| 04:19:56 INFO - PID 1684 | |0;ai-astar;107;115;113;113;113;113;113;114;115;113 04:19:56 INFO - PID 1684 | |1;audio-beat-detection;142;113;119;185;112;113;121;137;135;115 04:19:56 INFO - PID 1684 | |2;audio-dft;194;196;195;213;217;211;210;197;200;191 04:19:56 INFO - PID 1684 | |3;audio-fft;77;58;57;82;57;58;59;56;76;62 04:19:56 INFO - PID 1684 | |4;audio-oscillator;91;69;82;71;70;69;90;68;69;90 04:19:56 INFO - PID 1684 | |5;imaging-gaussian-blur;88;89;88;88;90;88;88;89;90;88 04:19:56 INFO - PID 1684 | |6;imaging-darkroom;96;97;97;97;97;96;123;96;97;95 04:19:56 INFO - PID 1684 | |7;imaging-desaturate;90;80;100;103;97;141;144;137;108;92 04:19:56 INFO - PID 1684 | |8;json-parse-financial;50;51;52;54;53;50;51;51;54;58 04:19:56 INFO - PID 1684 | |9;json-stringify-tinderbox;64;62;56;56;61;58;57;58;54;55 04:19:56 INFO - PID 1684 | |10;stanford-crypto-aes;83;84;84;86;84;82;83;84;84;73 04:19:56 INFO - PID 1684 | |11;stanford-crypto-ccm;150;152;142;153;155;150;159;158;187;140 04:19:56 INFO - PID 1684 | |12;stanford-crypto-pbkdf2;220;186;186;164;245;237;168;232;254;208 04:19:56 INFO - PID 1684 | |13;stanford-crypto-sha256-iterative;69;65;67;68;70;78;96;80;69;69 04:19:56 INFO - PID 1684 | __end_tp_report 04:19:56 INFO - PID 1684 | __start_cc_report 04:19:56 INFO - PID 1684 | _x_x_mozilla_cycle_collect,1007 04:19:56 INFO - PID 1684 | __end_cc_report 04:19:56 INFO - PID 1684 | __startTimestamp1492859996214__endTimestamp 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | ------- Summary: start ------- 04:19:56 INFO - PID 1684 | Number of tests: 14 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:2.23 (2.0%) stddev-sans-first:0.88 04:19:56 INFO - PID 1684 | Values: 107.0 115.0 113.0 113.0 113.0 113.0 113.0 114.0 115.0 113.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:128.00 stddev:22.52 (17.6%) stddev-sans-first:23.41 04:19:56 INFO - PID 1684 | Values: 142.0 113.0 119.0 185.0 112.0 113.0 121.0 137.0 135.0 115.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#2] audio-dft Cycles:10 Average:202.40 Median:205.00 stddev:9.36 (4.6%) stddev-sans-first:9.42 04:19:56 INFO - PID 1684 | Values: 194.0 196.0 195.0 213.0 217.0 211.0 210.0 197.0 200.0 191.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#3] audio-fft Cycles:10 Average:64.20 Median:60.50 stddev:10.00 (16.5%) stddev-sans-first:9.47 04:19:56 INFO - PID 1684 | Values: 77.0 58.0 57.0 82.0 57.0 58.0 59.0 56.0 76.0 62.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:76.50 stddev:10.09 (13.2%) stddev-sans-first:9.33 04:19:56 INFO - PID 1684 | Values: 91.0 69.0 82.0 71.0 70.0 69.0 90.0 68.0 69.0 90.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:88.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 04:19:56 INFO - PID 1684 | Values: 88.0 89.0 88.0 88.0 90.0 88.0 88.0 89.0 90.0 88.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#6] imaging-darkroom Cycles:10 Average:99.10 Median:97.00 stddev:8.43 (8.7%) stddev-sans-first:8.86 04:19:56 INFO - PID 1684 | Values: 96.0 97.0 97.0 97.0 97.0 96.0 123.0 96.0 97.0 95.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#7] imaging-desaturate Cycles:10 Average:109.20 Median:112.00 stddev:23.06 (20.6%) stddev-sans-first:23.39 04:19:56 INFO - PID 1684 | Values: 90.0 80.0 100.0 103.0 97.0 141.0 144.0 137.0 108.0 92.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:2.46 (4.7%) stddev-sans-first:2.45 04:19:56 INFO - PID 1684 | Values: 50.0 51.0 52.0 54.0 53.0 50.0 51.0 51.0 54.0 58.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:3.25 (5.6%) stddev-sans-first:2.65 04:19:56 INFO - PID 1684 | Values: 64.0 62.0 56.0 56.0 61.0 58.0 57.0 58.0 54.0 55.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:84.00 stddev:3.56 (4.2%) stddev-sans-first:3.77 04:19:56 INFO - PID 1684 | Values: 83.0 84.0 84.0 86.0 84.0 82.0 83.0 84.0 84.0 73.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:154.00 stddev:12.93 (8.4%) stddev-sans-first:13.61 04:19:56 INFO - PID 1684 | Values: 150.0 152.0 142.0 153.0 155.0 150.0 159.0 158.0 187.0 140.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:210.00 Median:226.00 stddev:32.51 (14.4%) stddev-sans-first:34.28 04:19:56 INFO - PID 1684 | Values: 220.0 186.0 186.0 164.0 245.0 237.0 168.0 232.0 254.0 208.0 04:19:56 INFO - PID 1684 | 04:19:56 INFO - PID 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:69.50 stddev:9.34 (13.4%) stddev-sans-first:9.79 04:19:56 INFO - PID 1684 | Values: 69.0 65.0 67.0 68.0 70.0 78.0 96.0 80.0 69.0 69.0 04:19:56 INFO - PID 1684 | -------- Summary: end -------- 04:19:56 INFO - PID 1684 | 04:19:57 INFO - TEST-INFO | 1684: exit 0 04:19:57 INFO - TEST-OK | kraken | took 60391ms 04:19:57 INFO - SUITE-END | took 1175s 04:19:57 INFO - Completed test suite (00:19:35) 04:19:57 INFO - javascript benchmark 04:19:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7814.423585979707, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3038.3467554475787, 3470.7331823884274, 3526.911827204321, 3611.1513794258353, 3641.28994846005, 6034.034554471285, 6095.75616975321, 6168.845778855531, 6211.689415529222, 6244.313125556197, 6124.289394097922, 6132.722655450954, 6148.678034222641, 6217.5958562693395, 6238.689875126218, 4268.253055715238, 5258.55302299305, 5415.160650099241, 5437.510624043835, 5529.917051244234, 5369.973150134244, 5430.212619170218, 5522.585806064541, 5529.115341545354, 5560.277163968699, 5332.253484512172, 5384.892302153935, 5470.261514695545, 5475.5072043516275, 5496.780128794843, 5415.9458405415835, 5440.6735595864375, 5455.018096742585, 5456.181572764078, 5493.313335833021, 5325.094733895208, 5396.568274538027, 5416.8104116356135, 5419.810306639249, 5463.808766693186, 5973.970130149365, 6069.605475644069, 6137.846553836145, 6137.989923150287, 6200.379962003809, 6636.402723754837, 6702.731890724365, 6711.261761206263, 6715.630640314781, 6717.764878229287, 6776.661166941633, 6803.455723542154, 6811.114555107804, 6819.488538359593, 6829.043933849265, 6121.326654068049, 6197.03945888388, 6243.43809057178, 6352.078948552434, 6365.458935990447, 6833.692483838239, 6856.5200435969, 6884.827879303058, 6898.620575868375, 6901.275366086589, 6293.244810622755, 6344.333844946306, 6377.5216858735785, 6511.3163117871945, 6574.079628851964, 6547.9672601636685, 6629.171353580802, 6732.730690772412, 6748.595084294958, 6786.185657721105, 6398.744050237939, 6657.068010478537, 6660.800175994728, 6660.966695166493, 6680.766173183915, 6468.126802881551, 6566.67166641666, 6574.211094668671, 6661.0, 6677.399034086956, 4474.194644963938, 4488.910221795546, 5288.206768984606, 5305.761240744176, 5305.920411193835, 4750.572448479585, 4752.643551733634, 4761.047790441926, 4763.95236047642, 4770.069836381872, 5098.898022039539, 6117.675163990694, 6129.8784197560135, 6288.182536270256, 6312.621242725451, 6375.724855029012, 6753.257141714407, 6784.694688739019, 6786.423154031962, 6788.456923446112, 5530.917036244459, 6232.470240029557, 6259.937400626027, 6300.054991751274, 6318.210223722035, 4671.299305104261, 5652.869426114711, 5693.345265294462, 5765.769369225184, 5879.853003674857, 6813.488988325896, 6859.794206173823, 6880.483963702843, 6917.996890450756, 6924.169099707866, 6745.763898263537, 6761.898571521333, 6764.120664313607, 6774.661266936535, 6774.966125169342, 6638.937769956784, 6865.691043903136, 6890.240566577167, 6933.341332573397, 6949.166100068024, 6491.642959637076, 6596.373344532261, 6619.106420633346, 6642.103316052464, 6678.966605166943, 6650.501212408992, 6791.3548212919695, 6796.966015169893, 6796.966015169893, 6805.489588280998, 6259.499240060875, 6392.584482008655, 6498.252700939263, 6598.736050557924, 6604.108445359815, 6325.399087086719, 6561.475081993524, 6567.605943643397, 6572.474202063919, 6583.473322134314, 6189.690515474298, 6340.587861789153, 6368.713407896563, 6426.742930282736, 6431.678416079084, 6588.209414870246, 6601.240857301472, 6602.867942641216, 6603.306652801387, 6616.272210056986, 6384.712687928962, 6418.422341989243, 6467.579607325509, 6469.967650161719, 6474.320196379313], "value": 6069.898788404249, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.817274767682, 799.1648727080201, 820.8794994832054, 952.9904700952989, 1108.5731993182621, 29071.854640726768, 35999.10002249942, 37128.0, 37162.81418592907, 37164.0, 39075.0, 39404.40893386601, 39432.014199645026, 39505.80247098768, 39520.01199970002, 8367.581620918929, 8368.832623347529, 8519.82960340796, 8531.232189102979, 8536.8719469208, 8436.029856566513, 8502.914970850305, 8534.317254619615, 8535.57322133894, 8538.316934645245, 8475.660973561051, 8546.529940853281, 8551.947532592196, 8556.315494760403, 8571.571421428935, 8470.237678608924, 8484.618192181366, 8485.575721213945, 8530.189631984951, 8549.95725021374, 8329.250367466897, 8393.664253429917, 8398.328133749286, 8428.53643049632, 8437.57812109392, 37358.81320593407, 37398.813005935066, 37531.24937501262, 37570.812145939366, 37646.43530347047, 3642.8724994625327, 3687.557493100818, 3688.022673991368, 3701.204241088179, 3702.2965636528975, 30751.692483075105, 30767.538486922713, 30823.845880770452, 30832.0, 31143.22141946447, 3132.6867313268717, 3205.0705295464286, 3205.983970080158, 3215.05489179048, 3215.115843143131, 241710.0, 243348.0, 243614.0, 243936.0, 308538.0, 49406.75296623566, 49919.750401248486, 49931.25103123456, 49988.0, 50060.499395006314, 54031.72984135054, 54297.0, 54359.0, 54561.72719136458, 54633.1805022925, 14044.438222471192, 14077.788833167511, 14197.716045679028, 14200.786988195185, 14228.430862765374, 11549.826752598718, 11558.768824623461, 11567.479463424166, 11573.652790416301, 11574.6527604172, 13844.584662459942, 13854.0, 13966.930165349107, 13968.790468142986, 14125.929370353082, 5974.312954010257, 5974.492168165668, 5979.880402392015, 5989.31122920861, 5990.191324171268, 998.495759641391, 1012.8885822559513, 1047.4919663962971, 1076.5263284154946, 1082.0802318029769, 19700.42396608268, 22305.888470557868, 23252.95361708727, 24405.38986525351, 24553.508929821302, 963.5856581669809, 1105.6627728542871, 1134.2173900008968, 1154.6709187881413, 1174.0842143128373, 12182.36098768885, 12578.86790188869, 12588.30764307972, 12610.558630447891, 12622.62132136019, 308877.4556127205, 325595.0, 329317.0602440965, 329912.0, 330145.0, 53492.0, 53840.19239711407, 53844.0, 53893.191602126, 54021.72989135029, 1466.7506523890963, 1509.0719207687193, 1513.833478317384, 1520.6806570620072, 1541.9514729983493, 24140.75859241385, 24201.0, 24347.26958191257, 24732.38169045788, 24896.37759056038, 37670.0, 37823.91968441762, 37846.62153378541, 37960.0, 37993.62006380012, 281652.0, 281938.0, 282618.0, 282919.0, 283645.0, 34117.829410852784, 35078.47382289216, 35108.473372898916, 35109.29781404409, 35264.47103293504, 43864.561354386045, 44202.33696494491, 44700.88247793701, 44782.10435791201, 44968.32547511855, 29002.854985724935, 29668.851655741582, 30290.24274393158, 30499.0, 30530.542041869834, 29843.403131936804, 30023.69976300209, 30700.84649576738, 30767.076987690405, 31042.223944400666, 36316.0, 36340.90977270686, 36354.818225908704, 36370.45444318285, 36413.817930910176, 24752.752472475764, 29094.1271761839, 29385.41229175362, 30502.474876255656, 31099.689003110583, 18760.513896952623, 20547.8972605142, 24082.0, 24319.0, 24403.0], "value": 17478.581706356174, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.5581038762555, 433.85465868933903, 440.6855319330803, 441.2652932866777, 464.6097278286239, 20870.686939695897, 21127.68308475372, 21496.677549836724, 21649.809260490707, 21984.0, 21239.0, 21379.465513362175, 21572.8921355393, 21820.563588728215, 22519.0, 6282.999999999988, 6495.805125846232, 6496.870062598745, 6506.60960342381, 6592.538522303441, 6063.333033366326, 6327.272363678167, 6357.93642063578, 6382.904256436157, 6383.202099737533, 6110.755569777203, 6270.874582508347, 6274.027525733519, 6347.206599175103, 6354.7775827846035, 5345.866353341178, 6250.9062364064575, 6288.968555157241, 6290.0, 6333.5749456372405, 5478.424765399655, 5489.835304940858, 5556.444355564452, 5566.165075238706, 5601.887962240773, 26846.731532684815, 26985.730142698518, 27359.589606155925, 27515.449691006066, 27558.5866212007, 2254.4363909022745, 2317.188983855654, 2319.489712263299, 2324.5467133908896, 2325.2210509479346, 15884.0, 16469.423570175106, 16755.162241887978, 17052.914735426366, 17787.822121778747, 1889.998300900525, 2139.743230812297, 2184.8907554622206, 2198.7251593550805, 2233.7207849018873, 157412.0, 157861.0, 159222.0, 160381.0, 162264.9999999988, 12436.63197048324, 12803.935980320039, 12969.286689232184, 13367.0, 13610.795838062437, 13845.376958036912, 14408.42366305336, 16536.338546458006, 16915.407960721317, 16922.49232523026, 7554.471187016966, 8722.476651400937, 9059.81880362389, 9088.372463825923, 9122.635094596275, 7987.440879138405, 8418.737189421636, 8616.48301101936, 8763.605637746317, 8796.988346340126, 8050.476719013245, 8106.392020598479, 8177.713780017671, 8191.180881911761, 8210.876836847452, 2263.287064574654, 2279.247848210087, 2281.3840263129196, 2282.0529480265504, 2475.851448913071, 845.9323254139654, 925.2366797392178, 979.9853002204973, 982.1553464020936, 1012.1851909213007, 21519.0, 21773.34679959604, 21933.341999740034, 21974.780252197594, 22004.0, 972.8909043690198, 1020.2501161646184, 1041.7239431550645, 1043.6034306963306, 1047.2826114111858, 9747.805043899083, 11306.378149201708, 11480.827787583194, 11494.96545310926, 11503.0, 426250.0, 523151.0, 525288.0, 539399.0, 542612.0, 115397.26904096446, 119823.801761983, 122478.38760806317, 131727.0, 136944.6305536932, 1082.5020490574266, 1191.862935762381, 1200.6758175292623, 1247.6132398956352, 1252.3174869696038, 20672.793272067087, 22435.887820560794, 22621.660675090217, 22895.0, 23147.305580832603, 43293.35059974166, 56785.01252456144, 56885.14672279837, 57449.0, 57702.422975771384, 78175.60912195402, 78641.4271714551, 78761.60619196868, 79081.0, 79910.0, 9033.548322583712, 9120.908790912272, 9244.445333280024, 9252.0, 9256.768580785534, 14258.144511329354, 14400.99193056476, 14462.85537144615, 14637.26813659334, 14783.334749936494, 11795.233309834834, 11832.58585949522, 12146.93926530397, 12181.512739490676, 12373.13388062827, 11376.772464550828, 11560.768784624091, 11639.718743961063, 11710.238834475731, 11838.763224735629, 11555.2489088209, 12279.69300767488, 12379.876201238232, 12629.11596188258, 12647.557335493582, 8423.947006624172, 8487.787805304917, 9096.135867092615, 9238.399504032217, 9264.212541934012, 11584.478698458759, 11992.0, 12210.206336588448, 12226.694332641755, 12268.754624907631], "value": 10586.34994440402, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1174.5830230268257, 1366.6651670340761, 1392.7284179584985, 1415.2569900802082, 1421.7014426970336, 11519.48162332695, 11830.0, 12047.036237101021, 12074.81887771683, 12220.511179552806, 11744.236624619394, 11940.70148246292, 11959.820602690967, 12017.759644807098, 12097.274163550193, 2492.102842976527, 2543.059068144789, 2548.3756479662507, 2562.090457887451, 2571.8585477798715, 2467.938301542467, 2522.709888362834, 2527.734587868275, 2529.380301826055, 2530.7975361971, 2472.6661900643453, 2504.9874750626223, 2527.810414218932, 2529.886155123024, 2538.5684433646234, 2279.1567120165478, 2349.0134143659534, 2458.889349979246, 2468.160825319391, 2508.912188073418, 2393.317904397256, 2471.3450935502105, 2491.2650768023477, 2499.3126890105186, 2503.2740505253637, 11751.001164900994, 11879.524819007229, 11881.5841445549, 11882.28706277626, 11895.167338286323, 5499.312585926759, 6787.2534021257625, 6861.073755043105, 6862.313768623148, 6870.106886104774, 3791.412331088658, 4060.1473690525027, 4450.643948484146, 4455.242608756519, 4465.888352791174, 1196.9401529923468, 1221.2550344289975, 1241.7516496700605, 1289.4519829072606, 1295.740851829638, 15214.239288035555, 15777.211139443096, 16531.6693666126, 16696.165191740365, 16731.247093880684, 5521.4478552145265, 5657.359365783959, 5863.267091613463, 5904.881902361929, 5907.763689452459, 12450.626481205398, 12513.124081314221, 12530.310832904277, 12535.686607834878, 12548.0, 6634.601923884582, 6669.833254168685, 6678.899816502756, 6679.666016699242, 6688.431483323875, 5110.872228194251, 6051.031834906394, 6254.499640028786, 6269.843253918689, 6276.0, 4281.935770963438, 4360.084382279757, 4379.386885835986, 4416.712913660602, 4432.357308190294, 1272.211229037984, 1272.7009152849073, 1291.3406272939228, 1299.0060257504686, 1309.8362704661918, 791.8970533830565, 798.5009369144285, 819.71310041485, 825.6614787936917, 849.099954048698, 4682.765861706901, 6247.312795592481, 6444.130042444303, 6569.0, 6607.372299631527, 589.1751547833068, 591.7899145803264, 607.520059153264, 613.2793967088653, 617.7374615788272, 3350.798952062884, 3710.257948410329, 3983.8406463741126, 4007.3788562772816, 4129.710920235615, 14213.644658883404, 14427.92786036063, 14625.488107916171, 14647.633809154857, 14950.40198392074, 14088.084274522123, 14301.0, 14315.427382904567, 14317.21255330946, 14516.927415362856, 8300.916990830014, 8378.497290162488, 8423.11557286476, 8471.703490377808, 8494.980602327636, 7158.713651454092, 7178.210396856446, 7365.8158546036775, 7398.96300518494, 7424.925750742639, 13243.47026118983, 13480.0, 13717.0, 13746.312684365541, 13758.31208439594, 12255.0, 13755.83075438599, 13833.584992450242, 14015.299235038412, 14055.789163162764, 9631.855522167032, 9787.46168960714, 9790.559424825757, 9809.950950245204, 9813.85279220798, 10664.786704266027, 10947.890521094687, 10973.23187376876, 11035.668929932115, 11063.059639930696, 9294.14045605703, 9308.394954327947, 9316.580753865957, 9470.384425012353, 9484.95257523708, 9121.589528471368, 9189.678361257324, 9288.58201380953, 9308.906910930804, 9310.441373517611, 8213.95893020531, 8404.579771011548, 8420.15798420153, 8489.320854331761, 8504.872426913478, 4761.333413322069, 6064.666443345658, 6109.327973922776, 6180.072989051679, 6196.256449226122, 4920.941997470561, 5875.353711091862, 6018.097285407224, 6261.78083767066, 6352.777652782131], "value": 5333.723033139033, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.00808501729654, 388.4658594432655, 405.09663450505354, 412.66780241905275, 415.0909508177092, 5502.449755024496, 5704.429557044294, 6236.314005459401, 6276.027215781555, 6327.588706734059, 4893.804247830082, 5980.431858973401, 6014.368491308415, 6087.0, 6119.847003824895, 3640.2719456108753, 3864.6908247340143, 4460.5430791136805, 4461.018575913294, 4468.346711716653, 4310.224159651277, 4425.513193548707, 4430.49049359323, 4475.216837053519, 4478.798454069574, 3789.677877380426, 4393.384926110347, 4395.86812395627, 4409.037978099747, 4417.889552761175, 4373.882557407825, 4394.1870753910625, 4412.925924815364, 4424.424824772759, 4440.644748420119, 3159.4786860168047, 3712.7215458840697, 3770.7171962102952, 3810.961890381116, 3829.8361425794337, 4473.753943533105, 5107.182850743863, 5325.600579956519, 5675.836453527058, 5923.0, 5215.947840521584, 5328.147496400596, 5333.599980001515, 5343.438938911436, 5359.892802143974, 5304.6286759926825, 5582.637128586629, 6231.003039513701, 6451.51613628975, 6497.837554061139, 3973.562908080109, 4363.400194839239, 4363.912721745579, 4369.847055353048, 4383.627391671712, 6727.2482027866445, 6867.484938629623, 6905.205901321312, 6940.201876784184, 6970.0, 4387.3857659927635, 4395.164918665443, 4396.648268138541, 4418.381426600278, 4420.916875365556, 3752.4558938954247, 4329.895876551459, 4485.8112600160985, 4489.967307519289, 4491.550844915548, 4575.7483338416705, 4594.793234304464, 5260.408452925418, 5285.55072818807, 5366.892662146735, 6525.412712855866, 6543.1821022372205, 6560.343965603402, 6562.9827376756675, 6586.242582103024, 1351.7431687979251, 1391.7494850926728, 1532.2338830584708, 1535.109636410879, 1536.9231538423035, 995.8207522645994, 1008.7276435362411, 1011.4234886114843, 1013.5844303835393, 1026.0662796854826, 5016.322796422436, 5225.372955245319, 6002.039673652194, 6259.749610015549, 6293.874122517524, 5596.776128954796, 6124.6325220486915, 6495.512836537278, 6750.3249675033085, 6757.763478278237, 5637.436256374412, 5762.625429347163, 5879.353271140171, 6245.688405434818, 6292.46514046302, 3041.874506432634, 3170.556122142902, 3515.5605549306338, 3549.467579863041, 3557.288542291552, 5422.213779002022, 5765.913511297334, 6736.292689267556, 6926.238113807477, 6993.622168462747, 5723.370429252779, 6057.151998720183, 6457.2896981332015, 6473.676316184172, 6572.441342485942, 5972.432618901197, 6417.518686098561, 6475.805725828232, 6819.681308355183, 6953.582785032914, 5448.645838020516, 6809.897851532132, 6843.0, 6857.457072158724, 6878.518503704692, 6131.294901086254, 6140.907886381798, 6517.250516190698, 6744.7976560703255, 6769.526133170828, 6021.939780602138, 6645.840101966784, 7030.367266945795, 7057.752978645723, 7064.364207221375, 4408.0, 4426.15902978433, 4432.423784907941, 4455.598996090367, 4458.665600079942, 5530.861728456821, 6142.0, 6389.2971773105855, 6837.931620683729, 6844.0, 5852.561057920588, 6196.442320191204, 6603.306652801579, 6606.636634985122, 6611.446310117022, 6167.374469148139, 6207.317195108625, 6253.78111766086, 6539.869202616016, 6574.276829548841, 6103.870783904992, 6499.5775274607, 6505.73977040932, 6511.38141876521, 6524.347565243438, 5834.562407819515, 5999.0, 6363.6499992499, 6596.241432235162, 6606.339366063356, 6391.909178126096, 6445.6454894981225, 6479.157709497924, 6490.123833282635, 6506.674666266573], "value": 4676.965625844111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.255470076931, 838.1743982177555, 838.39635462467, 859.5788063848712, 863.8747381629665, 16033.679326413465, 16767.83232167678, 16826.990380577157, 18315.725264121047, 19029.904850475727, 17505.299788008466, 17761.555961100978, 17803.931764094163, 17960.9223446593, 18143.0, 928.2805825485269, 935.780091678455, 947.4362754161263, 951.3863558005082, 952.9993506817848, 943.9480828554426, 960.2462067277189, 963.2197919685043, 967.3615413826876, 968.0368033806373, 1038.3043360948184, 1042.7445275907376, 1044.8171569975261, 1045.0855501436242, 1051.1695760349353, 1015.781606954501, 1035.404642330663, 1039.4127318065307, 1040.1314902056754, 1048.4128887822844, 722.53396559219, 743.4535616321999, 754.2457542457543, 757.5909009135061, 768.8154842837735, 16295.103769292684, 16383.344666213337, 16417.58956026097, 16482.75275870863, 16484.587885302844, 16160.353585856552, 16469.670606587923, 16782.83217167825, 16787.992720436814, 16904.323827046905, 13648.112872663245, 13778.862211377858, 14046.71906561863, 14081.225532595703, 14082.577522674335, 2951.631046119235, 3079.9846000769853, 3519.8240087995496, 3541.8937431877084, 3541.9291614167573, 109746.0, 109914.45042774735, 110731.44634276857, 110890.44554777256, 111874.0, 13008.804867926989, 13307.600771976857, 13377.73244535104, 13425.597232083053, 13460.798088028687, 24231.878840605685, 24576.87711561431, 24841.130560430298, 25158.993640254186, 25174.874125629256, 7846.293833554893, 7911.525308481395, 7932.08780990182, 7954.840903181904, 7968.402369822286, 3867.207222519377, 3908.9804550977065, 3937.822797974098, 3938.232044751246, 3941.0935484838647, 4205.957940420618, 4255.404243405926, 4297.806598703066, 4300.161468513672, 4321.503027151855, 918.4948278446827, 948.9572969216401, 953.909378609031, 958.8130314588727, 959.2278216036158, 551.7489542258263, 610.3133974278936, 634.508256101525, 643.6492111799081, 652.7617419641797, 11061.0, 11410.315381077162, 11846.111541634413, 12059.336736479403, 12131.5147394105, 627.883841489326, 648.1800522339245, 649.9220093588799, 675.6148995072762, 690.7444245629149, 5263.26314315996, 5558.305211848519, 5592.552595792326, 5626.859328516738, 5639.6334238274385, 108031.45984270028, 108788.0, 108815.45592271988, 109002.90997090086, 109296.4535177319, 97385.5130724356, 98230.52654210193, 98269.0, 98294.0, 98426.0, 83955.0, 85487.0, 85689.14310856936, 86271.0, 86787.0, 8415.789605259917, 10813.134949203888, 11167.664970050912, 11381.918717721803, 11466.598669046543, 42515.7874210627, 42651.57348426476, 42749.145017100105, 43074.70775876729, 43172.56827431811, 38844.0, 55015.0, 55122.72438637781, 55435.16847247375, 55597.44402555923, 13966.0, 13994.440222390991, 14060.648483787987, 14186.432542698176, 14211.431542738175, 15237.085774853102, 15565.92217038953, 15588.610284742519, 15606.687866242839, 15759.527214183592, 14525.055871368328, 14536.200508971686, 14583.197924114276, 14614.415423382945, 14699.0, 11988.700282493008, 14362.784558231844, 14392.352344144329, 14539.273036348352, 14603.415863365772, 14215.147091174562, 14254.928725356307, 14262.57212283633, 14308.856911431169, 14382.065165764192, 10355.896441035493, 10509.479324426402, 10598.841017384899, 10830.025297723243, 10835.783284334428, 11190.32858028521, 13051.738965220833, 13189.208647481182, 13644.454221831016, 14186.858131418967], "value": 8126.835924659087, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 115.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 113.0, 119.0, 185.0, 112.0, 113.0, 121.0, 137.0, 135.0, 115.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 196.0, 195.0, 213.0, 217.0, 211.0, 210.0, 197.0, 200.0, 191.0], "value": 202.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 57.0, 82.0, 57.0, 58.0, 59.0, 56.0, 76.0, 62.0], "value": 64.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 82.0, 71.0, 70.0, 69.0, 90.0, 68.0, 69.0, 90.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 88.0, 90.0, 88.0, 88.0, 89.0, 90.0, 88.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 123.0, 96.0, 97.0, 95.0], "value": 99.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 80.0, 100.0, 103.0, 97.0, 141.0, 144.0, 137.0, 108.0, 92.0], "value": 109.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 54.0, 53.0, 50.0, 51.0, 51.0, 54.0, 58.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 56.0, 56.0, 61.0, 58.0, 57.0, 58.0, 54.0, 55.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 86.0, 84.0, 82.0, 83.0, 84.0, 84.0, 73.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 142.0, 153.0, 155.0, 150.0, 159.0, 158.0, 187.0, 140.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 186.0, 186.0, 164.0, 245.0, 237.0, 168.0, 232.0, 254.0, 208.0], "value": 210.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 67.0, 68.0, 70.0, 78.0, 96.0, 80.0, 69.0, 69.0], "value": 73.1, "unit": "score"}]}]} 04:19:57 INFO - Return code: 0 04:19:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:19:57 ERROR - # TBPL SUCCESS # 04:19:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:19:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:19:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:19:57 INFO - 2017-04-22 04:19:57.575 screenresolution[1689:12186] starting screenresolution argv=screenresolution get 04:19:57 INFO - 2017-04-22 04:19:57.578 screenresolution[1689:12186] Display 0: 1600x1200x32@60 04:19:57 INFO - 2017-04-22 04:19:57.584 screenresolution[1690:12189] starting screenresolution argv=screenresolution list 04:19:57 INFO - Available Modes on Display 0 04:19:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:19:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:19:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:19:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:19:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:19:57 INFO - Intel Iris: 04:19:57 INFO - Chipset Model: Intel Iris 04:19:57 INFO - Type: GPU 04:19:57 INFO - Bus: Built-In 04:19:57 INFO - VRAM (Dynamic, Max): 1536 MB 04:19:57 INFO - Vendor: Intel (0x8086) 04:19:57 INFO - Device ID: 0x0a2e 04:19:57 INFO - Revision ID: 0x0009 04:19:57 INFO - Displays: 04:19:57 INFO - Display: 04:19:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:19:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:19:57 INFO - Display Serial Number: 1600x1200 60 04:19:57 INFO - Main Display: Yes 04:19:57 INFO - Mirror: Off 04:19:57 INFO - Online: Yes 04:19:57 INFO - Rotation: Supported 04:19:57 INFO - Return code: 0 04:19:57 INFO - Running post-action listener: _resource_record_post_action 04:19:57 INFO - [mozharness: 2017-04-22 11:19:57.825555Z] Finished run-tests step (success) 04:19:57 INFO - Running post-run listener: _resource_record_post_run 04:19:57 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 34927104; Write bytes: 515847168; Read time: 318; Write time: 2040 04:19:57 INFO - TinderboxPrint: CPU usage
54.0% 04:19:57 INFO - TinderboxPrint: I/O read bytes / time
34,927,104 / 318 04:19:57 INFO - TinderboxPrint: I/O write bytes / time
515,847,168 / 2,040 04:19:57 INFO - TinderboxPrint: CPU idle
2,201.0 (46.0%) 04:19:57 INFO - TinderboxPrint: CPU system
959.6 (20.1%) 04:19:57 INFO - TinderboxPrint: CPU user
1,625.0 (34.0%) 04:19:57 INFO - TinderboxPrint: Swap in / out
238,981,120 / 0 04:19:57 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207661568; Write bytes: 206525952; Read time: 15913; Write time: 513 04:19:57 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29946368; Write bytes: 302112256; Read time: 285; Write time: 1497 04:19:58 INFO - Running post-run listener: _upload_blobber_files 04:19:58 INFO - Blob upload gear active. 04:19:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:19:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:59 INFO - (blobuploader) - INFO - Done attempting. 04:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:00 INFO - (blobuploader) - INFO - Done attempting. 04:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:01 INFO - (blobuploader) - INFO - Done attempting. 04:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:03 INFO - (blobuploader) - INFO - Done attempting. 04:20:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:03 INFO - Return code: 0 04:20:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:20:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec7944369787827cfeed8019099531d8fe01c2353994d2b0430204b8ee170ad26697acc776f1c3a48d3a004baae50f739877a102a88b7cde4228e3a2d3b68cff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff5d069e8fa5c05b280b6ce17277bce3b706c8ba5226a72c078a3de890add394471fd960cc709e52ed3caf391cc3a0e3036d1bc5092337a4c8865ac33520163", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f5d3d8280baebe310012523c8307a0bde47a8e919da9c5b47b80a90f5f19918b21464133a8c4b722284b95ca7585a6da880c3e7d738e693c0b6f03ae2e61cce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6edaf70c015a34b720a5d02acf6afeb5f2982d47b3d1b395235502f357e9915c188cd82487841bd15284f43bf7192210aee6d7bced2cfa85bceca168655aa9d1"} 04:20:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:20:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:20:03 INFO - Contents: 04:20:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec7944369787827cfeed8019099531d8fe01c2353994d2b0430204b8ee170ad26697acc776f1c3a48d3a004baae50f739877a102a88b7cde4228e3a2d3b68cff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff5d069e8fa5c05b280b6ce17277bce3b706c8ba5226a72c078a3de890add394471fd960cc709e52ed3caf391cc3a0e3036d1bc5092337a4c8865ac33520163", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f5d3d8280baebe310012523c8307a0bde47a8e919da9c5b47b80a90f5f19918b21464133a8c4b722284b95ca7585a6da880c3e7d738e693c0b6f03ae2e61cce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6edaf70c015a34b720a5d02acf6afeb5f2982d47b3d1b395235502f357e9915c188cd82487841bd15284f43bf7192210aee6d7bced2cfa85bceca168655aa9d1"} 04:20:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:20:03 INFO - Copying logs to upload dir... 04:20:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:20:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.599330 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-22 04:20:03.963211) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-22 04:20:03.966867) ========= 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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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/Firefox/sha512/ec7944369787827cfeed8019099531d8fe01c2353994d2b0430204b8ee170ad26697acc776f1c3a48d3a004baae50f739877a102a88b7cde4228e3a2d3b68cff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff5d069e8fa5c05b280b6ce17277bce3b706c8ba5226a72c078a3de890add394471fd960cc709e52ed3caf391cc3a0e3036d1bc5092337a4c8865ac33520163", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f5d3d8280baebe310012523c8307a0bde47a8e919da9c5b47b80a90f5f19918b21464133a8c4b722284b95ca7585a6da880c3e7d738e693c0b6f03ae2e61cce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6edaf70c015a34b720a5d02acf6afeb5f2982d47b3d1b395235502f357e9915c188cd82487841bd15284f43bf7192210aee6d7bced2cfa85bceca168655aa9d1"} build_url:https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011059 build_url: 'https://queue.taskcluster.net/v1/task/PMZx_zt5S7aTtvUUXXpeyw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec7944369787827cfeed8019099531d8fe01c2353994d2b0430204b8ee170ad26697acc776f1c3a48d3a004baae50f739877a102a88b7cde4228e3a2d3b68cff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff5d069e8fa5c05b280b6ce17277bce3b706c8ba5226a72c078a3de890add394471fd960cc709e52ed3caf391cc3a0e3036d1bc5092337a4c8865ac33520163", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f5d3d8280baebe310012523c8307a0bde47a8e919da9c5b47b80a90f5f19918b21464133a8c4b722284b95ca7585a6da880c3e7d738e693c0b6f03ae2e61cce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6edaf70c015a34b720a5d02acf6afeb5f2982d47b3d1b395235502f357e9915c188cd82487841bd15284f43bf7192210aee6d7bced2cfa85bceca168655aa9d1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-22 04:20:04.004578) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 04:20:04.005180) ========= 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.USJrvEcwEE/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.mK3bdY4Ttc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.005126 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 04:20:04.056487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-22 04:20:04.057007) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-22 04:20:04.057688) ========= ========= Total master_lag: 0.21 =========