builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0106 starttime: 1492857698.42 results: success (0) buildid: 20170422014420 builduid: f077599d6227461f970e7183411b76de revision: 4ad23bc8d5c12134fd61970e56a4b305acfeb16e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:38.418956) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:38.419630) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:38.420138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:38.509330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:38.509838) ========= 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.uEXSfivN15/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.6d1YOz3NPn/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:41:38-- 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% 38.7M=0s 2017-04-22 03:41:38 (38.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.170278 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:38.720479) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:38.720951) ========= 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.uEXSfivN15/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.6d1YOz3NPn/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.029647 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:38.782974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:38.783572) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4ad23bc8d5c12134fd61970e56a4b305acfeb16e --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 4ad23bc8d5c12134fd61970e56a4b305acfeb16e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uEXSfivN15/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.6d1YOz3NPn/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:41:38,887 truncating revision to first 12 chars 2017-04-22 03:41:38,887 Setting DEBUG logging. 2017-04-22 03:41:38,887 attempt 1/10 2017-04-22 03:41:38,887 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4ad23bc8d5c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-22 03:41:39,507 unpacking tar archive at: mozilla-central-4ad23bc8d5c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.895963 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:39.705733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:39.706056) ========= script_repo_revision: 4ad23bc8d5c12134fd61970e56a4b305acfeb16e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:39.706570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:39.706857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-22 03:41:39.727890) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-22 03:41:39.728511) ========= /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.uEXSfivN15/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.6d1YOz3NPn/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:41:39 INFO - MultiFileLogger online at 20170422 03:41:39 in /builds/slave/test 03:41:39 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:41:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:41:39 INFO - {'append_to_log': False, 03:41:39 INFO - 'base_work_dir': '/builds/slave/test', 03:41:39 INFO - 'blob_upload_branch': 'Firefox', 03:41:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:41:39 INFO - 'branch': 'Firefox', 03:41:39 INFO - 'buildbot_json_path': 'buildprops.json', 03:41:39 INFO - 'config_files': ('talos/mac_config.py',), 03:41:39 INFO - 'default_actions': ('clobber', 03:41:39 INFO - 'read-buildbot-config', 03:41:39 INFO - 'download-and-extract', 03:41:39 INFO - 'populate-webroot', 03:41:39 INFO - 'create-virtualenv', 03:41:39 INFO - 'install', 03:41:39 INFO - 'run-tests'), 03:41:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:41:39 INFO - 'download_minidump_stackwalk': True, 03:41:39 INFO - 'download_symbols': 'ondemand', 03:41:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:41:39 INFO - 'tooltool.py': '/tools/tooltool.py', 03:41:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:41:39 INFO - '/tools/misc-python/virtualenv.py')}, 03:41:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:41:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:41:39 INFO - 'gecko_profile': False, 03:41:39 INFO - 'gecko_profile_interval': 0, 03:41:39 INFO - 'installer_path': 'installer.exe', 03:41:39 INFO - 'log_level': 'info', 03:41:39 INFO - 'log_name': 'talos', 03:41:39 INFO - 'log_to_console': True, 03:41:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:41:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:41:39 INFO - 'opt_config_files': (), 03:41:39 INFO - 'pip_index': False, 03:41:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:41:39 INFO - 'cmd': ('bash', 03:41:39 INFO - '-c', 03:41:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:41:39 INFO - 'enabled': True, 03:41:39 INFO - 'halt_on_failure': False, 03:41:39 INFO - 'name': 'check_screen_resolution'},), 03:41:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:41:39 INFO - 'cmd': ('bash', 03:41:39 INFO - '-c', 03:41:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:41:39 INFO - 'enabled': True, 03:41:39 INFO - 'halt_on_failure': False, 03:41:39 INFO - 'name': 'check_screen_resolution'},), 03:41:39 INFO - 'run_cmd_checks_enabled': True, 03:41:39 INFO - 'suite': 'dromaeojs-e10s', 03:41:39 INFO - 'system_bits': '32', 03:41:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:41:39 INFO - 'title': 't-yosemite-r7-0106', 03:41:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:41:39 INFO - 'use_talos_json': True, 03:41:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:41:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:41:39 INFO - 'work_dir': 'build'} 03:41:39 INFO - [mozharness: 2017-04-22 10:41:39.945287Z] Running clobber step. 03:41:39 INFO - Running pre-action listener: _resource_record_pre_action 03:41:39 INFO - Running main action method: clobber 03:41:39 INFO - rmtree: /builds/slave/test/build 03:41:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:41:42 INFO - Running post-action listener: _resource_record_post_action 03:41:42 INFO - [mozharness: 2017-04-22 10:41:42.503702Z] Finished clobber step (success) 03:41:42 INFO - [mozharness: 2017-04-22 10:41:42.503900Z] Running read-buildbot-config step. 03:41:42 INFO - Running pre-action listener: _resource_record_pre_action 03:41:42 INFO - Running main action method: read_buildbot_config 03:41:42 INFO - Using buildbot properties: 03:41:42 INFO - { 03:41:42 INFO - "project": "", 03:41:42 INFO - "product": "firefox", 03:41:42 INFO - "script_repo_revision": "production", 03:41:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:41:42 INFO - "repository": "", 03:41:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:41:42 INFO - "buildid": "20170422014420", 03:41:42 INFO - "pgo_build": "False", 03:41:42 INFO - "basedir": "/builds/slave/test", 03:41:42 INFO - "buildnumber": 200, 03:41:42 INFO - "slavename": "t-yosemite-r7-0106", 03:41:42 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:41:42 INFO - "platform": "yosemite_r7", 03:41:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:41:42 INFO - "branch": "mozilla-central", 03:41:42 INFO - "repo_path": "mozilla-central", 03:41:42 INFO - "revision": "4ad23bc8d5c12134fd61970e56a4b305acfeb16e", 03:41:42 INFO - "stage_platform": "macosx64", 03:41:42 INFO - "builduid": "f077599d6227461f970e7183411b76de", 03:41:42 INFO - "slavebuilddir": "test" 03:41:42 INFO - } 03:41:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:41:42 INFO - Running post-action listener: _resource_record_post_action 03:41:42 INFO - [mozharness: 2017-04-22 10:41:42.507343Z] Finished read-buildbot-config step (success) 03:41:42 INFO - [mozharness: 2017-04-22 10:41:42.507480Z] Running download-and-extract step. 03:41:42 INFO - Running pre-action listener: _resource_record_pre_action 03:41:42 INFO - Running main action method: download_and_extract 03:41:42 INFO - mkdir: /builds/slave/test/build/tests 03:41:42 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:41:42 INFO - trying https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:41:42 INFO - Downloading https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/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:41:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/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:41:43 INFO - Downloaded 1325 bytes. 03:41:43 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:41:43 INFO - Using the following test package requirements: 03:41:43 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:41:43 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:41:43 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:41:43 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:41:43 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:41:43 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:41:43 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:41:43 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:41:43 INFO - u'jsshell-mac.zip'], 03:41:43 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:41:43 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:41:43 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:41:43 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:41:43 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:41:43 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:41:43 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:41:43 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:41:43 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:41:43 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:41:43 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:41:43 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:41:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:41:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:41:43 INFO - Fetch https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:41:45 INFO - Content-Length response header: 52525136 03:41:45 INFO - Bytes received: 52525136 03:42:01 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:42:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:42:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:42:01 INFO - Fetch https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:42:03 INFO - Content-Length response header: 52525136 03:42:03 INFO - Bytes received: 52525136 03:42:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:42:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:42:19 INFO - Fetch https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:42:19 INFO - Content-Length response header: 14408811 03:42:19 INFO - Bytes received: 14408811 03:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:20 INFO - trying https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:42:20 INFO - Downloading https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/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:42:22 INFO - Downloaded 71038546 bytes. 03:42:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:42:22 INFO - mkdir: /builds/slave/test/properties 03:42:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:42:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:42:22 INFO - Contents: 03:42:22 INFO - build_url:https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:42:22 INFO - Running post-action listener: _resource_record_post_action 03:42:22 INFO - Running post-action listener: set_extra_try_arguments 03:42:22 INFO - [mozharness: 2017-04-22 10:42:22.938955Z] Finished download-and-extract step (success) 03:42:22 INFO - [mozharness: 2017-04-22 10:42:22.939093Z] Running populate-webroot step. 03:42:22 INFO - Running pre-action listener: _resource_record_pre_action 03:42:22 INFO - Running main action method: populate_webroot 03:42:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:42:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:42:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:42:22 INFO - '--tppagecycles', 03:42:22 INFO - '7'], 03:42:22 INFO - 'tests': ['tsvgm']}}, 03:42:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:42:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:42:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:42:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:42:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:42:22 INFO - 'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:42:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:42:22 INFO - 'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['damp', 'tps']}, 03:42:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:42:22 INFO - 'tests': ['damp', 'tps']}, 03:42:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['dromaeo_dom']}, 03:42:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:42:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:42:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:42:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['a11yr', 03:42:22 INFO - 'ts_paint', 03:42:22 INFO - 'tpaint', 03:42:22 INFO - 'sessionrestore', 03:42:22 INFO - 'sessionrestore_no_auto_restore', 03:42:22 INFO - 'tabpaint']}, 03:42:22 INFO - 'other-e10s': {'tests': ['a11yr', 03:42:22 INFO - 'ts_paint', 03:42:22 INFO - 'tpaint', 03:42:22 INFO - 'sessionrestore', 03:42:22 INFO - 'sessionrestore_no_auto_restore', 03:42:22 INFO - 'tabpaint']}, 03:42:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:42:22 INFO - 'ts_paint', 03:42:22 INFO - 'tpaint', 03:42:22 INFO - 'sessionrestore', 03:42:22 INFO - 'sessionrestore_no_auto_restore', 03:42:22 INFO - 'tabpaint']}, 03:42:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:42:22 INFO - 'ts_paint', 03:42:22 INFO - 'tpaint', 03:42:22 INFO - 'sessionrestore', 03:42:22 INFO - 'sessionrestore_no_auto_restore', 03:42:22 INFO - 'tabpaint']}, 03:42:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['a11yr', 03:42:22 INFO - 'ts_paint', 03:42:22 INFO - 'tpaint', 03:42:22 INFO - 'sessionrestore', 03:42:22 INFO - 'sessionrestore_no_auto_restore', 03:42:22 INFO - 'tabpaint']}, 03:42:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['a11yr', 03:42:22 INFO - 'ts_paint', 03:42:22 INFO - 'tpaint', 03:42:22 INFO - 'sessionrestore', 03:42:22 INFO - 'sessionrestore_no_auto_restore', 03:42:22 INFO - 'tabpaint']}, 03:42:22 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:42:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:42:22 INFO - 'bloom_basic_ref']}, 03:42:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['tsvgx', 03:42:22 INFO - 'tsvgr_opacity', 03:42:22 INFO - 'tart', 03:42:22 INFO - 'tscrollx', 03:42:22 INFO - 'cart', 03:42:22 INFO - 'tsvg_static']}, 03:42:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:42:22 INFO - 'tsvgr_opacity', 03:42:22 INFO - 'tart', 03:42:22 INFO - 'tscrollx', 03:42:22 INFO - 'cart', 03:42:22 INFO - 'tsvg_static']}, 03:42:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:42:22 INFO - 'talos_options': ['--disable-e10s'], 03:42:22 INFO - 'tests': ['tp5o']}, 03:42:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:42:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:42:22 INFO - 'talos_options': ['--disable-e10s', 03:42:22 INFO - '--xperf_path', 03:42:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:22 INFO - 'tests': ['tp5n']}, 03:42:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:42:22 INFO - 'talos_options': ['--xperf_path', 03:42:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:22 INFO - 'tests': ['tp5n']}}, 03:42:22 INFO - 'talos.zip': {'path': '', 03:42:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:42:22 INFO - Running post-action listener: _resource_record_post_action 03:42:22 INFO - [mozharness: 2017-04-22 10:42:22.957538Z] Finished populate-webroot step (success) 03:42:22 INFO - [mozharness: 2017-04-22 10:42:22.957649Z] Running create-virtualenv step. 03:42:22 INFO - Running pre-action listener: _resource_record_pre_action 03:42:22 INFO - Running main action method: create_virtualenv 03:42:22 INFO - Creating virtualenv /builds/slave/test/build/venv 03:42:22 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:42:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:42:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:42:23 INFO - Using real prefix '/tools/python27' 03:42:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:42:23 INFO - Installing distribute.............................................................................................................................................................................................done. 03:42:26 INFO - Installing pip.................done. 03:42:26 INFO - Return code: 0 03:42:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:42:26 INFO - Reading from file tmpfile_stdout 03:42:26 INFO - Output received: 03:42:26 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:42:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:26 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 0x109e52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d80595b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, '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.uEXSfivN15/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.6d1YOz3NPn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:42:26 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:42:26 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:42:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:42:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:26 INFO - 'HOME': '/Users/cltbld', 03:42:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:26 INFO - 'LOGNAME': 'cltbld', 03:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:26 INFO - 'MOZ_NO_REMOTE': '1', 03:42:26 INFO - 'NO_EM_RESTART': '1', 03:42:26 INFO - 'PAGER': '/bin/cat', 03:42:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:26 INFO - 'PWD': '/builds/slave/test', 03:42:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:26 INFO - 'SHELL': '/bin/bash', 03:42:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:42:26 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:42:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:26 INFO - 'USER': 'cltbld', 03:42:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:26 INFO - 'XPC_FLAGS': '0x0', 03:42:26 INFO - 'XPC_SERVICE_NAME': '0', 03:42:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:42:27 INFO - Cleaning up... 03:42:27 INFO - Return code: 0 03:42:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d80595b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, '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.uEXSfivN15/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.6d1YOz3NPn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:42:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:42:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:27 INFO - 'HOME': '/Users/cltbld', 03:42:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:27 INFO - 'LOGNAME': 'cltbld', 03:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:27 INFO - 'MOZ_NO_REMOTE': '1', 03:42:27 INFO - 'NO_EM_RESTART': '1', 03:42:27 INFO - 'PAGER': '/bin/cat', 03:42:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:27 INFO - 'PWD': '/builds/slave/test', 03:42:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:27 INFO - 'SHELL': '/bin/bash', 03:42:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:42:27 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:42:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:27 INFO - 'USER': 'cltbld', 03:42:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:27 INFO - 'XPC_FLAGS': '0x0', 03:42:27 INFO - 'XPC_SERVICE_NAME': '0', 03:42:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:27 INFO - Downloading/unpacking psutil>=3.1.1 03:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:42:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:31 INFO - Installing collected packages: psutil 03:42:31 INFO - Running setup.py install for psutil 03:42:31 INFO - building 'psutil._psutil_osx' extension 03:42:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:42:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:42:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:42:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:42:32 INFO - building 'psutil._psutil_posix' extension 03:42:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:42:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:42:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:42:32 INFO - ^ 03:42:32 INFO - 1 warning generated. 03:42:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:42:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:32 INFO - Successfully installed psutil 03:42:32 INFO - Cleaning up... 03:42:32 INFO - Return code: 0 03:42:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:42: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:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d80595b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, '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.uEXSfivN15/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.6d1YOz3NPn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:42:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:42:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:42:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:32 INFO - 'HOME': '/Users/cltbld', 03:42:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:32 INFO - 'LOGNAME': 'cltbld', 03:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:32 INFO - 'MOZ_NO_REMOTE': '1', 03:42:32 INFO - 'NO_EM_RESTART': '1', 03:42:32 INFO - 'PAGER': '/bin/cat', 03:42:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:32 INFO - 'PWD': '/builds/slave/test', 03:42:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:32 INFO - 'SHELL': '/bin/bash', 03:42:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:42:32 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:42:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:32 INFO - 'USER': 'cltbld', 03:42:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:32 INFO - 'XPC_FLAGS': '0x0', 03:42:32 INFO - 'XPC_SERVICE_NAME': '0', 03:42:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:42: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:42: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:42: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:42: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:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:42:35 INFO - Installing collected packages: mozsystemmonitor 03:42:35 INFO - Running setup.py install for mozsystemmonitor 03:42:35 INFO - Successfully installed mozsystemmonitor 03:42:35 INFO - Cleaning up... 03:42:35 INFO - Return code: 0 03:42:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d80595b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, '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.uEXSfivN15/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.6d1YOz3NPn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:42:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:42:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:35 INFO - 'HOME': '/Users/cltbld', 03:42:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:35 INFO - 'LOGNAME': 'cltbld', 03:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:35 INFO - 'MOZ_NO_REMOTE': '1', 03:42:35 INFO - 'NO_EM_RESTART': '1', 03:42:35 INFO - 'PAGER': '/bin/cat', 03:42:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:35 INFO - 'PWD': '/builds/slave/test', 03:42:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:35 INFO - 'SHELL': '/bin/bash', 03:42:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:42:35 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:42:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:35 INFO - 'USER': 'cltbld', 03:42:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:35 INFO - 'XPC_FLAGS': '0x0', 03:42:35 INFO - 'XPC_SERVICE_NAME': '0', 03:42:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:36 INFO - Downloading/unpacking jsonschema==2.5.1 03:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:42:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:42: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:42: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:42: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:42: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:42: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:42: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:42:39 INFO - Downloading functools32-3.2.3-2.tar.gz 03:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:42:39 INFO - warning: no files found matching '*.txt' 03:42:39 INFO - no previously-included directories found matching 'build' 03:42:39 INFO - no previously-included directories found matching 'dist' 03:42:39 INFO - no previously-included directories found matching '.git*' 03:42:39 INFO - Installing collected packages: jsonschema, functools32 03:42:39 INFO - Running setup.py install for functools32 03:42:39 INFO - warning: no files found matching '*.txt' 03:42:39 INFO - no previously-included directories found matching 'build' 03:42:39 INFO - no previously-included directories found matching 'dist' 03:42:39 INFO - no previously-included directories found matching '.git*' 03:42:39 INFO - Successfully installed jsonschema functools32 03:42:39 INFO - Cleaning up... 03:42:39 INFO - Return code: 0 03:42:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d80595b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, '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.uEXSfivN15/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.6d1YOz3NPn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:42:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:42:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:42:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:39 INFO - 'HOME': '/Users/cltbld', 03:42:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:39 INFO - 'LOGNAME': 'cltbld', 03:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:39 INFO - 'MOZ_NO_REMOTE': '1', 03:42:39 INFO - 'NO_EM_RESTART': '1', 03:42:39 INFO - 'PAGER': '/bin/cat', 03:42:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:39 INFO - 'PWD': '/builds/slave/test', 03:42:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:39 INFO - 'SHELL': '/bin/bash', 03:42:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:42:39 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:42:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:39 INFO - 'USER': 'cltbld', 03:42:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:39 INFO - 'XPC_FLAGS': '0x0', 03:42:39 INFO - 'XPC_SERVICE_NAME': '0', 03:42:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:42:39 INFO - Cleaning up... 03:42:39 INFO - Return code: 0 03:42:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d80595b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, '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.uEXSfivN15/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.6d1YOz3NPn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:42:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:42:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:42:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:39 INFO - 'HOME': '/Users/cltbld', 03:42:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:39 INFO - 'LOGNAME': 'cltbld', 03:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:39 INFO - 'MOZ_NO_REMOTE': '1', 03:42:39 INFO - 'NO_EM_RESTART': '1', 03:42:39 INFO - 'PAGER': '/bin/cat', 03:42:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:39 INFO - 'PWD': '/builds/slave/test', 03:42:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:39 INFO - 'SHELL': '/bin/bash', 03:42:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:42:39 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:42:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:39 INFO - 'USER': 'cltbld', 03:42:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:39 INFO - 'XPC_FLAGS': '0x0', 03:42:39 INFO - 'XPC_SERVICE_NAME': '0', 03:42:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:42 INFO - Downloading blobuploader-1.2.4.tar.gz 03:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:42:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:42:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:42:43 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:42:43 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:42:43 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:42:43 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:42:43 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:42:43 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:42:43 INFO - Downloading docopt-0.6.1.tar.gz 03:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:42:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:42:44 INFO - Running setup.py install for blobuploader 03:42:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:42:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:42:44 INFO - Running setup.py install for requests 03:42:44 INFO - Running setup.py install for docopt 03:42:44 INFO - Successfully installed blobuploader requests docopt 03:42:44 INFO - Cleaning up... 03:42:45 INFO - Return code: 0 03:42:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42: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:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:45 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 0x109e52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d80595b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, '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.uEXSfivN15/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.6d1YOz3NPn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:42:45 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:42:45 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:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:45 INFO - 'HOME': '/Users/cltbld', 03:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:45 INFO - 'LOGNAME': 'cltbld', 03:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:45 INFO - 'MOZ_NO_REMOTE': '1', 03:42:45 INFO - 'NO_EM_RESTART': '1', 03:42:45 INFO - 'PAGER': '/bin/cat', 03:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:45 INFO - 'PWD': '/builds/slave/test', 03:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:45 INFO - 'SHELL': '/bin/bash', 03:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:42:45 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:45 INFO - 'USER': 'cltbld', 03:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:45 INFO - 'XPC_FLAGS': '0x0', 03:42:45 INFO - 'XPC_SERVICE_NAME': '0', 03:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-18jIVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-pWqZQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Nq0FXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-vkWj6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Uk7Wz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-4P7QE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-6rCYbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-3sZ4ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-50SlLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-nSeXBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-bx5iPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-vuedSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-bym6wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-6d3504-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-4dujvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Ie1axh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9x1w8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:42:47 INFO - Running setup.py install for manifestparser 03:42:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:42:47 INFO - Running setup.py install for mozcrash 03:42:47 INFO - Running setup.py install for mozdebug 03:42:47 INFO - Running setup.py install for mozdevice 03:42:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:42:47 INFO - Running setup.py install for mozfile 03:42:47 INFO - Running setup.py install for mozhttpd 03:42:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:42:47 INFO - Running setup.py install for mozinfo 03:42:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:42:48 INFO - Running setup.py install for mozInstall 03:42:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:42:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:42:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:42:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:42:48 INFO - Running setup.py install for mozleak 03:42:48 INFO - Running setup.py install for mozlog 03:42:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:42:48 INFO - Running setup.py install for moznetwork 03:42:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:42:48 INFO - Running setup.py install for mozprocess 03:42:48 INFO - Running setup.py install for mozprofile 03:42:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:42:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:42:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:42:48 INFO - Running setup.py install for mozrunner 03:42:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:42:49 INFO - Running setup.py install for mozscreenshot 03:42:49 INFO - Running setup.py install for moztest 03:42:49 INFO - Running setup.py install for mozversion 03:42:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:42:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:42:49 INFO - Cleaning up... 03:42:49 INFO - Return code: 0 03:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:49 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 0x109e52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d80595b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, '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.uEXSfivN15/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.6d1YOz3NPn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:42:49 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:42:49 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:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:49 INFO - 'HOME': '/Users/cltbld', 03:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:49 INFO - 'LOGNAME': 'cltbld', 03:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:49 INFO - 'MOZ_NO_REMOTE': '1', 03:42:49 INFO - 'NO_EM_RESTART': '1', 03:42:49 INFO - 'PAGER': '/bin/cat', 03:42:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:49 INFO - 'PWD': '/builds/slave/test', 03:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:49 INFO - 'SHELL': '/bin/bash', 03:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:42:49 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:49 INFO - 'USER': 'cltbld', 03:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:49 INFO - 'XPC_FLAGS': '0x0', 03:42:49 INFO - 'XPC_SERVICE_NAME': '0', 03:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:49 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-PfQSTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:49 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-EDIXVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Dmyh9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-dWzsz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-hRSpeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-MgGuOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-sL7Znn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-1pcGA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-INCovQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-rJlSmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-x7yyMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:51 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:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-3B_23k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:51 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:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zZtpVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:51 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:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-3xxNCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:51 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:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-5VYGMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:51 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:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-_0hyG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:51 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:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-vapCnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:42:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:54 INFO - Downloading blessings-1.6.tar.gz 03:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:42:54 INFO - Installing collected packages: blessings 03:42:54 INFO - Running setup.py install for blessings 03:42:54 INFO - Successfully installed blessings 03:42:54 INFO - Cleaning up... 03:42:54 INFO - Return code: 0 03:42:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:54 INFO - Reading from file tmpfile_stdout 03:42:54 INFO - Current package versions: 03:42:54 INFO - blessings == 1.6 03:42:54 INFO - blobuploader == 1.2.4 03:42:54 INFO - docopt == 0.6.1 03:42:54 INFO - functools32 == 3.2.3-2 03:42:54 INFO - jsonschema == 2.5.1 03:42:54 INFO - manifestparser == 1.1 03:42:54 INFO - mozInstall == 1.12 03:42:54 INFO - mozcrash == 1.0 03:42:54 INFO - mozdebug == 0.1 03:42:54 INFO - mozdevice == 0.50 03:42:54 INFO - mozfile == 1.2 03:42:54 INFO - mozhttpd == 0.7 03:42:54 INFO - mozinfo == 0.9 03:42:54 INFO - mozleak == 0.1 03:42:54 INFO - mozlog == 3.4 03:42:54 INFO - moznetwork == 0.27 03:42:54 INFO - mozprocess == 0.25 03:42:54 INFO - mozprofile == 0.28 03:42:54 INFO - mozrunner == 6.13 03:42:54 INFO - mozscreenshot == 0.1 03:42:54 INFO - mozsystemmonitor == 0.3 03:42:54 INFO - moztest == 0.8 03:42:54 INFO - mozversion == 1.4 03:42:54 INFO - psutil == 3.1.1 03:42:54 INFO - requests == 1.2.3 03:42:54 INFO - wsgiref == 0.1.2 03:42:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42: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:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d80595b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, '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.uEXSfivN15/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.6d1YOz3NPn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:54 INFO - 'HOME': '/Users/cltbld', 03:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:54 INFO - 'LOGNAME': 'cltbld', 03:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:54 INFO - 'MOZ_NO_REMOTE': '1', 03:42:54 INFO - 'NO_EM_RESTART': '1', 03:42:54 INFO - 'PAGER': '/bin/cat', 03:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:54 INFO - 'PWD': '/builds/slave/test', 03:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:54 INFO - 'SHELL': '/bin/bash', 03:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:42:54 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:54 INFO - 'USER': 'cltbld', 03:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:54 INFO - 'XPC_FLAGS': '0x0', 03:42:54 INFO - 'XPC_SERVICE_NAME': '0', 03:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:42:55 INFO - Cleaning up... 03:42:55 INFO - Return code: 0 03:42:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d80595b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, '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.uEXSfivN15/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.6d1YOz3NPn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:55 INFO - 'HOME': '/Users/cltbld', 03:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:55 INFO - 'LOGNAME': 'cltbld', 03:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:55 INFO - 'MOZ_NO_REMOTE': '1', 03:42:55 INFO - 'NO_EM_RESTART': '1', 03:42:55 INFO - 'PAGER': '/bin/cat', 03:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:55 INFO - 'PWD': '/builds/slave/test', 03:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:55 INFO - 'SHELL': '/bin/bash', 03:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:42:55 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:55 INFO - 'USER': 'cltbld', 03:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:55 INFO - 'XPC_FLAGS': '0x0', 03:42:55 INFO - 'XPC_SERVICE_NAME': '0', 03:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:42:55 INFO - Cleaning up... 03:42:55 INFO - Return code: 0 03:42:55 INFO - Running post-action listener: _resource_record_post_action 03:42:55 INFO - Running post-action listener: _start_resource_monitoring 03:42:55 INFO - Starting resource monitoring. 03:42:55 INFO - [mozharness: 2017-04-22 10:42:55.554791Z] Finished create-virtualenv step (success) 03:42:55 INFO - [mozharness: 2017-04-22 10:42:55.555764Z] Running install step. 03:42:55 INFO - Running pre-action listener: _resource_record_pre_action 03:42:55 INFO - Running main action method: install 03:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:55 INFO - Reading from file tmpfile_stdout 03:42:55 INFO - Detecting whether we're running mozinstall >=1.0... 03:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:42:55 INFO - Reading from file tmpfile_stdout 03:42:55 INFO - Output received: 03:42:55 INFO - Usage: mozinstall [options] installer 03:42:55 INFO - Options: 03:42:55 INFO - -h, --help show this help message and exit 03:42:55 INFO - -d DEST, --destination=DEST 03:42:55 INFO - Directory to install application into. [default: 03:42:55 INFO - "/builds/slave/test"] 03:42:55 INFO - --app=APP Application being installed. [default: firefox] 03:42:55 INFO - mkdir: /builds/slave/test/build/application 03:42:55 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'] 03:42:55 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 03:43:15 INFO - Reading from file tmpfile_stdout 03:43:15 INFO - Output received: 03:43:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:43:15 INFO - Running post-action listener: _resource_record_post_action 03:43:15 INFO - [mozharness: 2017-04-22 10:43:15.424719Z] Finished install step (success) 03:43:15 INFO - [mozharness: 2017-04-22 10:43:15.424864Z] Running run-tests step. 03:43:15 INFO - Running pre-action listener: _resource_record_pre_action 03:43:15 INFO - Running main action method: run_tests 03:43:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:43:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:43:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:43:15 INFO - 2017-04-22 03:43:15.439 screenresolution[1660:9145] starting screenresolution argv=screenresolution get 03:43:15 INFO - 2017-04-22 03:43:15.442 screenresolution[1660:9145] Display 0: 1600x1200x32@60 03:43:15 INFO - 2017-04-22 03:43:15.448 screenresolution[1661:9147] starting screenresolution argv=screenresolution list 03:43:15 INFO - Available Modes on Display 0 03:43:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:43:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:43:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:43:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:43:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:43:15 INFO - Intel Iris: 03:43:15 INFO - Chipset Model: Intel Iris 03:43:15 INFO - Type: GPU 03:43:15 INFO - Bus: Built-In 03:43:15 INFO - VRAM (Dynamic, Max): 1536 MB 03:43:15 INFO - Vendor: Intel (0x8086) 03:43:15 INFO - Device ID: 0x0a2e 03:43:15 INFO - Revision ID: 0x0009 03:43:15 INFO - Displays: 03:43:15 INFO - Display: 03:43:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:43:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:43:15 INFO - Display Serial Number: 1600x1200 60 03:43:15 INFO - Main Display: Yes 03:43:15 INFO - Mirror: Off 03:43:15 INFO - Online: Yes 03:43:15 INFO - Rotation: Supported 03:43:15 INFO - Return code: 0 03:43:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:43:15 INFO - Python 2.7.3 03:43:15 INFO - Return code: 0 03:43:15 INFO - grabbing minidump binary from tooltool 03:43:15 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:43:15 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 0x109c30d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c25be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:43:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:43:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:43:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:43:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:43:15 INFO - Return code: 0 03:43:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:43:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:43:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:43:15 INFO - ENV: RUST_BACKTRACE is now 1 03:43:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:43:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:43:15 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/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:43:15 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/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:43:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uEXSfivN15/Render', 03:43:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:15 INFO - 'HOME': '/Users/cltbld', 03:43:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:15 INFO - 'LOGNAME': 'cltbld', 03:43:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:43:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:15 INFO - 'MOZ_NO_REMOTE': '1', 03:43:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:43:15 INFO - 'NO_EM_RESTART': '1', 03:43:15 INFO - 'PAGER': '/bin/cat', 03:43:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:15 INFO - 'PWD': '/builds/slave/test', 03:43:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:43:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:15 INFO - 'RUST_BACKTRACE': '1', 03:43:15 INFO - 'SHELL': '/bin/bash', 03:43:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6d1YOz3NPn/Listeners', 03:43:15 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 03:43:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:15 INFO - 'USER': 'cltbld', 03:43:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:15 INFO - 'XPC_FLAGS': '0x0', 03:43:15 INFO - 'XPC_SERVICE_NAME': '0', 03:43:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:15 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/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:43:16 INFO - mozversion application_buildid: 20170422014420 03:43:16 INFO - mozversion application_changeset: 4ad23bc8d5c12134fd61970e56a4b305acfeb16e 03:43:16 INFO - mozversion application_display_name: Nightly 03:43:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:43:16 INFO - mozversion application_name: Firefox 03:43:16 INFO - mozversion application_remotingname: firefox 03:43:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:43:16 INFO - mozversion application_vendor: Mozilla 03:43:16 INFO - mozversion application_version: 55.0a1 03:43:16 INFO - mozversion platform_buildid: 20170422014420 03:43:16 INFO - mozversion platform_changeset: 4ad23bc8d5c12134fd61970e56a4b305acfeb16e 03:43:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:43:16 INFO - mozversion platform_version: 55.0a1 03:43:16 INFO - using testdate: 1492857796 03:43:16 INFO - actual date: 1492857796 03:43:16 INFO - starting webserver on 'localhost:49240' 03:43:16 INFO - SUITE-START | Running 2 tests 03:43:16 INFO - TEST-START | dromaeo_css 03:43:16 INFO - operating with platform_type : mac_ 03:43:16 INFO - Initialising browser for dromaeo_css test... 03:43:16 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpv3gW3e/profile http://localhost:49240/getInfo.html) 03:43:19 INFO - PID 1671 | 2017-04-22 03:43:19.162 plugin-container[1675:9470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4f, name = 'com.apple.tsm.portname' 03:43:19 INFO - PID 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:43:19 INFO - PID 1671 | 2017-04-22 03:43:19.165 plugin-container[1675:9470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9c17, name = 'com.apple.CFPasteboardClient' 03:43:19 INFO - PID 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:43:19 INFO - PID 1671 | 2017-04-22 03:43:19.165 plugin-container[1675:9470] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:43:19 INFO - PID 1671 | __metrics Screen width/height:1600/1200 03:43:19 INFO - PID 1671 | colorDepth:24 03:43:19 INFO - PID 1671 | Browser inner width/height: 1024/689 03:43:19 INFO - PID 1671 | __metrics 03:43:19 ERROR - PID 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 03:43:20 INFO - TEST-INFO | 1671: exit 0 03:43:20 INFO - Browser initialized. 03:43:20 INFO - Running cycle 1/1 for dromaeo_css test... 03:43:20 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpv3gW3e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:22 INFO - PID 1676 | 2017-04-22 03:43:22.535 plugin-container[1677:9595] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 03:43:22 INFO - PID 1676 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:43:22 INFO - PID 1676 | 2017-04-22 03:43:22.539 plugin-container[1677:9595] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9613, name = 'com.apple.CFPasteboardClient' 03:43:22 INFO - PID 1676 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:43:22 INFO - PID 1676 | 2017-04-22 03:43:22.539 plugin-container[1677:9595] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:43:32 INFO - PID 1676 | RSS: Main: 236068864 03:43:32 INFO - PID 1676 | 03:46:35 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 03:46:37 INFO - PID 1676 | RSS: Main: 257523712 03:46:37 INFO - PID 1676 | 03:48:20 INFO - PID 1676 | ************************* 03:48:20 INFO - PID 1676 | A coding exception was thrown and uncaught in a Task. 03:48:20 INFO - PID 1676 | 03:48:20 ERROR - PID 1676 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:48:20 INFO - PID 1676 | Full stack: 03:48:20 INFO - PID 1676 | ************************* 03:48:20 INFO - PID 1676 | ************************* 03:48:20 INFO - PID 1676 | A coding exception was thrown and uncaught in a Task. 03:48:20 INFO - PID 1676 | 03:48:20 ERROR - PID 1676 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:48:20 INFO - PID 1676 | Full stack: 03:48:20 INFO - PID 1676 | ************************* 03:48:20 INFO - PID 1676 | ************************* 03:48:20 INFO - PID 1676 | A coding exception was thrown and uncaught in a Task. 03:48:20 INFO - PID 1676 | 03:48:20 ERROR - PID 1676 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:48:20 INFO - PID 1676 | Full stack: 03:48:20 INFO - PID 1676 | ************************* 03:48:20 INFO - PID 1676 | ************************* 03:48:20 INFO - PID 1676 | A coding exception was thrown and uncaught in a Task. 03:48:20 INFO - PID 1676 | 03:48:20 ERROR - PID 1676 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:48:20 INFO - PID 1676 | Full stack: 03:48:20 INFO - PID 1676 | ************************* 03:49:39 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 03:49:40 INFO - PID 1676 | RSS: Main: 258957312 03:49:40 INFO - PID 1676 | 03:52:41 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 03:52:42 INFO - PID 1676 | RSS: Main: 267730944 03:52:42 INFO - PID 1676 | 03:55:44 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 03:55:44 INFO - PID 1676 | RSS: Main: 260640768 03:55:44 INFO - PID 1676 | 03:58:47 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 03:58:48 INFO - PID 1676 | RSS: Main: 268750848 03:58:48 INFO - PID 1676 | 04:01:50 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 04:01:50 INFO - PID 1676 | RSS: Main: 264458240 04:01:50 INFO - PID 1676 | 04:01:50 INFO - PID 1676 | __start_tp_report 04:01:50 INFO - PID 1676 | _x_x_mozilla_page_load 04:01:50 INFO - PID 1676 | _x_x_mozilla_page_load_details 04:01:50 INFO - PID 1676 | |i|pagename|runs| 04:01:50 INFO - PID 1676 | |0;dojo.html;3043.26961529233;3555.253396786675;3573.8927832165045;3606.459031145328;3625.5105560749307;6138.324784273726;6153.538484613655;6245.406686364794;6287.15123458333;6291.245050593924;6198.566100372976;6228.595141315811;6233.1273621693;6266.342034086424;6296.433321001109;5471.206675032118;5489.451054894518;5498;5534.335879694442;5600.103983362663;5359.008583412081;5490.396056433789;5545.279113715212;5568.610197286192;5607.355154157263;4473.888152796158;5377.11277639189;5471.5896307776675;5486.1222204447095;5515.558755299567;5442.673439593597;5454.890902181974;5456.181572764078;5484.2596249506605;5513.5037846594;5412.107002344608;5424.105022671254;5459;5476;5476.507114359687;5276.2085687146855;5832.212651292064;6113.081058499965;6184.257889053342;6236.688165591748;6700.39696427319;6725.293844146392;6725.730970761164;6743.898841517381;6751.0886030386255;6763.898541521881;6788.7623933162595;6799.082123913257;6800.217974932896;6812.352826481477;6176.629402235881;6246.562740608114;6293.779717709858;6384.808455746289;6396.744130234785;6844.315568443216;6886.931130688629;6894.448444124458;6898.862022759517;6952.687129079203;6308.179936608211;6368.5860419072615;6400.935990640127;6572.4084832365315;6599.967000165065;6580.276169621337;6679.365460281363;6769.289224631441;6772.187337519431;6788.9660551696925;6365.809025729235;6434.903476447857;6655;6682.064510968468;6710.765123220664;6562.146920900253;6574.737010519526;6608.735650574019;6639.966800166065;6676.632785196861;5255.08036093682;5258.974499972545;5270.947290527046;5302.469753024744;5328.413874473805;4615.399998000238;4726.527347265246;4738.739369334719;4744.146053710297;4789.592884604778;6167.784127555514;6318.968405157945;6341.968290158612;6399.648019358887;6400.135981642418;6726.293739157318;6739.460843132538;6743.3593808589085;6745.0556922030955;6754.257031726506;6316.494680425555;6322.146510221061;6339.302676705559;6384.52116091295;6404.295527491972;5720.313562372542;5815.302163740378;5897.380775018647;5922.763089476459;5962.135490353874;6924.134483189601;6933.064036355128;6939.791806245821;6953.895691564731;6963.686634101579;6676.732930682912;6730.528862979544;6764.526483146133;6787.728490860311;6815.148106486689;6614.239362473185;6781.812548102384;6796.150481189851;6844.486663500158;6994.02083708271;6631.3700198481065;6668.699908504032;6672.8999065013095;6673.232578253369;6690.732370705117;6398.104265402754;6727.461803055841;6762.222344430454;6783.559068660521;6802.761903333359;6345.524085693499;6468.902966455601;6532.804015879531;6549.672516374258;6560.40956313934;5231.8168864089575;5486.972565137149;5893.675847828239;6547.9672601638595;6587.505937054644;5355.973220133875;6391.360863913572;6448.838779030561;6450.677466126769;6474.449671777763;6331.5884467511305;6332.873342533216;6468.3855033771715;6526.4452521536205;6563.704633291418;6371.076193951758;6396.26442959047;6411.3909178627955;6418.454431373386;6424.93575064262 04:01:50 INFO - PID 1676 | |1;ext.html;738.7155944961188;819.4919150126922;836.9497830130192;1251.4556168066892;1270.7903195972665;38018;38799.80600097003;38960;38972.415413768744;38972.41541376878;38863.41704874429;38881.222375552476;39202.607973920254;39209.60790392102;39319.60680393195;7900.92099079009;8062.838743225132;8457.915420845806;8680.392372533925;8719.738407847775;8594.441361311494;8694.869576956351;8716.128387161265;8736.781580460476;8737.868931966026;8661.69684061058;8708;8735.039145693969;8741.650333986632;8747.169018943223;8673.002604700445;8714.607842647065;8716.171963663443;8734.432261902988;8737.388382813206;8408.579571021424;8433.40966132371;8454.408191426603;8456.49261044333;8469.36479764014;31351.686483135334;37426.8128659355;37829.62170378288;37875.81062094672;38016.80991595052;3554.8222588870713;3706.721995850322;3752.5684546277253;3753.6997040236715;3755.2301778135416;31300.217494562592;31359.216019599466;31389.37221255585;31422;31643.84178079095;3180.745540356789;3214.2285851395495;3219.951700724491;3229.11199420159;3232.903012909593;239378;242357;271982;287730;288720.5563972167;48221.27668084981;48358.03283934302;48427.27359089616;48432.515674843504;48438.94513185852;48726.51273487291;48880.75559622179;48947.02105957861;49014.26478602824;49147.262791058165;13868.93065534666;13901.67934046264;14011.579652610439;14046.648833779032;14063;11487.655370338904;11565.132615053904;11584.015358694436;11584.884151158549;11599;13378.732425351438;13414.262215578237;13415.530456433979;13419.463221471031;13457.932710336385;5048.72232027242;5908.734106965197;5943.316518600416;5968.731407086691;5980.43185897339;1023.2070145637042;1028.3829702178782;1052.2791887557048;1060.411471633251;1086.22877756792;22630.189584833173;23602.64596031061;24357.025718971043;24763.5047299053;25116.623250651253;1127.3855748617023;1134.5688638317552;1143.1712008793559;1146.3236690352733;1165.539611853313;12558.246505209716;12558.434870430852;12606.243625382507;12613.873861261454;12633.368331583384;313475;314058;314093;314747;315238;54824.62938426571;54828;55191;55243.89512209733;55300;1314.612189404147;1506.8267149277754;1559.4619856149611;1562.546861410201;1567.8432156784231;23935.880320598983;23968.40078998039;24089.638655420535;24166;24278;39249;39383.60616393799;39424.802875985435;39443.80278098591;39504.61733839302;161030;195020.04979950018;195927;196628;197471;34206.2013805193;34232.973010809714;34292.48561271533;34509;34532.136696582784;42148.57851421569;43960;44612.33081503715;44705;44785.55214447944;24586.385340366633;25327.240182794547;30023.648935798377;30649;30661.54007689931;30203.546946796254;30679.386412272077;30879.382412352075;30926.176096630606;31004;37210.25579488449;37223.44164837584;37266.881993540235;37275.25449491049;37356;26753.866230668722;30130.096097117123;30979;31394.372112557165;31418.52872206873;20577.279795207094;24241.393965150306;24524.386890327885;24607;24737.628935565623 04:01:50 INFO - PID 1676 | |2;jquery.html;397.39000634026763;414.1282600126735;435.30351437699704;445.66352403935036;463.35824882537696;19113.713294300578;19543.511412214702;21265.57468850622;21461.463463413424;21482.785172148273;21144.97504209466;21232.57534849302;21487.785122148773;21576.676349854766;21615;5896.970515147418;6118.755249790003;6139.815805525842;6141.723622437001;6153.876922461548;5761.683107429089;5807.448292412214;5875.471207591316;5883.529317654598;5945.88108237835;5802.361740208574;5809.244798176232;5819.33077696064;5821.243238379026;5838.41615838417;5630.859228519279;5988.670623115749;5998.070299103624;6057.636541807506;6073;4465.888352791174;5374;5380.461953804627;5385.380681221671;5397.595180361489;25818.354541136436;26047.218583442525;26288;26306.079287225046;26521.602175967375;2179.56408718257;2273.818094552448;2280.270313499681;2323.546908352872;2330.091264406866;17877.106144692712;17922.641547168983;18023.91856488615;18107.909460452614;18241;1863.7297591849242;2179.5967745966886;2179.7384313882276;2188.7701791311842;2210.6573481110454;165400.9999999988;165535;166804;168187;168562;12414.937925310316;12416.689582760504;12536.498540058477;12581.874181258254;12696.619101426972;16241.51275461738;16252.75620865688;16282.75575866363;16294.592635184215;16302.83697163037;8610.956945215234;8918.241949434241;8940.552972351486;9027.187553120251;9048.41185322952;6907.551009184387;7355.264473552709;8243.917560824315;8363.414560980795;8394.034686011064;7759.107702614158;7870.763877083697;7903.762887113396;7906.723264685824;8017.158198389086;2016.294296996069;2145.1097794415455;2177.6733489976314;2194.9341519754435;2405.9037638494615;969.8496733006396;987.5457289646699;994.6021591363368;1010.1262408017012;1040.953157107932;19175.424737257905;20177.899110504353;20681.586368272852;21055.8947205263;21286.78713212879;1017.730301470111;1018.9235807314333;1050.1861057680205;1052.663147792699;1056.5404049238452;10321.432321222255;10680.305780124267;10716.51775670081;10726.249162558546;10731;525439;574107;575334;585331;587562;124045;134761;138211;138292;142040;1197.9221350612183;1240.2434514945876;1266.0820904843915;1267.5056727876135;1270.1743866486856;20615.38153855387;20908.22280106208;21906.12375504962;21916.671249930943;22005;56929.71535142298;57181;59594;59778.10332844924;60937.390626094944;62562.68718656377;81801;82390.58804705938;82413.58793205995;83138.5843070805;8661.653533858827;8818.691345802867;8820.91179088201;8859.335549833659;8862.202401783612;13571.728565428833;13741.725165496833;13779.242141682304;13838.962077844;13933.233672147724;11511.251768635348;11691.240069395462;11895.226810257305;11921;12079.637610871689;10342.965703429596;10831.187660925305;10834.404107774148;10903.945480272549;11141.72145696364;10981.725456863642;11385.943070284595;11771.234869733782;12058.974987126192;12215;8532.914670853212;8682.739517814476;8738.25724813398;8769.693060742844;8770.210681038738;11176.441177941233;11608.825867611824;11851.992580630744;11930.522779088738;12022.63932082039 04:01:50 INFO - PID 1676 | |3;mootools.html;1336.4520546575907;1342.8921140059454;1445.0607105381503;1510.1467670766017;1514.1520748380908;11344.205905586612;11751.588694395676;11837.940810295959;11868.10989175812;12141.210821296632;11594.30434173948;11896.583619573317;11901.345426001566;11942.283462992205;11962.461689223985;2516.609925461552;2573.74262573743;2587;2589.8057645676554;2590.5596048671678;2354.5290941811704;2493.5012997400504;2529.443522425073;2543.55487789637;2544.7709706126443;2316.420894776306;2522.810789190809;2555.220657699401;2555.3356127406823;2558.181381957765;2485.378655336166;2507.360623041131;2528.4311030018284;2536.987315063422;2541.440883005736;2438.1588352018525;2514.911978080777;2533.40464990727;2539.0986199898953;2558.2581051495044;11754.412279386082;11839.644810655695;11854.703632409259;11896.286222826659;11913.583024594098;6564;6764.729410823561;6792.76225332111;6803.557768745016;6810.250872404032;4024.1348110156164;4406.581374769424;4418;4497.955020449786;4500.729956202638;1291.0897817038965;1293.2757655712737;1311.1346511302495;1340.7318536292682;1340.8592097829685;16421.261043253082;16694.165291735364;16786.160691965353;16905.23926423314;16905.323787048503;5654.434556544313;5728.054870946247;5772.520941088056;5885.882282354329;5888.322842873039;10359.741006474747;12302;12410.945069668998;12414;12436.00511959041;6579.440747536417;6611.900821487586;6639.435647969976;6662.533622646465;6675.198976122896;6059;6167.044108163242;6178.567500274938;6225.968870155621;6312.5581209314905;4363.323684828857;4469.307257375112;4485.842995495142;4486.730796152241;4560.771961401917;1324.1326930860303;1337.2912356451097;1337.699017721005;1342.8791408773257;1345.421468768439;795.3478147918651;801.1867954026668;821.5892053973014;831.4678605692362;854.0818619983419;6192.916239658132;6269.592476489105;6455.806325810233;6475.255345635218;6501.772437964649;592.8280798568453;604.7067172421372;604.9637021778707;610.3743662745633;615.0927382111439;3862.362710152793;4312.525622181557;4391.14372697321;4458.487273963471;4473.664475164311;14765.704685906436;15077.321520531603;15090.471833485775;15215.391384344503;15247.466338678092;14576.635584110481;15066.246687665573;15083.698326033418;15092.547223583091;15121.319540620698;5783.681897495678;7628.199039100926;8725.389222754473;8820.33847461443;8821.338399620054;6628.7017084230365;7033.683484243324;7048.964755176191;7191.280871912976;7212.206657267801;10050.497475126069;11424.371659558805;13479.326033698471;13779.035467517178;13814.723705525632;13757.862421375658;13801.930990344985;13848.446062157402;14006.299685015505;14092.506762263272;8174;8237.258646721824;8647.913520864711;8764.78088047804;8821.2060914518;10736.89263107359;10742.3017503862;10753.569857205624;10799.406032667965;10846.783064338826;9174.403663761834;9200.125988031126;9238.168564829197;9238.260939124988;9278.536073196448;8964.103589640983;8986.281097512314;9121.680741174026;9164;9292.884853817584;8255.752327430188;8332.625031873458;8380.497170169809;8422.073571906963;8433.19884610961;6140;6193.504519638508;6207.34822843613;6207.720652570735;6213.161223234805;6138.447539721446;6152.384761523812;6305.243370795534;6305.4009869062365;6336.936630633819 04:01:50 INFO - PID 1676 | |4;prototype.html;322.7643820011391;387.51195409627024;408.15919206434745;413.76622208452227;417.46981333706213;4780.593649539785;5113.48865113489;5399.4330595287465;6030.849228769283;6151.692415379235;5969.88060238795;6000.459958603725;6050.697465126737;6057.575969682124;6090.634561926277;4350.173467041268;4463.237021376563;4499.212637788391;4516.503184649686;4518.209313370164;4103.2409004334295;4516.616087632555;4523.389342438762;4544.909101817978;4576.816927322903;4474.485434175079;4489;4489.608221451361;4494.595486406222;4499.70751901127;4364.629006534448;4381.78091095444;4395.384646149541;4464.6651501137385;4482.394876691637;3212.550242965963;3365.6802603752603;3850.133719912997;3881.204353107606;3889.230400167945;5868.882622347529;6011.707482891155;6024.102407741548;6056.062060140756;6079.6960151992225;5032;5224.947750522484;5268.5521730652945;5327;5349.491798279158;6030.819075427744;6183.907241391383;6433.8391540211405;6489.424955406427;6558.344165583451;4339.47926248849;4343.283358245885;4358.4987726411555;4359.215341238576;4363.345498175299;5782.392848750863;6647.900281495781;6889.827754306132;6913.1358580177475;6927.757528486479;3880.3403421418425;4028.778417187083;4406.876246557107;4410.25025745624;4427.8228870844805;4492.9101417972115;4493.348464472633;4503.369528266046;4551.840685575989;4558.635309175258;5115.590752739772;5263.184206448007;5336.719187394997;5367.35591728995;5371.435999220025;5830.300363956352;6100.176476175659;6527.738890444329;6547.919593267057;6554.279029306773;1352.9052966292265;1515.9621009474631;1530.6249968757725;1554.2694933381292;1561.2818103672437;995.9502024898726;1012.6202673997251;1013.1034034879185;1019.2050200843354;1024.8052869954686;6070.726817293233;6276.9372306276355;6282.811515654537;6298.905516417258;6306.306306306303;6762.661866906635;6768.830779230559;6779.508508128204;6788.558743681645;6831.155587991215;5385.661821497806;5390.407055223922;6160.322364539897;6172.537059720539;6238.282597501346;3488.66857648523;3530.91172720684;3541.29174165168;3543.7696549724187;3547;6322.525810564226;6906.412954898789;6978.685959131852;7001;7098.60957647324;5818;6389.600787334694;6934.271901450275;6989.475789315821;7006.369426751617;6604.636744979072;6755.6567638965835;6936.606870629625;6962.96518517394;7002.719891204295;5484.945150548603;6409.423151916163;6431.356864313531;6739.797806065826;6787;5726.828195154152;6603.702833372606;6624.436922861611;6702.899456508254;6747.493937954575;5592.832215033555;7056.611886346095;7081.539699919695;7093.82265443368;7101.431885449048;3631.8002509862213;4421.204183247047;4483.686141970031;4493.056458143827;4501.09978004407;5317.494837990384;6720.8319792005595;6804.727810887707;6872.553284036521;6921.442675397995;5668.603197776116;6425.325340839145;6540.803775886731;6545.280019197789;6618.7352505899225;5375.554122874161;6520.902186467301;6527.086207930798;6537.7058032389605;6549.6070235786;6192.8233635609095;6445.452136568257;6462.935370646233;6465.579737317059;6472.061551074974;5636.84444688846;5770.6249093808765;6413.679316034273;6625.17185351831;6646.90029649546;6424.421802037839;6430.196225471816;6455.774047908489;6487.708053137526;6535.771248006297 04:01:50 INFO - PID 1676 | |5;yui.html;818.2513000604447;829.5313148071339;851.6380538271234;852.1223140165624;863.8445079885622;16437;16800.32798688054;16909.83090169098;18585.814141858576;19158;14531.418743250257;17573.3849315274;17752.644947101082;17923.64152716945;18095;985.5023213277285;1008.6167256442542;1008.7326858382535;1009.2531526670284;1013.3210748798323;945.5603144537788;978.9314747967645;1003.7089244119196;1004.6031817432109;1005.9094681478665;1047.1256500821785;1057.323313079626;1057.9629712960048;1061.2412125330388;1066.7226521104492;1052.300220353464;1053.4837929414532;1054.6572363981659;1058.8358804385332;1059.8304271316551;763.5571368606251;769.7498313048226;788.1763557082862;789.9493673414345;791.8535071011823;16454.83545164557;16664.416745413975;16821.57946051346;16880.98714077147;16965.57586060346;16515.83484165155;16748.665026699397;16938.068406237653;17163.828361716347;17190.656186876316;13768.173909565357;13864.168149910936;13942.512012079529;14009.369578368896;14187.929060354736;3538.5046093546925;3550.804705741183;3568.0544655666267;3573.338932297507;3574.3566158091535;98827.50586247095;111253.44373278163;115220.42389788081;129529;130358;11251;12862.035347348987;12988.480460781651;13109.147905386119;13130.146540474838;24095.397615059414;24421.38946526351;24778;25388.492230155294;25476.617850732255;7665.846683066307;7702.460827742004;7773.844523109507;7776.183500732454;7791.922080779233;3700.9259814803554;3805.37211360128;3943.428202910562;3970.9873982134372;4039.293123703399;4330.870073897788;4415.977920110443;4422.447194100738;4427.335899615084;4429.092036132585;792.5838934559403;905.2622112977901;907.1699395053585;915.3135148638521;915.4598786715869;631.8641492079133;640.5228105061666;664.8038828545591;674.4435840431663;679.1815861886415;10382.3251488653;11348.943255283672;11368.317900925971;11434.599789007345;11435.656930292105;638.450932198309;647.4755448087064;652.6019128331714;662.2549631664377;666.6067020457953;5631.4087020863035;6122.326544080148;6148.6925653717135;6226.439620434183;6230.719617617218;86019;91965;96756.51621741986;96806.5159674197;110285;78325;85911.71132433019;86264.56867715747;86371;88180.24575330666;76546;76874.61562692151;77014.614926925;78583.60708196537;80025.39949200983;11934.4032798358;12756.298403587893;12780.87219127834;12786;12790.040746944203;39993;40151.59848401479;41591.37612935748;41705.58294417017;42323.78838105913;52286.73856630845;52340.73829630828;52838.735806322264;53211;53341.733291333294;14311.642208944444;14963.925180374028;15147.772783408478;16823.747643785107;16979.575510612332;18178.545536361697;18629.975351355806;18696.626067478846;18788.3424080162;18890.05549722536;16772.748408773634;17244;17255.843019622545;17415.56461088483;17447.127643618023;13161.934190328988;14144.575662730134;16961.49115526536;17196.656066878844;17226.569335766708;16718.58203544921;16759.994400336018;16985.575360616083;17038.97766134036;17084.743728844325;9671.661491847752;10405.47972601382;10721.035106840422;11622.020250338808;11829.645110646694;9011.639534418811;10840;11165.665030049111;11443.25618834773;11481.885181148082 04:01:50 INFO - PID 1676 | __end_tp_report 04:01:50 INFO - PID 1676 | __start_cc_report 04:01:50 INFO - PID 1676 | _x_x_mozilla_cycle_collect,417 04:01:50 INFO - PID 1676 | __end_cc_report 04:01:50 INFO - PID 1676 | __startTimestamp1492858910365__endTimestamp 04:01:50 INFO - PID 1676 | 04:01:50 INFO - PID 1676 | ------- Summary: start ------- 04:01:50 INFO - PID 1676 | Number of tests: 6 04:01:50 INFO - PID 1676 | 04:01:50 INFO - PID 1676 | [#0] dojo.html Cycles:165 Average:6146.45 Median:6391.36 stddev:749.31 (11.7%) stddev-sans-first:710.97 04:01:50 INFO - PID 1676 | Values: 3043.3 3555.3 3573.9 3606.5 3625.5 6138.3 6153.5 6245.4 6287.2 6291.2 6198.6 6228.6 6233.1 6266.3 6296.4 5471.2 5489.5 5498.0 5534.3 5600.1 5359.0 5490.4 5545.3 5568.6 5607.4 4473.9 5377.1 5471.6 5486.1 5515.6 5442.7 5454.9 5456.2 5484.3 5513.5 5412.1 5424.1 5459.0 5476.0 5476.5 5276.2 5832.2 6113.1 6184.3 6236.7 6700.4 6725.3 6725.7 6743.9 6751.1 6763.9 6788.8 6799.1 6800.2 6812.4 6176.6 6246.6 6293.8 6384.8 6396.7 6844.3 6886.9 6894.4 6898.9 6952.7 6308.2 6368.6 6400.9 6572.4 6600.0 6580.3 6679.4 6769.3 6772.2 6789.0 6365.8 6434.9 6655.0 6682.1 6710.8 6562.1 6574.7 6608.7 6640.0 6676.6 5255.1 5259.0 5270.9 5302.5 5328.4 4615.4 4726.5 4738.7 4744.1 4789.6 6167.8 6319.0 6342.0 6399.6 6400.1 6726.3 6739.5 6743.4 6745.1 6754.3 6316.5 6322.1 6339.3 6384.5 6404.3 5720.3 5815.3 5897.4 5922.8 5962.1 6924.1 6933.1 6939.8 6953.9 6963.7 6676.7 6730.5 6764.5 6787.7 6815.1 6614.2 6781.8 6796.2 6844.5 6994.0 6631.4 6668.7 6672.9 6673.2 6690.7 6398.1 6727.5 6762.2 6783.6 6802.8 6345.5 6468.9 6532.8 6549.7 6560.4 5231.8 5487.0 5893.7 6548.0 6587.5 5356.0 6391.4 6448.8 6450.7 6474.4 6331.6 6332.9 6468.4 6526.4 6563.7 6371.1 6396.3 6411.4 6418.5 6424.9 04:01:50 INFO - PID 1676 | 04:01:50 INFO - PID 1676 | [#1] ext.html Cycles:180 Average:41547.18 Median:3224.53 stddev:68619.09 (2128.0%) stddev-sans-first:68743.17 04:01:50 INFO - PID 1676 | Values: 738.7 819.5 836.9 1251.5 1270.8 38018.0 38799.8 38960.0 38972.4 38972.4 38863.4 38881.2 39202.6 39209.6 39319.6 7900.9 8062.8 8457.9 8680.4 8719.7 8594.4 8694.9 8716.1 8736.8 8737.9 8661.7 8708.0 8735.0 8741.7 8747.2 8673.0 8714.6 8716.2 8734.4 8737.4 8408.6 8433.4 8454.4 8456.5 8469.4 31351.7 37426.8 37829.6 37875.8 38016.8 3554.8 3706.7 3752.6 3753.7 3755.2 31300.2 31359.2 31389.4 31422.0 31643.8 3180.7 3214.2 3220.0 3229.1 3232.9 239378.0 242357.0 271982.0 287730.0 288720.6 48221.3 48358.0 48427.3 48432.5 48438.9 48726.5 48880.8 48947.0 49014.3 49147.3 13868.9 13901.7 14011.6 14046.6 14063.0 11487.7 11565.1 11584.0 11584.9 11599.0 13378.7 13414.3 13415.5 13419.5 13457.9 5048.7 5908.7 5943.3 5968.7 5980.4 1023.2 1028.4 1052.3 1060.4 1086.2 22630.2 23602.6 24357.0 24763.5 25116.6 1127.4 1134.6 1143.2 1146.3 1165.5 12558.2 12558.4 12606.2 12613.9 12633.4 313475.0 314058.0 314093.0 314747.0 315238.0 54824.6 54828.0 55191.0 55243.9 55300.0 1314.6 1506.8 1559.5 1562.5 1567.8 23935.9 23968.4 24089.6 24166.0 24278.0 39249.0 39383.6 39424.8 39443.8 39504.6 161030.0 195020.0 195927.0 196628.0 197471.0 34206.2 34233.0 34292.5 34509.0 34532.1 42148.6 43960.0 44612.3 44705.0 44785.6 24586.4 25327.2 30023.6 30649.0 30661.5 30203.5 30679.4 30879.4 30926.2 31004.0 37210.3 37223.4 37266.9 37275.3 37356.0 26753.9 30130.1 30979.0 31394.4 31418.5 20577.3 24241.4 24524.4 24607.0 24737.6 04:01:50 INFO - PID 1676 | 04:01:50 INFO - PID 1676 | [#2] jquery.html Cycles:180 Average:36612.55 Median:2184.25 stddev:97045.73 (4443.0%) stddev-sans-first:97279.88 04:01:50 INFO - PID 1676 | Values: 397.4 414.1 435.3 445.7 463.4 19113.7 19543.5 21265.6 21461.5 21482.8 21145.0 21232.6 21487.8 21576.7 21615.0 5897.0 6118.8 6139.8 6141.7 6153.9 5761.7 5807.4 5875.5 5883.5 5945.9 5802.4 5809.2 5819.3 5821.2 5838.4 5630.9 5988.7 5998.1 6057.6 6073.0 4465.9 5374.0 5380.5 5385.4 5397.6 25818.4 26047.2 26288.0 26306.1 26521.6 2179.6 2273.8 2280.3 2323.5 2330.1 17877.1 17922.6 18023.9 18107.9 18241.0 1863.7 2179.6 2179.7 2188.8 2210.7 165401.0 165535.0 166804.0 168187.0 168562.0 12414.9 12416.7 12536.5 12581.9 12696.6 16241.5 16252.8 16282.8 16294.6 16302.8 8611.0 8918.2 8940.6 9027.2 9048.4 6907.6 7355.3 8243.9 8363.4 8394.0 7759.1 7870.8 7903.8 7906.7 8017.2 2016.3 2145.1 2177.7 2194.9 2405.9 969.8 987.5 994.6 1010.1 1041.0 19175.4 20177.9 20681.6 21055.9 21286.8 1017.7 1018.9 1050.2 1052.7 1056.5 10321.4 10680.3 10716.5 10726.2 10731.0 525439.0 574107.0 575334.0 585331.0 587562.0 124045.0 134761.0 138211.0 138292.0 142040.0 1197.9 1240.2 1266.1 1267.5 1270.2 20615.4 20908.2 21906.1 21916.7 22005.0 56929.7 57181.0 59594.0 59778.1 60937.4 62562.7 81801.0 82390.6 82413.6 83138.6 8661.7 8818.7 8820.9 8859.3 8862.2 13571.7 13741.7 13779.2 13839.0 13933.2 11511.3 11691.2 11895.2 11921.0 12079.6 10343.0 10831.2 10834.4 10903.9 11141.7 10981.7 11385.9 11771.2 12059.0 12215.0 8532.9 8682.7 8738.3 8769.7 8770.2 11176.4 11608.8 11852.0 11930.5 12022.6 04:01:50 INFO - PID 1676 | 04:01:50 INFO - PID 1676 | [#3] mootools.html Cycles:180 Average:7142.05 Median:3943.25 stddev:4512.96 (114.4%) stddev-sans-first:4504.53 04:01:50 INFO - PID 1676 | Values: 1336.5 1342.9 1445.1 1510.1 1514.2 11344.2 11751.6 11837.9 11868.1 12141.2 11594.3 11896.6 11901.3 11942.3 11962.5 2516.6 2573.7 2587.0 2589.8 2590.6 2354.5 2493.5 2529.4 2543.6 2544.8 2316.4 2522.8 2555.2 2555.3 2558.2 2485.4 2507.4 2528.4 2537.0 2541.4 2438.2 2514.9 2533.4 2539.1 2558.3 11754.4 11839.6 11854.7 11896.3 11913.6 6564.0 6764.7 6792.8 6803.6 6810.3 4024.1 4406.6 4418.0 4498.0 4500.7 1291.1 1293.3 1311.1 1340.7 1340.9 16421.3 16694.2 16786.2 16905.2 16905.3 5654.4 5728.1 5772.5 5885.9 5888.3 10359.7 12302.0 12410.9 12414.0 12436.0 6579.4 6611.9 6639.4 6662.5 6675.2 6059.0 6167.0 6178.6 6226.0 6312.6 4363.3 4469.3 4485.8 4486.7 4560.8 1324.1 1337.3 1337.7 1342.9 1345.4 795.3 801.2 821.6 831.5 854.1 6192.9 6269.6 6455.8 6475.3 6501.8 592.8 604.7 605.0 610.4 615.1 3862.4 4312.5 4391.1 4458.5 4473.7 14765.7 15077.3 15090.5 15215.4 15247.5 14576.6 15066.2 15083.7 15092.5 15121.3 5783.7 7628.2 8725.4 8820.3 8821.3 6628.7 7033.7 7049.0 7191.3 7212.2 10050.5 11424.4 13479.3 13779.0 13814.7 13757.9 13801.9 13848.4 14006.3 14092.5 8174.0 8237.3 8647.9 8764.8 8821.2 10736.9 10742.3 10753.6 10799.4 10846.8 9174.4 9200.1 9238.2 9238.3 9278.5 8964.1 8986.3 9121.7 9164.0 9292.9 8255.8 8332.6 8380.5 8422.1 8433.2 6140.0 6193.5 6207.3 6207.7 6213.2 6138.4 6152.4 6305.2 6305.4 6336.9 04:01:50 INFO - PID 1676 | 04:01:50 INFO - PID 1676 | [#4] prototype.html Cycles:180 Average:5273.09 Median:5919.38 stddev:1663.67 (28.1%) stddev-sans-first:1626.32 04:01:50 INFO - PID 1676 | Values: 322.8 387.5 408.2 413.8 417.5 4780.6 5113.5 5399.4 6030.8 6151.7 5969.9 6000.5 6050.7 6057.6 6090.6 4350.2 4463.2 4499.2 4516.5 4518.2 4103.2 4516.6 4523.4 4544.9 4576.8 4474.5 4489.0 4489.6 4494.6 4499.7 4364.6 4381.8 4395.4 4464.7 4482.4 3212.6 3365.7 3850.1 3881.2 3889.2 5868.9 6011.7 6024.1 6056.1 6079.7 5032.0 5224.9 5268.6 5327.0 5349.5 6030.8 6183.9 6433.8 6489.4 6558.3 4339.5 4343.3 4358.5 4359.2 4363.3 5782.4 6647.9 6889.8 6913.1 6927.8 3880.3 4028.8 4406.9 4410.3 4427.8 4492.9 4493.3 4503.4 4551.8 4558.6 5115.6 5263.2 5336.7 5367.4 5371.4 5830.3 6100.2 6527.7 6547.9 6554.3 1352.9 1516.0 1530.6 1554.3 1561.3 996.0 1012.6 1013.1 1019.2 1024.8 6070.7 6276.9 6282.8 6298.9 6306.3 6762.7 6768.8 6779.5 6788.6 6831.2 5385.7 5390.4 6160.3 6172.5 6238.3 3488.7 3530.9 3541.3 3543.8 3547.0 6322.5 6906.4 6978.7 7001.0 7098.6 5818.0 6389.6 6934.3 6989.5 7006.4 6604.6 6755.7 6936.6 6963.0 7002.7 5484.9 6409.4 6431.4 6739.8 6787.0 5726.8 6603.7 6624.4 6702.9 6747.5 5592.8 7056.6 7081.5 7093.8 7101.4 3631.8 4421.2 4483.7 4493.1 4501.1 5317.5 6720.8 6804.7 6872.6 6921.4 5668.6 6425.3 6540.8 6545.3 6618.7 5375.6 6520.9 6527.1 6537.7 6549.6 6192.8 6445.5 6462.9 6465.6 6472.1 5636.8 5770.6 6413.7 6625.2 6646.9 6424.4 6430.2 6455.8 6487.7 6535.8 04:01:50 INFO - PID 1676 | 04:01:50 INFO - PID 1676 | [#5] yui.html Cycles:180 Average:20924.04 Median:18663.30 stddev:28681.35 (153.7%) stddev-sans-first:28722.08 04:01:50 INFO - PID 1676 | Values: 818.3 829.5 851.6 852.1 863.8 16437.0 16800.3 16909.8 18585.8 19158.0 14531.4 17573.4 17752.6 17923.6 18095.0 985.5 1008.6 1008.7 1009.3 1013.3 945.6 978.9 1003.7 1004.6 1005.9 1047.1 1057.3 1058.0 1061.2 1066.7 1052.3 1053.5 1054.7 1058.8 1059.8 763.6 769.7 788.2 789.9 791.9 16454.8 16664.4 16821.6 16881.0 16965.6 16515.8 16748.7 16938.1 17163.8 17190.7 13768.2 13864.2 13942.5 14009.4 14187.9 3538.5 3550.8 3568.1 3573.3 3574.4 98827.5 111253.4 115220.4 129529.0 130358.0 11251.0 12862.0 12988.5 13109.1 13130.1 24095.4 24421.4 24778.0 25388.5 25476.6 7665.8 7702.5 7773.8 7776.2 7791.9 3700.9 3805.4 3943.4 3971.0 4039.3 4330.9 4416.0 4422.4 4427.3 4429.1 792.6 905.3 907.2 915.3 915.5 631.9 640.5 664.8 674.4 679.2 10382.3 11348.9 11368.3 11434.6 11435.7 638.5 647.5 652.6 662.3 666.6 5631.4 6122.3 6148.7 6226.4 6230.7 86019.0 91965.0 96756.5 96806.5 110285.0 78325.0 85911.7 86264.6 86371.0 88180.2 76546.0 76874.6 77014.6 78583.6 80025.4 11934.4 12756.3 12780.9 12786.0 12790.0 39993.0 40151.6 41591.4 41705.6 42323.8 52286.7 52340.7 52838.7 53211.0 53341.7 14311.6 14963.9 15147.8 16823.7 16979.6 18178.5 18630.0 18696.6 18788.3 18890.1 16772.7 17244.0 17255.8 17415.6 17447.1 13161.9 14144.6 16961.5 17196.7 17226.6 16718.6 16760.0 16985.6 17039.0 17084.7 9671.7 10405.5 10721.0 11622.0 11829.6 9011.6 10840.0 11165.7 11443.3 11481.9 04:01:50 INFO - PID 1676 | -------- Summary: end -------- 04:01:50 INFO - PID 1676 | 04:01:50 INFO - TEST-INFO | 1676: exit 0 04:01:51 INFO - TEST-OK | dromaeo_css | took 1114984ms 04:01:51 INFO - TEST-START | kraken 04:01:51 INFO - operating with platform_type : mac_ 04:01:51 INFO - Initialising browser for kraken test... 04:01:51 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpyYVb1l/profile http://localhost:49240/getInfo.html) 04:01:53 INFO - PID 1687 | 2017-04-22 04:01:53.810 plugin-container[1688:11816] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 04:01:53 INFO - PID 1687 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:01:53 INFO - PID 1687 | 2017-04-22 04:01:53.815 plugin-container[1688:11816] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980f, name = 'com.apple.CFPasteboardClient' 04:01:53 INFO - PID 1687 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:01:53 INFO - PID 1687 | 2017-04-22 04:01:53.816 plugin-container[1688:11816] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:01:53 INFO - PID 1687 | __metrics Screen width/height:1600/1200 04:01:53 INFO - PID 1687 | colorDepth:24 04:01:53 INFO - PID 1687 | Browser inner width/height: 1024/689 04:01:53 INFO - PID 1687 | __metrics 04:01:54 ERROR - PID 1687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 04:01:54 INFO - TEST-INFO | 1687: exit 0 04:01:54 INFO - Browser initialized. 04:01:54 INFO - Running cycle 1/1 for kraken test... 04:01:54 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpyYVb1l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:57 INFO - PID 1689 | 2017-04-22 04:01:57.317 plugin-container[1690:11938] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 04:01:57 INFO - PID 1689 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:01:57 INFO - PID 1689 | 2017-04-22 04:01:57.318 plugin-container[1690:11938] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x430f, name = 'com.apple.CFPasteboardClient' 04:01:57 INFO - PID 1689 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:01:57 INFO - PID 1689 | 2017-04-22 04:01:57.318 plugin-container[1690:11938] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:02:07 INFO - PID 1689 | RSS: Main: 236761088 04:02:07 INFO - PID 1689 | 04:02:09 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 04:02:10 INFO - PID 1689 | RSS: Main: 249409536 04:02:10 INFO - PID 1689 | 04:02:13 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 04:02:14 INFO - PID 1689 | RSS: Main: 257568768 04:02:14 INFO - PID 1689 | 04:02:17 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 04:02:17 INFO - PID 1689 | RSS: Main: 259694592 04:02:17 INFO - PID 1689 | 04:02:19 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 04:02:20 INFO - PID 1689 | RSS: Main: 262361088 04:02:20 INFO - PID 1689 | 04:02:22 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:02:23 INFO - PID 1689 | RSS: Main: 262561792 04:02:23 INFO - PID 1689 | 04:02:25 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 04:02:26 INFO - PID 1689 | RSS: Main: 269082624 04:02:26 INFO - PID 1689 | 04:02:29 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 04:02:30 INFO - PID 1689 | RSS: Main: 270880768 04:02:30 INFO - PID 1689 | 04:02:32 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 04:02:33 INFO - PID 1689 | RSS: Main: 270323712 04:02:33 INFO - PID 1689 | 04:02:35 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:02:35 INFO - PID 1689 | RSS: Main: 269676544 04:02:35 INFO - PID 1689 | 04:02:37 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:02:38 INFO - PID 1689 | RSS: Main: 269369344 04:02:38 INFO - PID 1689 | 04:02:40 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:02:40 INFO - PID 1689 | RSS: Main: 268926976 04:02:40 INFO - PID 1689 | 04:02:43 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:02:44 INFO - PID 1689 | RSS: Main: 269119488 04:02:44 INFO - PID 1689 | 04:02:47 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:02:48 INFO - PID 1689 | RSS: Main: 269357056 04:02:48 INFO - PID 1689 | 04:02:49 INFO - PID 1689 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 04:02:50 INFO - PID 1689 | RSS: Main: 271175680 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | __start_tp_report 04:02:50 INFO - PID 1689 | _x_x_mozilla_page_load 04:02:50 INFO - PID 1689 | _x_x_mozilla_page_load_details 04:02:50 INFO - PID 1689 | |i|pagename|runs| 04:02:50 INFO - PID 1689 | |0;ai-astar;104;116;117;115;115;115;115;116;117;116 04:02:50 INFO - PID 1689 | |1;audio-beat-detection;172;109;105;182;144;140;110;108;139;110 04:02:50 INFO - PID 1689 | |2;audio-dft;196;204;200;210;209;216;206;199;201;198 04:02:50 INFO - PID 1689 | |3;audio-fft;80;59;62;97;62;60;58;60;88;85 04:02:50 INFO - PID 1689 | |4;audio-oscillator;92;70;87;70;70;69;104;100;100;101 04:02:50 INFO - PID 1689 | |5;imaging-gaussian-blur;88;88;88;87;88;87;88;88;92;87 04:02:50 INFO - PID 1689 | |6;imaging-darkroom;145;96;96;97;96;96;97;96;96;97 04:02:50 INFO - PID 1689 | |7;imaging-desaturate;92;91;91;90;95;90;90;94;90;91 04:02:50 INFO - PID 1689 | |8;json-parse-financial;50;48;49;50;51;51;50;49;47;49 04:02:50 INFO - PID 1689 | |9;json-stringify-tinderbox;57;63;61;64;61;56;57;53;57;57 04:02:50 INFO - PID 1689 | |10;stanford-crypto-aes;84;84;84;81;82;83;83;84;82;82 04:02:50 INFO - PID 1689 | |11;stanford-crypto-ccm;148;148;141;136;139;137;139;139;188;138 04:02:50 INFO - PID 1689 | |12;stanford-crypto-pbkdf2;181;187;176;188;183;182;186;179;183;182 04:02:50 INFO - PID 1689 | |13;stanford-crypto-sha256-iterative;67;67;68;69;68;80;82;67;60;77 04:02:50 INFO - PID 1689 | __end_tp_report 04:02:50 INFO - PID 1689 | __start_cc_report 04:02:50 INFO - PID 1689 | _x_x_mozilla_cycle_collect,984 04:02:50 INFO - PID 1689 | __end_cc_report 04:02:50 INFO - PID 1689 | __startTimestamp1492858970045__endTimestamp 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | ------- Summary: start ------- 04:02:50 INFO - PID 1689 | Number of tests: 14 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#0] ai-astar Cycles:10 Average:114.60 Median:116.00 stddev:3.81 (3.3%) stddev-sans-first:0.83 04:02:50 INFO - PID 1689 | Values: 104.0 116.0 117.0 115.0 115.0 115.0 115.0 116.0 117.0 116.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:139.50 stddev:28.20 (20.2%) stddev-sans-first:25.91 04:02:50 INFO - PID 1689 | Values: 172.0 109.0 105.0 182.0 144.0 140.0 110.0 108.0 139.0 110.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#2] audio-dft Cycles:10 Average:203.90 Median:205.00 stddev:6.31 (3.1%) stddev-sans-first:6.02 04:02:50 INFO - PID 1689 | Values: 196.0 204.0 200.0 210.0 209.0 216.0 206.0 199.0 201.0 198.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#3] audio-fft Cycles:10 Average:71.10 Median:71.00 stddev:14.75 (20.8%) stddev-sans-first:15.29 04:02:50 INFO - PID 1689 | Values: 80.0 59.0 62.0 97.0 62.0 60.0 58.0 60.0 88.0 85.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#4] audio-oscillator Cycles:10 Average:86.30 Median:70.00 stddev:15.03 (21.5%) stddev-sans-first:15.80 04:02:50 INFO - PID 1689 | Values: 92.0 70.0 87.0 70.0 70.0 69.0 104.0 100.0 100.0 101.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:88.00 stddev:1.45 (1.6%) stddev-sans-first:1.54 04:02:50 INFO - PID 1689 | Values: 88.0 88.0 88.0 87.0 88.0 87.0 88.0 88.0 92.0 87.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#6] imaging-darkroom Cycles:10 Average:101.20 Median:96.00 stddev:15.40 (16.0%) stddev-sans-first:0.50 04:02:50 INFO - PID 1689 | Values: 145.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#7] imaging-desaturate Cycles:10 Average:91.40 Median:91.00 stddev:1.78 (2.0%) stddev-sans-first:1.87 04:02:50 INFO - PID 1689 | Values: 92.0 91.0 91.0 90.0 95.0 90.0 90.0 94.0 90.0 91.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:50.00 stddev:1.26 (2.5%) stddev-sans-first:1.32 04:02:50 INFO - PID 1689 | Values: 50.0 48.0 49.0 50.0 51.0 51.0 50.0 49.0 47.0 49.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:3.47 (5.9%) stddev-sans-first:3.63 04:02:50 INFO - PID 1689 | Values: 57.0 63.0 61.0 64.0 61.0 56.0 57.0 53.0 57.0 57.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.50 stddev:1.10 (1.3%) stddev-sans-first:1.09 04:02:50 INFO - PID 1689 | Values: 84.0 84.0 84.0 81.0 82.0 83.0 83.0 84.0 82.0 82.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:140.00 stddev:15.58 (11.1%) stddev-sans-first:16.49 04:02:50 INFO - PID 1689 | Values: 148.0 148.0 141.0 136.0 139.0 137.0 139.0 139.0 188.0 138.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:183.00 stddev:3.65 (2.0%) stddev-sans-first:3.82 04:02:50 INFO - PID 1689 | Values: 181.0 187.0 176.0 188.0 183.0 182.0 186.0 179.0 183.0 182.0 04:02:50 INFO - PID 1689 | 04:02:50 INFO - PID 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:68.50 stddev:6.88 (10.0%) stddev-sans-first:7.18 04:02:50 INFO - PID 1689 | Values: 67.0 67.0 68.0 69.0 68.0 80.0 82.0 67.0 60.0 77.0 04:02:50 INFO - PID 1689 | -------- Summary: end -------- 04:02:50 INFO - PID 1689 | 04:02:51 INFO - TEST-INFO | 1689: exit 0 04:02:51 INFO - TEST-OK | kraken | took 60099ms 04:02:51 INFO - SUITE-END | took 1175s 04:02:51 INFO - Completed test suite (00:19:35) 04:02:51 INFO - javascript benchmark 04:02:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7848.731868143098, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.26961529233, 3555.253396786675, 3573.8927832165045, 3606.459031145328, 3625.5105560749307, 6138.324784273726, 6153.538484613655, 6245.406686364794, 6287.15123458333, 6291.245050593924, 6198.566100372976, 6228.595141315811, 6233.1273621693, 6266.342034086424, 6296.433321001109, 5471.206675032118, 5489.451054894518, 5498.0, 5534.335879694442, 5600.103983362663, 5359.008583412081, 5490.396056433789, 5545.279113715212, 5568.610197286192, 5607.355154157263, 4473.888152796158, 5377.11277639189, 5471.5896307776675, 5486.1222204447095, 5515.558755299567, 5442.673439593597, 5454.890902181974, 5456.181572764078, 5484.2596249506605, 5513.5037846594, 5412.107002344608, 5424.105022671254, 5459.0, 5476.0, 5476.507114359687, 5276.2085687146855, 5832.212651292064, 6113.081058499965, 6184.257889053342, 6236.688165591748, 6700.39696427319, 6725.293844146392, 6725.730970761164, 6743.898841517381, 6751.0886030386255, 6763.898541521881, 6788.7623933162595, 6799.082123913257, 6800.217974932896, 6812.352826481477, 6176.629402235881, 6246.562740608114, 6293.779717709858, 6384.808455746289, 6396.744130234785, 6844.315568443216, 6886.931130688629, 6894.448444124458, 6898.862022759517, 6952.687129079203, 6308.179936608211, 6368.5860419072615, 6400.935990640127, 6572.4084832365315, 6599.967000165065, 6580.276169621337, 6679.365460281363, 6769.289224631441, 6772.187337519431, 6788.9660551696925, 6365.809025729235, 6434.903476447857, 6655.0, 6682.064510968468, 6710.765123220664, 6562.146920900253, 6574.737010519526, 6608.735650574019, 6639.966800166065, 6676.632785196861, 5255.08036093682, 5258.974499972545, 5270.947290527046, 5302.469753024744, 5328.413874473805, 4615.399998000238, 4726.527347265246, 4738.739369334719, 4744.146053710297, 4789.592884604778, 6167.784127555514, 6318.968405157945, 6341.968290158612, 6399.648019358887, 6400.135981642418, 6726.293739157318, 6739.460843132538, 6743.3593808589085, 6745.0556922030955, 6754.257031726506, 6316.494680425555, 6322.146510221061, 6339.302676705559, 6384.52116091295, 6404.295527491972, 5720.313562372542, 5815.302163740378, 5897.380775018647, 5922.763089476459, 5962.135490353874, 6924.134483189601, 6933.064036355128, 6939.791806245821, 6953.895691564731, 6963.686634101579, 6676.732930682912, 6730.528862979544, 6764.526483146133, 6787.728490860311, 6815.148106486689, 6614.239362473185, 6781.812548102384, 6796.150481189851, 6844.486663500158, 6994.02083708271, 6631.3700198481065, 6668.699908504032, 6672.8999065013095, 6673.232578253369, 6690.732370705117, 6398.104265402754, 6727.461803055841, 6762.222344430454, 6783.559068660521, 6802.761903333359, 6345.524085693499, 6468.902966455601, 6532.804015879531, 6549.672516374258, 6560.40956313934, 5231.8168864089575, 5486.972565137149, 5893.675847828239, 6547.9672601638595, 6587.505937054644, 5355.973220133875, 6391.360863913572, 6448.838779030561, 6450.677466126769, 6474.449671777763, 6331.5884467511305, 6332.873342533216, 6468.3855033771715, 6526.4452521536205, 6563.704633291418, 6371.076193951758, 6396.26442959047, 6411.3909178627955, 6418.454431373386, 6424.93575064262], "value": 6095.091677554661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.7155944961188, 819.4919150126922, 836.9497830130192, 1251.4556168066892, 1270.7903195972665, 38018.0, 38799.80600097003, 38960.0, 38972.415413768744, 38972.41541376878, 38863.41704874429, 38881.222375552476, 39202.607973920254, 39209.60790392102, 39319.60680393195, 7900.92099079009, 8062.838743225132, 8457.915420845806, 8680.392372533925, 8719.738407847775, 8594.441361311494, 8694.869576956351, 8716.128387161265, 8736.781580460476, 8737.868931966026, 8661.69684061058, 8708.0, 8735.039145693969, 8741.650333986632, 8747.169018943223, 8673.002604700445, 8714.607842647065, 8716.171963663443, 8734.432261902988, 8737.388382813206, 8408.579571021424, 8433.40966132371, 8454.408191426603, 8456.49261044333, 8469.36479764014, 31351.686483135334, 37426.8128659355, 37829.62170378288, 37875.81062094672, 38016.80991595052, 3554.8222588870713, 3706.721995850322, 3752.5684546277253, 3753.6997040236715, 3755.2301778135416, 31300.217494562592, 31359.216019599466, 31389.37221255585, 31422.0, 31643.84178079095, 3180.745540356789, 3214.2285851395495, 3219.951700724491, 3229.11199420159, 3232.903012909593, 239378.0, 242357.0, 271982.0, 287730.0, 288720.5563972167, 48221.27668084981, 48358.03283934302, 48427.27359089616, 48432.515674843504, 48438.94513185852, 48726.51273487291, 48880.75559622179, 48947.02105957861, 49014.26478602824, 49147.262791058165, 13868.93065534666, 13901.67934046264, 14011.579652610439, 14046.648833779032, 14063.0, 11487.655370338904, 11565.132615053904, 11584.015358694436, 11584.884151158549, 11599.0, 13378.732425351438, 13414.262215578237, 13415.530456433979, 13419.463221471031, 13457.932710336385, 5048.72232027242, 5908.734106965197, 5943.316518600416, 5968.731407086691, 5980.43185897339, 1023.2070145637042, 1028.3829702178782, 1052.2791887557048, 1060.411471633251, 1086.22877756792, 22630.189584833173, 23602.64596031061, 24357.025718971043, 24763.5047299053, 25116.623250651253, 1127.3855748617023, 1134.5688638317552, 1143.1712008793559, 1146.3236690352733, 1165.539611853313, 12558.246505209716, 12558.434870430852, 12606.243625382507, 12613.873861261454, 12633.368331583384, 313475.0, 314058.0, 314093.0, 314747.0, 315238.0, 54824.62938426571, 54828.0, 55191.0, 55243.89512209733, 55300.0, 1314.612189404147, 1506.8267149277754, 1559.4619856149611, 1562.546861410201, 1567.8432156784231, 23935.880320598983, 23968.40078998039, 24089.638655420535, 24166.0, 24278.0, 39249.0, 39383.60616393799, 39424.802875985435, 39443.80278098591, 39504.61733839302, 161030.0, 195020.04979950018, 195927.0, 196628.0, 197471.0, 34206.2013805193, 34232.973010809714, 34292.48561271533, 34509.0, 34532.136696582784, 42148.57851421569, 43960.0, 44612.33081503715, 44705.0, 44785.55214447944, 24586.385340366633, 25327.240182794547, 30023.648935798377, 30649.0, 30661.54007689931, 30203.546946796254, 30679.386412272077, 30879.382412352075, 30926.176096630606, 31004.0, 37210.25579488449, 37223.44164837584, 37266.881993540235, 37275.25449491049, 37356.0, 26753.866230668722, 30130.096097117123, 30979.0, 31394.372112557165, 31418.52872206873, 20577.279795207094, 24241.393965150306, 24524.386890327885, 24607.0, 24737.628935565623], "value": 17390.37425388741, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.39000634026763, 414.1282600126735, 435.30351437699704, 445.66352403935036, 463.35824882537696, 19113.713294300578, 19543.511412214702, 21265.57468850622, 21461.463463413424, 21482.785172148273, 21144.97504209466, 21232.57534849302, 21487.785122148773, 21576.676349854766, 21615.0, 5896.970515147418, 6118.755249790003, 6139.815805525842, 6141.723622437001, 6153.876922461548, 5761.683107429089, 5807.448292412214, 5875.471207591316, 5883.529317654598, 5945.88108237835, 5802.361740208574, 5809.244798176232, 5819.33077696064, 5821.243238379026, 5838.41615838417, 5630.859228519279, 5988.670623115749, 5998.070299103624, 6057.636541807506, 6073.0, 4465.888352791174, 5374.0, 5380.461953804627, 5385.380681221671, 5397.595180361489, 25818.354541136436, 26047.218583442525, 26288.0, 26306.079287225046, 26521.602175967375, 2179.56408718257, 2273.818094552448, 2280.270313499681, 2323.546908352872, 2330.091264406866, 17877.106144692712, 17922.641547168983, 18023.91856488615, 18107.909460452614, 18241.0, 1863.7297591849242, 2179.5967745966886, 2179.7384313882276, 2188.7701791311842, 2210.6573481110454, 165400.9999999988, 165535.0, 166804.0, 168187.0, 168562.0, 12414.937925310316, 12416.689582760504, 12536.498540058477, 12581.874181258254, 12696.619101426972, 16241.51275461738, 16252.75620865688, 16282.75575866363, 16294.592635184215, 16302.83697163037, 8610.956945215234, 8918.241949434241, 8940.552972351486, 9027.187553120251, 9048.41185322952, 6907.551009184387, 7355.264473552709, 8243.917560824315, 8363.414560980795, 8394.034686011064, 7759.107702614158, 7870.763877083697, 7903.762887113396, 7906.723264685824, 8017.158198389086, 2016.294296996069, 2145.1097794415455, 2177.6733489976314, 2194.9341519754435, 2405.9037638494615, 969.8496733006396, 987.5457289646699, 994.6021591363368, 1010.1262408017012, 1040.953157107932, 19175.424737257905, 20177.899110504353, 20681.586368272852, 21055.8947205263, 21286.78713212879, 1017.730301470111, 1018.9235807314333, 1050.1861057680205, 1052.663147792699, 1056.5404049238452, 10321.432321222255, 10680.305780124267, 10716.51775670081, 10726.249162558546, 10731.0, 525439.0, 574107.0, 575334.0, 585331.0, 587562.0, 124045.0, 134761.0, 138211.0, 138292.0, 142040.0, 1197.9221350612183, 1240.2434514945876, 1266.0820904843915, 1267.5056727876135, 1270.1743866486856, 20615.38153855387, 20908.22280106208, 21906.12375504962, 21916.671249930943, 22005.0, 56929.71535142298, 57181.0, 59594.0, 59778.10332844924, 60937.390626094944, 62562.68718656377, 81801.0, 82390.58804705938, 82413.58793205995, 83138.5843070805, 8661.653533858827, 8818.691345802867, 8820.91179088201, 8859.335549833659, 8862.202401783612, 13571.728565428833, 13741.725165496833, 13779.242141682304, 13838.962077844, 13933.233672147724, 11511.251768635348, 11691.240069395462, 11895.226810257305, 11921.0, 12079.637610871689, 10342.965703429596, 10831.187660925305, 10834.404107774148, 10903.945480272549, 11141.72145696364, 10981.725456863642, 11385.943070284595, 11771.234869733782, 12058.974987126192, 12215.0, 8532.914670853212, 8682.739517814476, 8738.25724813398, 8769.693060742844, 8770.210681038738, 11176.441177941233, 11608.825867611824, 11851.992580630744, 11930.522779088738, 12022.63932082039], "value": 10432.95679947937, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.4520546575907, 1342.8921140059454, 1445.0607105381503, 1510.1467670766017, 1514.1520748380908, 11344.205905586612, 11751.588694395676, 11837.940810295959, 11868.10989175812, 12141.210821296632, 11594.30434173948, 11896.583619573317, 11901.345426001566, 11942.283462992205, 11962.461689223985, 2516.609925461552, 2573.74262573743, 2587.0, 2589.8057645676554, 2590.5596048671678, 2354.5290941811704, 2493.5012997400504, 2529.443522425073, 2543.55487789637, 2544.7709706126443, 2316.420894776306, 2522.810789190809, 2555.220657699401, 2555.3356127406823, 2558.181381957765, 2485.378655336166, 2507.360623041131, 2528.4311030018284, 2536.987315063422, 2541.440883005736, 2438.1588352018525, 2514.911978080777, 2533.40464990727, 2539.0986199898953, 2558.2581051495044, 11754.412279386082, 11839.644810655695, 11854.703632409259, 11896.286222826659, 11913.583024594098, 6564.0, 6764.729410823561, 6792.76225332111, 6803.557768745016, 6810.250872404032, 4024.1348110156164, 4406.581374769424, 4418.0, 4497.955020449786, 4500.729956202638, 1291.0897817038965, 1293.2757655712737, 1311.1346511302495, 1340.7318536292682, 1340.8592097829685, 16421.261043253082, 16694.165291735364, 16786.160691965353, 16905.23926423314, 16905.323787048503, 5654.434556544313, 5728.054870946247, 5772.520941088056, 5885.882282354329, 5888.322842873039, 10359.741006474747, 12302.0, 12410.945069668998, 12414.0, 12436.00511959041, 6579.440747536417, 6611.900821487586, 6639.435647969976, 6662.533622646465, 6675.198976122896, 6059.0, 6167.044108163242, 6178.567500274938, 6225.968870155621, 6312.5581209314905, 4363.323684828857, 4469.307257375112, 4485.842995495142, 4486.730796152241, 4560.771961401917, 1324.1326930860303, 1337.2912356451097, 1337.699017721005, 1342.8791408773257, 1345.421468768439, 795.3478147918651, 801.1867954026668, 821.5892053973014, 831.4678605692362, 854.0818619983419, 6192.916239658132, 6269.592476489105, 6455.806325810233, 6475.255345635218, 6501.772437964649, 592.8280798568453, 604.7067172421372, 604.9637021778707, 610.3743662745633, 615.0927382111439, 3862.362710152793, 4312.525622181557, 4391.14372697321, 4458.487273963471, 4473.664475164311, 14765.704685906436, 15077.321520531603, 15090.471833485775, 15215.391384344503, 15247.466338678092, 14576.635584110481, 15066.246687665573, 15083.698326033418, 15092.547223583091, 15121.319540620698, 5783.681897495678, 7628.199039100926, 8725.389222754473, 8820.33847461443, 8821.338399620054, 6628.7017084230365, 7033.683484243324, 7048.964755176191, 7191.280871912976, 7212.206657267801, 10050.497475126069, 11424.371659558805, 13479.326033698471, 13779.035467517178, 13814.723705525632, 13757.862421375658, 13801.930990344985, 13848.446062157402, 14006.299685015505, 14092.506762263272, 8174.0, 8237.258646721824, 8647.913520864711, 8764.78088047804, 8821.2060914518, 10736.89263107359, 10742.3017503862, 10753.569857205624, 10799.406032667965, 10846.783064338826, 9174.403663761834, 9200.125988031126, 9238.168564829197, 9238.260939124988, 9278.536073196448, 8964.103589640983, 8986.281097512314, 9121.680741174026, 9164.0, 9292.884853817584, 8255.752327430188, 8332.625031873458, 8380.497170169809, 8422.073571906963, 8433.19884610961, 6140.0, 6193.504519638508, 6207.34822843613, 6207.720652570735, 6213.161223234805, 6138.447539721446, 6152.384761523812, 6305.243370795534, 6305.4009869062365, 6336.936630633819], "value": 5377.579611964003, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.7643820011391, 387.51195409627024, 408.15919206434745, 413.76622208452227, 417.46981333706213, 4780.593649539785, 5113.48865113489, 5399.4330595287465, 6030.849228769283, 6151.692415379235, 5969.88060238795, 6000.459958603725, 6050.697465126737, 6057.575969682124, 6090.634561926277, 4350.173467041268, 4463.237021376563, 4499.212637788391, 4516.503184649686, 4518.209313370164, 4103.2409004334295, 4516.616087632555, 4523.389342438762, 4544.909101817978, 4576.816927322903, 4474.485434175079, 4489.0, 4489.608221451361, 4494.595486406222, 4499.70751901127, 4364.629006534448, 4381.78091095444, 4395.384646149541, 4464.6651501137385, 4482.394876691637, 3212.550242965963, 3365.6802603752603, 3850.133719912997, 3881.204353107606, 3889.230400167945, 5868.882622347529, 6011.707482891155, 6024.102407741548, 6056.062060140756, 6079.6960151992225, 5032.0, 5224.947750522484, 5268.5521730652945, 5327.0, 5349.491798279158, 6030.819075427744, 6183.907241391383, 6433.8391540211405, 6489.424955406427, 6558.344165583451, 4339.47926248849, 4343.283358245885, 4358.4987726411555, 4359.215341238576, 4363.345498175299, 5782.392848750863, 6647.900281495781, 6889.827754306132, 6913.1358580177475, 6927.757528486479, 3880.3403421418425, 4028.778417187083, 4406.876246557107, 4410.25025745624, 4427.8228870844805, 4492.9101417972115, 4493.348464472633, 4503.369528266046, 4551.840685575989, 4558.635309175258, 5115.590752739772, 5263.184206448007, 5336.719187394997, 5367.35591728995, 5371.435999220025, 5830.300363956352, 6100.176476175659, 6527.738890444329, 6547.919593267057, 6554.279029306773, 1352.9052966292265, 1515.9621009474631, 1530.6249968757725, 1554.2694933381292, 1561.2818103672437, 995.9502024898726, 1012.6202673997251, 1013.1034034879185, 1019.2050200843354, 1024.8052869954686, 6070.726817293233, 6276.9372306276355, 6282.811515654537, 6298.905516417258, 6306.306306306303, 6762.661866906635, 6768.830779230559, 6779.508508128204, 6788.558743681645, 6831.155587991215, 5385.661821497806, 5390.407055223922, 6160.322364539897, 6172.537059720539, 6238.282597501346, 3488.66857648523, 3530.91172720684, 3541.29174165168, 3543.7696549724187, 3547.0, 6322.525810564226, 6906.412954898789, 6978.685959131852, 7001.0, 7098.60957647324, 5818.0, 6389.600787334694, 6934.271901450275, 6989.475789315821, 7006.369426751617, 6604.636744979072, 6755.6567638965835, 6936.606870629625, 6962.96518517394, 7002.719891204295, 5484.945150548603, 6409.423151916163, 6431.356864313531, 6739.797806065826, 6787.0, 5726.828195154152, 6603.702833372606, 6624.436922861611, 6702.899456508254, 6747.493937954575, 5592.832215033555, 7056.611886346095, 7081.539699919695, 7093.82265443368, 7101.431885449048, 3631.8002509862213, 4421.204183247047, 4483.686141970031, 4493.056458143827, 4501.09978004407, 5317.494837990384, 6720.8319792005595, 6804.727810887707, 6872.553284036521, 6921.442675397995, 5668.603197776116, 6425.325340839145, 6540.803775886731, 6545.280019197789, 6618.7352505899225, 5375.554122874161, 6520.902186467301, 6527.086207930798, 6537.7058032389605, 6549.6070235786, 6192.8233635609095, 6445.452136568257, 6462.935370646233, 6465.579737317059, 6472.061551074974, 5636.84444688846, 5770.6249093808765, 6413.679316034273, 6625.17185351831, 6646.90029649546, 6424.421802037839, 6430.196225471816, 6455.774047908489, 6487.708053137526, 6535.771248006297], "value": 4751.573473894134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.2513000604447, 829.5313148071339, 851.6380538271234, 852.1223140165624, 863.8445079885622, 16437.0, 16800.32798688054, 16909.83090169098, 18585.814141858576, 19158.0, 14531.418743250257, 17573.3849315274, 17752.644947101082, 17923.64152716945, 18095.0, 985.5023213277285, 1008.6167256442542, 1008.7326858382535, 1009.2531526670284, 1013.3210748798323, 945.5603144537788, 978.9314747967645, 1003.7089244119196, 1004.6031817432109, 1005.9094681478665, 1047.1256500821785, 1057.323313079626, 1057.9629712960048, 1061.2412125330388, 1066.7226521104492, 1052.300220353464, 1053.4837929414532, 1054.6572363981659, 1058.8358804385332, 1059.8304271316551, 763.5571368606251, 769.7498313048226, 788.1763557082862, 789.9493673414345, 791.8535071011823, 16454.83545164557, 16664.416745413975, 16821.57946051346, 16880.98714077147, 16965.57586060346, 16515.83484165155, 16748.665026699397, 16938.068406237653, 17163.828361716347, 17190.656186876316, 13768.173909565357, 13864.168149910936, 13942.512012079529, 14009.369578368896, 14187.929060354736, 3538.5046093546925, 3550.804705741183, 3568.0544655666267, 3573.338932297507, 3574.3566158091535, 98827.50586247095, 111253.44373278163, 115220.42389788081, 129529.0, 130358.0, 11251.0, 12862.035347348987, 12988.480460781651, 13109.147905386119, 13130.146540474838, 24095.397615059414, 24421.38946526351, 24778.0, 25388.492230155294, 25476.617850732255, 7665.846683066307, 7702.460827742004, 7773.844523109507, 7776.183500732454, 7791.922080779233, 3700.9259814803554, 3805.37211360128, 3943.428202910562, 3970.9873982134372, 4039.293123703399, 4330.870073897788, 4415.977920110443, 4422.447194100738, 4427.335899615084, 4429.092036132585, 792.5838934559403, 905.2622112977901, 907.1699395053585, 915.3135148638521, 915.4598786715869, 631.8641492079133, 640.5228105061666, 664.8038828545591, 674.4435840431663, 679.1815861886415, 10382.3251488653, 11348.943255283672, 11368.317900925971, 11434.599789007345, 11435.656930292105, 638.450932198309, 647.4755448087064, 652.6019128331714, 662.2549631664377, 666.6067020457953, 5631.4087020863035, 6122.326544080148, 6148.6925653717135, 6226.439620434183, 6230.719617617218, 86019.0, 91965.0, 96756.51621741986, 96806.5159674197, 110285.0, 78325.0, 85911.71132433019, 86264.56867715747, 86371.0, 88180.24575330666, 76546.0, 76874.61562692151, 77014.614926925, 78583.60708196537, 80025.39949200983, 11934.4032798358, 12756.298403587893, 12780.87219127834, 12786.0, 12790.040746944203, 39993.0, 40151.59848401479, 41591.37612935748, 41705.58294417017, 42323.78838105913, 52286.73856630845, 52340.73829630828, 52838.735806322264, 53211.0, 53341.733291333294, 14311.642208944444, 14963.925180374028, 15147.772783408478, 16823.747643785107, 16979.575510612332, 18178.545536361697, 18629.975351355806, 18696.626067478846, 18788.3424080162, 18890.05549722536, 16772.748408773634, 17244.0, 17255.843019622545, 17415.56461088483, 17447.127643618023, 13161.934190328988, 14144.575662730134, 16961.49115526536, 17196.656066878844, 17226.569335766708, 16718.58203544921, 16759.994400336018, 16985.575360616083, 17038.97766134036, 17084.743728844325, 9671.661491847752, 10405.47972601382, 10721.035106840422, 11622.020250338808, 11829.645110646694, 9011.639534418811, 10840.0, 11165.665030049111, 11443.25618834773, 11481.885181148082], "value": 8272.667585958547, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1477.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 117.0, 115.0, 115.0, 115.0, 115.0, 116.0, 117.0, 116.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 109.0, 105.0, 182.0, 144.0, 140.0, 110.0, 108.0, 139.0, 110.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 204.0, 200.0, 210.0, 209.0, 216.0, 206.0, 199.0, 201.0, 198.0], "value": 203.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 62.0, 97.0, 62.0, 60.0, 58.0, 60.0, 88.0, 85.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 87.0, 70.0, 70.0, 69.0, 104.0, 100.0, 100.0, 101.0], "value": 86.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 87.0, 88.0, 87.0, 88.0, 88.0, 92.0, 87.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0], "value": 101.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 91.0, 90.0, 95.0, 90.0, 90.0, 94.0, 90.0, 91.0], "value": 91.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 49.0, 50.0, 51.0, 51.0, 50.0, 49.0, 47.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 61.0, 64.0, 61.0, 56.0, 57.0, 53.0, 57.0, 57.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 81.0, 82.0, 83.0, 83.0, 84.0, 82.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 141.0, 136.0, 139.0, 137.0, 139.0, 139.0, 188.0, 138.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 187.0, 176.0, 188.0, 183.0, 182.0, 186.0, 179.0, 183.0, 182.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 69.0, 68.0, 80.0, 82.0, 67.0, 60.0, 77.0], "value": 70.5, "unit": "score"}]}]} 04:02:51 INFO - Return code: 0 04:02:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:02:51 ERROR - # TBPL SUCCESS # 04:02:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:02:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:02:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:02:51 INFO - 2017-04-22 04:02:51.348 screenresolution[1694:12328] starting screenresolution argv=screenresolution get 04:02:51 INFO - 2017-04-22 04:02:51.351 screenresolution[1694:12328] Display 0: 1600x1200x32@60 04:02:51 INFO - 2017-04-22 04:02:51.357 screenresolution[1695:12331] starting screenresolution argv=screenresolution list 04:02:51 INFO - Available Modes on Display 0 04:02:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:02:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:02:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:02:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:02:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:02:51 INFO - Intel Iris: 04:02:51 INFO - Chipset Model: Intel Iris 04:02:51 INFO - Type: GPU 04:02:51 INFO - Bus: Built-In 04:02:51 INFO - VRAM (Dynamic, Max): 1536 MB 04:02:51 INFO - Vendor: Intel (0x8086) 04:02:51 INFO - Device ID: 0x0a2e 04:02:51 INFO - Revision ID: 0x0009 04:02:51 INFO - Displays: 04:02:51 INFO - Display: 04:02:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:02:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:02:51 INFO - Display Serial Number: 1600x1200 60 04:02:51 INFO - Main Display: Yes 04:02:51 INFO - Mirror: Off 04:02:51 INFO - Online: Yes 04:02:51 INFO - Rotation: Supported 04:02:51 INFO - Return code: 0 04:02:51 INFO - Running post-action listener: _resource_record_post_action 04:02:51 INFO - [mozharness: 2017-04-22 11:02:51.602643Z] Finished run-tests step (success) 04:02:51 INFO - Running post-run listener: _resource_record_post_run 04:02:51 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 35025408; Write bytes: 520484864; Read time: 322; Write time: 1660 04:02:51 INFO - TinderboxPrint: CPU usage
54.5% 04:02:51 INFO - TinderboxPrint: I/O read bytes / time
35,025,408 / 322 04:02:51 INFO - TinderboxPrint: I/O write bytes / time
520,484,864 / 1,660 04:02:51 INFO - TinderboxPrint: CPU idle
2,177.7 (45.5%) 04:02:51 INFO - TinderboxPrint: CPU system
968.3 (20.2%) 04:02:51 INFO - TinderboxPrint: CPU user
1,635.7 (34.2%) 04:02:51 INFO - TinderboxPrint: Swap in / out
238,940,160 / 0 04:02:51 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 196684288; Write bytes: 192241664; Read time: 14956; Write time: 354 04:02:51 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34075136; Write bytes: 311416832; Read time: 307; Write time: 1256 04:02:52 INFO - Running post-run listener: _upload_blobber_files 04:02:52 INFO - Blob upload gear active. 04:02:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:02:52 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:02:52 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:02:52 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:02:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:02:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:02:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:02:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:53 INFO - (blobuploader) - INFO - Done attempting. 04:02:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:02:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:02:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:54 INFO - (blobuploader) - INFO - Done attempting. 04:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:55 INFO - (blobuploader) - INFO - Done attempting. 04:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:02:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:57 INFO - (blobuploader) - INFO - Done attempting. 04:02:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:02:57 INFO - Return code: 0 04:02:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:02:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:02:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/530b607710b5e9d7939a70a3234a662b84d858891edfd6dd7ef52d4322a2de1fce6ba0029c4af8d4485ea8f707bd5ca53038fb26adb145b0750e94ab6ac8e7b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6bf07ecf628e157793bd24fb8ecf8270abe8384ceb6ced823ecc83ebe432e3b03c2b2396313e542cbd774ff56acd8a3b2e2898c7aad59a89f170a0f0eda1648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f8a107add23fc13a523ebfb27d57af86fca536375caaea321f445bfe5339b8ca6a8e39abb94a7a23ad3c4acab0ebb5ca0de4ff5869f828c445ffcc358745f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab7b4e0881bff3678312f3b80f7eb468d126911ca8c503d814f9a032a1909c8e3a23369d3ba18db3c33d094ea28cd2e5f82721fa1d451f5416e6d40d510b7b5c"} 04:02:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:02:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:02:57 INFO - Contents: 04:02:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/530b607710b5e9d7939a70a3234a662b84d858891edfd6dd7ef52d4322a2de1fce6ba0029c4af8d4485ea8f707bd5ca53038fb26adb145b0750e94ab6ac8e7b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6bf07ecf628e157793bd24fb8ecf8270abe8384ceb6ced823ecc83ebe432e3b03c2b2396313e542cbd774ff56acd8a3b2e2898c7aad59a89f170a0f0eda1648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f8a107add23fc13a523ebfb27d57af86fca536375caaea321f445bfe5339b8ca6a8e39abb94a7a23ad3c4acab0ebb5ca0de4ff5869f828c445ffcc358745f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab7b4e0881bff3678312f3b80f7eb468d126911ca8c503d814f9a032a1909c8e3a23369d3ba18db3c33d094ea28cd2e5f82721fa1d451f5416e6d40d510b7b5c"} 04:02:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:02:57 INFO - Copying logs to upload dir... 04:02:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:02:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.858050 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-22 04:02:57.626385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-22 04:02:57.630178) ========= 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.uEXSfivN15/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.6d1YOz3NPn/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/530b607710b5e9d7939a70a3234a662b84d858891edfd6dd7ef52d4322a2de1fce6ba0029c4af8d4485ea8f707bd5ca53038fb26adb145b0750e94ab6ac8e7b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6bf07ecf628e157793bd24fb8ecf8270abe8384ceb6ced823ecc83ebe432e3b03c2b2396313e542cbd774ff56acd8a3b2e2898c7aad59a89f170a0f0eda1648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f8a107add23fc13a523ebfb27d57af86fca536375caaea321f445bfe5339b8ca6a8e39abb94a7a23ad3c4acab0ebb5ca0de4ff5869f828c445ffcc358745f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab7b4e0881bff3678312f3b80f7eb468d126911ca8c503d814f9a032a1909c8e3a23369d3ba18db3c33d094ea28cd2e5f82721fa1d451f5416e6d40d510b7b5c"} build_url:https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/J9BVx46WSZyd8QmG_okyPw/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/530b607710b5e9d7939a70a3234a662b84d858891edfd6dd7ef52d4322a2de1fce6ba0029c4af8d4485ea8f707bd5ca53038fb26adb145b0750e94ab6ac8e7b4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6bf07ecf628e157793bd24fb8ecf8270abe8384ceb6ced823ecc83ebe432e3b03c2b2396313e542cbd774ff56acd8a3b2e2898c7aad59a89f170a0f0eda1648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f8a107add23fc13a523ebfb27d57af86fca536375caaea321f445bfe5339b8ca6a8e39abb94a7a23ad3c4acab0ebb5ca0de4ff5869f828c445ffcc358745f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab7b4e0881bff3678312f3b80f7eb468d126911ca8c503d814f9a032a1909c8e3a23369d3ba18db3c33d094ea28cd2e5f82721fa1d451f5416e6d40d510b7b5c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-22 04:02:57.665677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 04:02:57.665985) ========= 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.uEXSfivN15/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.6d1YOz3NPn/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005241 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 04:02:57.713539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-22 04:02:57.713882) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-22 04:02:57.714234) ========= ========= Total master_lag: 0.21 =========