builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0057 starttime: 1493375961.15 results: success (0) buildid: 20170428014124 builduid: 89a4c6de6d9d4ed883aadf73bfcf8c3c revision: 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:21.147987) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:21.148406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:21.148725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:21.176155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:21.176527) ========= 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.n1JLik25YD/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.rRJNi5FfiD/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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-28 03:39:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.02M=0.001s 2017-04-28 03:39:21 (9.02 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095645 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:21.297615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:21.297965) ========= 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.n1JLik25YD/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.rRJNi5FfiD/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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.027619 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:21.348964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 03:39:21.349320) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 --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 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.n1JLik25YD/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.rRJNi5FfiD/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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-28 03:39:21,458 truncating revision to first 12 chars 2017-04-28 03:39:21,459 Setting DEBUG logging. 2017-04-28 03:39:21,459 attempt 1/10 2017-04-28 03:39:21,459 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/84762dbeb538?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 03:39:22,516 unpacking tar archive at: mozilla-central-84762dbeb538/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 03:39:22.705748) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:22.706091) ========= script_repo_revision: 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:22.706488) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:22.706759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 03:39:22.727389) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-28 03:39:22.727756) ========= /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.n1JLik25YD/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.rRJNi5FfiD/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:39:22 INFO - MultiFileLogger online at 20170428 03:39:22 in /builds/slave/test 03:39:22 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:39:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:22 INFO - {'append_to_log': False, 03:39:22 INFO - 'base_work_dir': '/builds/slave/test', 03:39:22 INFO - 'blob_upload_branch': 'Firefox', 03:39:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:22 INFO - 'branch': 'Firefox', 03:39:22 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:22 INFO - 'config_files': ('talos/mac_config.py',), 03:39:22 INFO - 'default_actions': ('clobber', 03:39:22 INFO - 'read-buildbot-config', 03:39:22 INFO - 'download-and-extract', 03:39:22 INFO - 'populate-webroot', 03:39:22 INFO - 'create-virtualenv', 03:39:22 INFO - 'install', 03:39:22 INFO - 'run-tests'), 03:39:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:22 INFO - 'download_minidump_stackwalk': True, 03:39:22 INFO - 'download_symbols': 'ondemand', 03:39:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:22 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:22 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:22 INFO - 'gecko_profile': False, 03:39:22 INFO - 'gecko_profile_interval': 0, 03:39:22 INFO - 'installer_path': 'installer.exe', 03:39:22 INFO - 'log_level': 'info', 03:39:22 INFO - 'log_name': 'talos', 03:39:22 INFO - 'log_to_console': True, 03:39:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:39:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:39:22 INFO - 'opt_config_files': (), 03:39:22 INFO - 'pip_index': False, 03:39:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:39:22 INFO - 'cmd': ('bash', 03:39:22 INFO - '-c', 03:39:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:39:22 INFO - 'enabled': True, 03:39:22 INFO - 'halt_on_failure': False, 03:39:22 INFO - 'name': 'check_screen_resolution'},), 03:39:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:39:22 INFO - 'cmd': ('bash', 03:39:22 INFO - '-c', 03:39:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:39:22 INFO - 'enabled': True, 03:39:22 INFO - 'halt_on_failure': False, 03:39:22 INFO - 'name': 'check_screen_resolution'},), 03:39:22 INFO - 'run_cmd_checks_enabled': True, 03:39:22 INFO - 'suite': 'dromaeojs-e10s', 03:39:22 INFO - 'system_bits': '32', 03:39:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:22 INFO - 'title': 't-yosemite-r7-0057', 03:39:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:22 INFO - 'use_talos_json': True, 03:39:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:22 INFO - 'work_dir': 'build'} 03:39:22 INFO - [mozharness: 2017-04-28 10:39:22.938941Z] Running clobber step. 03:39:22 INFO - Running pre-action listener: _resource_record_pre_action 03:39:22 INFO - Running main action method: clobber 03:39:22 INFO - rmtree: /builds/slave/test/build 03:39:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:25 INFO - Running post-action listener: _resource_record_post_action 03:39:25 INFO - [mozharness: 2017-04-28 10:39:25.496455Z] Finished clobber step (success) 03:39:25 INFO - [mozharness: 2017-04-28 10:39:25.496588Z] Running read-buildbot-config step. 03:39:25 INFO - Running pre-action listener: _resource_record_pre_action 03:39:25 INFO - Running main action method: read_buildbot_config 03:39:25 INFO - Using buildbot properties: 03:39:25 INFO - { 03:39:25 INFO - "project": "", 03:39:25 INFO - "product": "firefox", 03:39:25 INFO - "script_repo_revision": "production", 03:39:25 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:39:25 INFO - "repository": "", 03:39:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:39:25 INFO - "buildid": "20170428014124", 03:39:25 INFO - "pgo_build": "False", 03:39:25 INFO - "basedir": "/builds/slave/test", 03:39:25 INFO - "buildnumber": 204, 03:39:25 INFO - "slavename": "t-yosemite-r7-0057", 03:39:25 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:39:25 INFO - "platform": "yosemite_r7", 03:39:25 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:39:25 INFO - "branch": "mozilla-central", 03:39:25 INFO - "repo_path": "mozilla-central", 03:39:25 INFO - "revision": "84762dbeb5380461fe27f0afa0e27e8ba9dd3b01", 03:39:25 INFO - "stage_platform": "macosx64", 03:39:25 INFO - "builduid": "89a4c6de6d9d4ed883aadf73bfcf8c3c", 03:39:25 INFO - "slavebuilddir": "test" 03:39:25 INFO - } 03:39:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:39:25 INFO - Running post-action listener: _resource_record_post_action 03:39:25 INFO - [mozharness: 2017-04-28 10:39:25.499957Z] Finished read-buildbot-config step (success) 03:39:25 INFO - [mozharness: 2017-04-28 10:39:25.500090Z] Running download-and-extract step. 03:39:25 INFO - Running pre-action listener: _resource_record_pre_action 03:39:25 INFO - Running main action method: download_and_extract 03:39:25 INFO - mkdir: /builds/slave/test/build/tests 03:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:25 INFO - trying https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:39:25 INFO - Downloading https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/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:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/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:39:26 INFO - Downloaded 1325 bytes. 03:39:26 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:39:26 INFO - Using the following test package requirements: 03:39:26 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:39:26 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:39:26 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:39:26 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:39:26 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:39:26 INFO - u'jsshell-mac.zip'], 03:39:26 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:39:26 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:39:26 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:39:26 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:39:26 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:39:26 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:39:26 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:39:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:39:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:39:26 INFO - Fetch https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:39:28 INFO - Content-Length response header: 52695150 03:39:28 INFO - Bytes received: 52695150 03:39:44 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:39:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:39:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:39:44 INFO - Fetch https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:39:46 INFO - Content-Length response header: 52695150 03:39:46 INFO - Bytes received: 52695150 03:40:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:40:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:40:02 INFO - Fetch https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:40:03 INFO - Content-Length response header: 14408809 03:40:03 INFO - Bytes received: 14408809 03:40:03 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:40:03 INFO - trying https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:40:03 INFO - Downloading https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/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:40:05 INFO - Downloaded 71219205 bytes. 03:40:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:40:05 INFO - mkdir: /builds/slave/test/properties 03:40:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:05 INFO - Contents: 03:40:05 INFO - build_url:https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:40:06 INFO - Running post-action listener: _resource_record_post_action 03:40:06 INFO - Running post-action listener: set_extra_try_arguments 03:40:06 INFO - [mozharness: 2017-04-28 10:40:06.056763Z] Finished download-and-extract step (success) 03:40:06 INFO - [mozharness: 2017-04-28 10:40:06.056890Z] Running populate-webroot step. 03:40:06 INFO - Running pre-action listener: _resource_record_pre_action 03:40:06 INFO - Running main action method: populate_webroot 03:40:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:06 INFO - '--tppagecycles', 03:40:06 INFO - '7'], 03:40:06 INFO - 'tests': ['tsvgm']}}, 03:40:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:40:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:40:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:40:06 INFO - 'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:40:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:40:06 INFO - 'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['damp', 'tps']}, 03:40:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:40:06 INFO - 'tests': ['damp', 'tps']}, 03:40:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['dromaeo_dom']}, 03:40:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:40:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:40:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['a11yr', 03:40:06 INFO - 'ts_paint', 03:40:06 INFO - 'tpaint', 03:40:06 INFO - 'sessionrestore', 03:40:06 INFO - 'sessionrestore_no_auto_restore', 03:40:06 INFO - 'tabpaint']}, 03:40:06 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:40:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:40:06 INFO - 'bloom_basic_ref']}, 03:40:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['tsvgx', 03:40:06 INFO - 'tsvgr_opacity', 03:40:06 INFO - 'tart', 03:40:06 INFO - 'tscrollx', 03:40:06 INFO - 'cart', 03:40:06 INFO - 'tsvg_static']}, 03:40:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:40:06 INFO - 'tsvgr_opacity', 03:40:06 INFO - 'tart', 03:40:06 INFO - 'tscrollx', 03:40:06 INFO - 'cart', 03:40:06 INFO - 'tsvg_static']}, 03:40:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:40:06 INFO - 'talos_options': ['--disable-e10s'], 03:40:06 INFO - 'tests': ['tp5o']}, 03:40:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:40:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:40:06 INFO - 'talos_options': ['--disable-e10s', 03:40:06 INFO - '--xperf_path', 03:40:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:06 INFO - 'tests': ['tp5n']}, 03:40:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:40:06 INFO - 'talos_options': ['--xperf_path', 03:40:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:06 INFO - 'tests': ['tp5n']}}, 03:40:06 INFO - 'talos.zip': {'path': '', 03:40:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:06 INFO - Running post-action listener: _resource_record_post_action 03:40:06 INFO - [mozharness: 2017-04-28 10:40:06.076074Z] Finished populate-webroot step (success) 03:40:06 INFO - [mozharness: 2017-04-28 10:40:06.076161Z] Running create-virtualenv step. 03:40:06 INFO - Running pre-action listener: _resource_record_pre_action 03:40:06 INFO - Running main action method: create_virtualenv 03:40:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:06 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:40:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:06 INFO - Using real prefix '/tools/python27' 03:40:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:06 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:10 INFO - Installing pip.................done. 03:40:10 INFO - Return code: 0 03:40:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:40:10 INFO - Reading from file tmpfile_stdout 03:40:10 INFO - Output received: 03:40:10 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:40:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40:10 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:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 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:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 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 0x109452b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109455768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9600d7e370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, '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.n1JLik25YD/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.rRJNi5FfiD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:40:10 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:40:10 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:40:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:10 INFO - 'HOME': '/Users/cltbld', 03:40:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:10 INFO - 'LOGNAME': 'cltbld', 03:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:10 INFO - 'MOZ_NO_REMOTE': '1', 03:40:10 INFO - 'NO_EM_RESTART': '1', 03:40:10 INFO - 'PAGER': '/bin/cat', 03:40:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:10 INFO - 'PWD': '/builds/slave/test', 03:40:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:10 INFO - 'SHELL': '/bin/bash', 03:40:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:10 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:10 INFO - 'USER': 'cltbld', 03:40:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:10 INFO - 'XPC_FLAGS': '0x0', 03:40:10 INFO - 'XPC_SERVICE_NAME': '0', 03:40:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:10 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:40:10 INFO - Cleaning up... 03:40:10 INFO - Return code: 0 03:40:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:40:10 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:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 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:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 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 0x109452b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109455768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9600d7e370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, '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.n1JLik25YD/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.rRJNi5FfiD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:40:10 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:40:10 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:40:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:10 INFO - 'HOME': '/Users/cltbld', 03:40:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:10 INFO - 'LOGNAME': 'cltbld', 03:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:10 INFO - 'MOZ_NO_REMOTE': '1', 03:40:10 INFO - 'NO_EM_RESTART': '1', 03:40:10 INFO - 'PAGER': '/bin/cat', 03:40:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:10 INFO - 'PWD': '/builds/slave/test', 03:40:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:10 INFO - 'SHELL': '/bin/bash', 03:40:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:10 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:10 INFO - 'USER': 'cltbld', 03:40:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:10 INFO - 'XPC_FLAGS': '0x0', 03:40:10 INFO - 'XPC_SERVICE_NAME': '0', 03:40:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:10 INFO - Downloading/unpacking psutil>=3.1.1 03:40:10 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:40:10 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:40:10 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:40:10 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:40:10 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:40:10 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:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:14 INFO - Installing collected packages: psutil 03:40:14 INFO - Running setup.py install for psutil 03:40:14 INFO - building 'psutil._psutil_osx' extension 03:40:14 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:40:15 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:40:15 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:40:15 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:40:15 INFO - building 'psutil._psutil_posix' extension 03:40:15 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:40:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:40:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:40:15 INFO - ^ 03:40:15 INFO - 1 warning generated. 03:40:15 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:40:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:15 INFO - Successfully installed psutil 03:40:15 INFO - Cleaning up... 03:40:15 INFO - Return code: 0 03:40:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:40: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:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:15 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 0x109452b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109455768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9600d7e370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, '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.n1JLik25YD/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.rRJNi5FfiD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:40:15 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:40:15 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:40:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:15 INFO - 'HOME': '/Users/cltbld', 03:40:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:15 INFO - 'LOGNAME': 'cltbld', 03:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:15 INFO - 'MOZ_NO_REMOTE': '1', 03:40:15 INFO - 'NO_EM_RESTART': '1', 03:40:15 INFO - 'PAGER': '/bin/cat', 03:40:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:15 INFO - 'PWD': '/builds/slave/test', 03:40:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:15 INFO - 'SHELL': '/bin/bash', 03:40:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:15 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:15 INFO - 'USER': 'cltbld', 03:40:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:15 INFO - 'XPC_FLAGS': '0x0', 03:40:15 INFO - 'XPC_SERVICE_NAME': '0', 03:40:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:40:15 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:40:15 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:40:15 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:40:15 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:40:15 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:40:15 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:40:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:40:19 INFO - Installing collected packages: mozsystemmonitor 03:40:19 INFO - Running setup.py install for mozsystemmonitor 03:40:19 INFO - Successfully installed mozsystemmonitor 03:40:19 INFO - Cleaning up... 03:40:19 INFO - Return code: 0 03:40:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:40:19 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:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:19 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:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:19 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 0x109452b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109455768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9600d7e370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, '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.n1JLik25YD/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.rRJNi5FfiD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:40:19 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:40:19 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:40:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:19 INFO - 'HOME': '/Users/cltbld', 03:40:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:19 INFO - 'LOGNAME': 'cltbld', 03:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:19 INFO - 'MOZ_NO_REMOTE': '1', 03:40:19 INFO - 'NO_EM_RESTART': '1', 03:40:19 INFO - 'PAGER': '/bin/cat', 03:40:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:19 INFO - 'PWD': '/builds/slave/test', 03:40:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:19 INFO - 'SHELL': '/bin/bash', 03:40:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:19 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:19 INFO - 'USER': 'cltbld', 03:40:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:19 INFO - 'XPC_FLAGS': '0x0', 03:40:19 INFO - 'XPC_SERVICE_NAME': '0', 03:40:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:19 INFO - Downloading/unpacking jsonschema==2.5.1 03:40:19 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:40:19 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:40:19 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:40:19 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:40:19 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:40:19 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:40:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:40:22 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:40:22 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:40:22 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:40:22 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:40:22 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:40:22 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:40:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:23 INFO - warning: no files found matching '*.txt' 03:40:23 INFO - no previously-included directories found matching 'build' 03:40:23 INFO - no previously-included directories found matching 'dist' 03:40:23 INFO - no previously-included directories found matching '.git*' 03:40:23 INFO - Installing collected packages: jsonschema, functools32 03:40:23 INFO - Running setup.py install for functools32 03:40:23 INFO - warning: no files found matching '*.txt' 03:40:23 INFO - no previously-included directories found matching 'build' 03:40:23 INFO - no previously-included directories found matching 'dist' 03:40:23 INFO - no previously-included directories found matching '.git*' 03:40:23 INFO - Successfully installed jsonschema functools32 03:40:23 INFO - Cleaning up... 03:40:23 INFO - Return code: 0 03:40:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:40:23 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:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:23 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:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:23 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 0x109452b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109455768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9600d7e370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, '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.n1JLik25YD/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.rRJNi5FfiD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:40:23 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:40:23 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:40:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:23 INFO - 'HOME': '/Users/cltbld', 03:40:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:23 INFO - 'LOGNAME': 'cltbld', 03:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:23 INFO - 'MOZ_NO_REMOTE': '1', 03:40:23 INFO - 'NO_EM_RESTART': '1', 03:40:23 INFO - 'PAGER': '/bin/cat', 03:40:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:23 INFO - 'PWD': '/builds/slave/test', 03:40:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:23 INFO - 'SHELL': '/bin/bash', 03:40:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:23 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:23 INFO - 'USER': 'cltbld', 03:40:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:23 INFO - 'XPC_FLAGS': '0x0', 03:40:23 INFO - 'XPC_SERVICE_NAME': '0', 03:40:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:40:23 INFO - Cleaning up... 03:40:23 INFO - Return code: 0 03:40:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40:23 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:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:23 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:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:23 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 0x109452b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109455768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9600d7e370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, '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.n1JLik25YD/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.rRJNi5FfiD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:40:23 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:40:23 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:40:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:23 INFO - 'HOME': '/Users/cltbld', 03:40:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:23 INFO - 'LOGNAME': 'cltbld', 03:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:23 INFO - 'MOZ_NO_REMOTE': '1', 03:40:23 INFO - 'NO_EM_RESTART': '1', 03:40:23 INFO - 'PAGER': '/bin/cat', 03:40:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:23 INFO - 'PWD': '/builds/slave/test', 03:40:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:23 INFO - 'SHELL': '/bin/bash', 03:40:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:23 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:23 INFO - 'USER': 'cltbld', 03:40:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:23 INFO - 'XPC_FLAGS': '0x0', 03:40:23 INFO - 'XPC_SERVICE_NAME': '0', 03:40:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:23 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:40:23 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:40:23 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:40:23 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:40:23 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:40:23 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:40:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40:26 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:40:26 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:40:26 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:40:26 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:40:26 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:40:26 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:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40: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:40: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:40: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:40: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:40: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:40: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:40:27 INFO - Downloading docopt-0.6.1.tar.gz 03:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:28 INFO - Running setup.py install for blobuploader 03:40:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:28 INFO - Running setup.py install for requests 03:40:28 INFO - Running setup.py install for docopt 03:40:28 INFO - Successfully installed blobuploader requests docopt 03:40:28 INFO - Cleaning up... 03:40:28 INFO - Return code: 0 03:40:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:28 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:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:28 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:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:28 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 0x109452b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109455768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9600d7e370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, '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.n1JLik25YD/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.rRJNi5FfiD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:40:28 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:40:28 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:40:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:28 INFO - 'HOME': '/Users/cltbld', 03:40:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:28 INFO - 'LOGNAME': 'cltbld', 03:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:28 INFO - 'MOZ_NO_REMOTE': '1', 03:40:28 INFO - 'NO_EM_RESTART': '1', 03:40:28 INFO - 'PAGER': '/bin/cat', 03:40:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:28 INFO - 'PWD': '/builds/slave/test', 03:40:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:28 INFO - 'SHELL': '/bin/bash', 03:40:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:28 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:28 INFO - 'USER': 'cltbld', 03:40:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:28 INFO - 'XPC_FLAGS': '0x0', 03:40:28 INFO - 'XPC_SERVICE_NAME': '0', 03:40:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:29 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-xskBB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:29 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-_zQCk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:29 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-Y0OSC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:29 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-fyvN_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:29 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-T8_XQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:29 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-wLp02u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:29 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-XMxEBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:29 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-XWEJeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:29 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-gqPcDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:30 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-Q3myrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:30 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-Wvkwp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:30 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-X7C_Bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:30 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-X7ggOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:30 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-8zyHvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:30 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-jqJGsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:30 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-GediWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:30 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-aV1fgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:30 INFO - Running setup.py install for manifestparser 03:40:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:31 INFO - Running setup.py install for mozcrash 03:40:31 INFO - Running setup.py install for mozdebug 03:40:31 INFO - Running setup.py install for mozdevice 03:40:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:31 INFO - Running setup.py install for mozfile 03:40:31 INFO - Running setup.py install for mozhttpd 03:40:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:31 INFO - Running setup.py install for mozinfo 03:40:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:31 INFO - Running setup.py install for mozInstall 03:40:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:32 INFO - Running setup.py install for mozleak 03:40:32 INFO - Running setup.py install for mozlog 03:40:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:32 INFO - Running setup.py install for moznetwork 03:40:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:32 INFO - Running setup.py install for mozprocess 03:40:32 INFO - Running setup.py install for mozprofile 03:40:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:32 INFO - Running setup.py install for mozrunner 03:40:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:33 INFO - Running setup.py install for mozscreenshot 03:40:33 INFO - Running setup.py install for moztest 03:40:33 INFO - Running setup.py install for mozversion 03:40:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:33 INFO - Cleaning up... 03:40:33 INFO - Return code: 0 03:40:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:33 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 0x109452b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109455768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9600d7e370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, '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.n1JLik25YD/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.rRJNi5FfiD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:40:33 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:40:33 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:40:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:33 INFO - 'HOME': '/Users/cltbld', 03:40:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:33 INFO - 'LOGNAME': 'cltbld', 03:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:33 INFO - 'MOZ_NO_REMOTE': '1', 03:40:33 INFO - 'NO_EM_RESTART': '1', 03:40:33 INFO - 'PAGER': '/bin/cat', 03:40:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:33 INFO - 'PWD': '/builds/slave/test', 03:40:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:33 INFO - 'SHELL': '/bin/bash', 03:40:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:33 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:33 INFO - 'USER': 'cltbld', 03:40:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:33 INFO - 'XPC_FLAGS': '0x0', 03:40:33 INFO - 'XPC_SERVICE_NAME': '0', 03:40:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:33 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-1CqHpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:33 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:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:33 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-4cPfEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:33 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:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:33 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-bs0Svt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-JFfHmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-hIHVmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-kfJ_zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-0aiaKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-jW1kmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-YvSx13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-F_kffM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-Rds4uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-dAYaaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-bwfsU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:35 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-ZXEbw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:35 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-nGD5C6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:35 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-FU_hJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:35 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-EyaSpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:35 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:40:35 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:40:35 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:40:35 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:40:35 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:40:35 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:40:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:35 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:40:35 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:40:35 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:40:35 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:40:35 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:40:35 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:40:38 INFO - Downloading blessings-1.6.tar.gz 03:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:38 INFO - Installing collected packages: blessings 03:40:38 INFO - Running setup.py install for blessings 03:40:38 INFO - Successfully installed blessings 03:40:38 INFO - Cleaning up... 03:40:38 INFO - Return code: 0 03:40:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:38 INFO - Reading from file tmpfile_stdout 03:40:38 INFO - Current package versions: 03:40:38 INFO - blessings == 1.6 03:40:38 INFO - blobuploader == 1.2.4 03:40:38 INFO - docopt == 0.6.1 03:40:38 INFO - functools32 == 3.2.3-2 03:40:38 INFO - jsonschema == 2.5.1 03:40:38 INFO - manifestparser == 1.1 03:40:38 INFO - mozInstall == 1.12 03:40:38 INFO - mozcrash == 1.0 03:40:38 INFO - mozdebug == 0.1 03:40:38 INFO - mozdevice == 0.50 03:40:38 INFO - mozfile == 1.2 03:40:38 INFO - mozhttpd == 0.7 03:40:38 INFO - mozinfo == 0.9 03:40:38 INFO - mozleak == 0.1 03:40:38 INFO - mozlog == 3.4 03:40:38 INFO - moznetwork == 0.27 03:40:38 INFO - mozprocess == 0.25 03:40:38 INFO - mozprofile == 0.28 03:40:38 INFO - mozrunner == 6.13 03:40:38 INFO - mozscreenshot == 0.1 03:40:38 INFO - mozsystemmonitor == 0.3 03:40:38 INFO - moztest == 0.8 03:40:38 INFO - mozversion == 1.4 03:40:38 INFO - psutil == 3.1.1 03:40:38 INFO - requests == 1.2.3 03:40:38 INFO - wsgiref == 0.1.2 03:40:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:38 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 0x109452b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109455768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9600d7e370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, '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.n1JLik25YD/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.rRJNi5FfiD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:40:38 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:40:38 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:40:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:38 INFO - 'HOME': '/Users/cltbld', 03:40:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:38 INFO - 'LOGNAME': 'cltbld', 03:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:38 INFO - 'MOZ_NO_REMOTE': '1', 03:40:38 INFO - 'NO_EM_RESTART': '1', 03:40:38 INFO - 'PAGER': '/bin/cat', 03:40:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:38 INFO - 'PWD': '/builds/slave/test', 03:40:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:38 INFO - 'SHELL': '/bin/bash', 03:40:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:38 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:38 INFO - 'USER': 'cltbld', 03:40:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:38 INFO - 'XPC_FLAGS': '0x0', 03:40:38 INFO - 'XPC_SERVICE_NAME': '0', 03:40:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:39 INFO - Cleaning up... 03:40:39 INFO - Return code: 0 03:40:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40: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:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109452b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109455768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9600d7e370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, '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.n1JLik25YD/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.rRJNi5FfiD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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:40: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', 'jsonschema'] in /builds/slave/test/build 03:40: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 jsonschema 03:40:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:39 INFO - 'HOME': '/Users/cltbld', 03:40:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:39 INFO - 'LOGNAME': 'cltbld', 03:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:39 INFO - 'MOZ_NO_REMOTE': '1', 03:40:39 INFO - 'NO_EM_RESTART': '1', 03:40:39 INFO - 'PAGER': '/bin/cat', 03:40:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:39 INFO - 'PWD': '/builds/slave/test', 03:40:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:39 INFO - 'SHELL': '/bin/bash', 03:40:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:39 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:39 INFO - 'USER': 'cltbld', 03:40:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:39 INFO - 'XPC_FLAGS': '0x0', 03:40:39 INFO - 'XPC_SERVICE_NAME': '0', 03:40:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:40:39 INFO - Cleaning up... 03:40:39 INFO - Return code: 0 03:40:39 INFO - Running post-action listener: _resource_record_post_action 03:40:39 INFO - Running post-action listener: _start_resource_monitoring 03:40:39 INFO - Starting resource monitoring. 03:40:39 INFO - [mozharness: 2017-04-28 10:40:39.412379Z] Finished create-virtualenv step (success) 03:40:39 INFO - [mozharness: 2017-04-28 10:40:39.413361Z] Running install step. 03:40:39 INFO - Running pre-action listener: _resource_record_pre_action 03:40:39 INFO - Running main action method: install 03:40:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:39 INFO - Reading from file tmpfile_stdout 03:40:39 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:39 INFO - Reading from file tmpfile_stdout 03:40:39 INFO - Output received: 03:40:39 INFO - Usage: mozinstall [options] installer 03:40:39 INFO - Options: 03:40:39 INFO - -h, --help show this help message and exit 03:40:39 INFO - -d DEST, --destination=DEST 03:40:39 INFO - Directory to install application into. [default: 03:40:39 INFO - "/builds/slave/test"] 03:40:39 INFO - --app=APP Application being installed. [default: firefox] 03:40:39 INFO - mkdir: /builds/slave/test/build/application 03:40:39 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:40:39 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:40:59 INFO - Reading from file tmpfile_stdout 03:40:59 INFO - Output received: 03:40:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:40:59 INFO - Running post-action listener: _resource_record_post_action 03:40:59 INFO - [mozharness: 2017-04-28 10:40:59.269370Z] Finished install step (success) 03:40:59 INFO - [mozharness: 2017-04-28 10:40:59.269491Z] Running run-tests step. 03:40:59 INFO - Running pre-action listener: _resource_record_pre_action 03:40:59 INFO - Running main action method: run_tests 03:40:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:40:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:40:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:40:59 INFO - 2017-04-28 03:40:59.283 screenresolution[1622:7391] starting screenresolution argv=screenresolution get 03:40:59 INFO - 2017-04-28 03:40:59.286 screenresolution[1622:7391] Display 0: 1600x1200x32@60 03:40:59 INFO - 2017-04-28 03:40:59.292 screenresolution[1623:7394] starting screenresolution argv=screenresolution list 03:40:59 INFO - Available Modes on Display 0 03:40:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:40:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:40:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:40:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:40:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:40:59 INFO - Intel Iris: 03:40:59 INFO - Chipset Model: Intel Iris 03:40:59 INFO - Type: GPU 03:40:59 INFO - Bus: Built-In 03:40:59 INFO - VRAM (Dynamic, Max): 1536 MB 03:40:59 INFO - Vendor: Intel (0x8086) 03:40:59 INFO - Device ID: 0x0a2e 03:40:59 INFO - Revision ID: 0x0009 03:40:59 INFO - Displays: 03:40:59 INFO - Display: 03:40:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:40:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:40:59 INFO - Display Serial Number: 1600x1200 60 03:40:59 INFO - Main Display: Yes 03:40:59 INFO - Mirror: Off 03:40:59 INFO - Online: Yes 03:40:59 INFO - Rotation: Supported 03:40:59 INFO - Return code: 0 03:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:59 INFO - Python 2.7.3 03:40:59 INFO - Return code: 0 03:40:59 INFO - grabbing minidump binary from tooltool 03:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:59 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 0x109230d30>, '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 0x109156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109225be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:59 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:40:59 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:40:59 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:40:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:59 INFO - Return code: 0 03:40:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:40:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:59 INFO - ENV: RUST_BACKTRACE is now 1 03:40:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:40:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:59 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/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--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:40:59 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/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0057 --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:40:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n1JLik25YD/Render', 03:40:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:59 INFO - 'HOME': '/Users/cltbld', 03:40:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:59 INFO - 'LOGNAME': 'cltbld', 03:40:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:59 INFO - 'MOZ_NO_REMOTE': '1', 03:40:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:59 INFO - 'NO_EM_RESTART': '1', 03:40:59 INFO - 'PAGER': '/bin/cat', 03:40:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:59 INFO - 'PWD': '/builds/slave/test', 03:40:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:59 INFO - 'RUST_BACKTRACE': '1', 03:40:59 INFO - 'SHELL': '/bin/bash', 03:40:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRJNi5FfiD/Listeners', 03:40:59 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 03:40:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:59 INFO - 'USER': 'cltbld', 03:40:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:59 INFO - 'XPC_FLAGS': '0x0', 03:40:59 INFO - 'XPC_SERVICE_NAME': '0', 03:40:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:59 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/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--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:40:59 INFO - mozversion application_buildid: 20170428014124 03:40:59 INFO - mozversion application_changeset: 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 03:40:59 INFO - mozversion application_display_name: Nightly 03:40:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:59 INFO - mozversion application_name: Firefox 03:40:59 INFO - mozversion application_remotingname: firefox 03:40:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:40:59 INFO - mozversion application_vendor: Mozilla 03:40:59 INFO - mozversion application_version: 55.0a1 03:40:59 INFO - mozversion platform_buildid: 20170428014124 03:40:59 INFO - mozversion platform_changeset: 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 03:40:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:40:59 INFO - mozversion platform_version: 55.0a1 03:40:59 INFO - using testdate: 1493376059 03:40:59 INFO - actual date: 1493376059 03:40:59 INFO - starting webserver on 'localhost:49229' 03:40:59 INFO - SUITE-START | Running 2 tests 03:40:59 INFO - TEST-START | dromaeo_css 03:40:59 INFO - operating with platform_type : mac_ 03:40:59 INFO - Initialising browser for dromaeo_css test... 03:40:59 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmp2CcpuQ/profile http://localhost:49229/getInfo.html) 03:41:02 INFO - PID 1633 | 2017-04-28 03:41:02.259 plugin-container[1635:7575] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9837, name = 'com.apple.tsm.portname' 03:41:02 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:41:02 INFO - PID 1633 | 2017-04-28 03:41:02.262 plugin-container[1635:7575] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 03:41:02 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:41:02 INFO - PID 1633 | 2017-04-28 03:41:02.262 plugin-container[1635:7575] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:41:02 INFO - PID 1633 | __metrics Screen width/height:1600/1200 03:41:02 INFO - PID 1633 | colorDepth:24 03:41:02 INFO - PID 1633 | Browser inner width/height: 1024/689 03:41:02 INFO - PID 1633 | __metrics 03:41:02 ERROR - PID 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 03:41:03 INFO - TEST-INFO | 1633: exit 0 03:41:03 INFO - Browser initialized. 03:41:03 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:03 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmp2CcpuQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:05 INFO - PID 1636 | 2017-04-28 03:41:05.550 plugin-container[1637:7712] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9337, name = 'com.apple.tsm.portname' 03:41:05 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:41:05 INFO - PID 1636 | 2017-04-28 03:41:05.551 plugin-container[1637:7712] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 03:41:05 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:41:05 INFO - PID 1636 | 2017-04-28 03:41:05.551 plugin-container[1637:7712] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:41:15 INFO - PID 1636 | RSS: Main: 250523648 03:41:15 INFO - PID 1636 | 03:44:19 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49229/tests/dromaeo/cssquery-ext.html) 03:44:21 INFO - PID 1636 | RSS: Main: 253734912 03:44:21 INFO - PID 1636 | 03:46:04 INFO - PID 1636 | ************************* 03:46:04 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 03:46:04 INFO - PID 1636 | 03:46:04 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:46:04 INFO - PID 1636 | Full stack: 03:46:04 INFO - PID 1636 | ************************* 03:46:04 INFO - PID 1636 | ************************* 03:46:04 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 03:46:04 INFO - PID 1636 | 03:46:04 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:46:04 INFO - PID 1636 | Full stack: 03:46:04 INFO - PID 1636 | ************************* 03:46:04 INFO - PID 1636 | ************************* 03:46:04 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 03:46:04 INFO - PID 1636 | 03:46:04 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:46:04 INFO - PID 1636 | Full stack: 03:46:04 INFO - PID 1636 | ************************* 03:46:04 INFO - PID 1636 | ************************* 03:46:04 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 03:46:04 INFO - PID 1636 | 03:46:04 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:46:04 INFO - PID 1636 | Full stack: 03:46:04 INFO - PID 1636 | ************************* 03:47:23 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-ext.html (next: http://localhost:49229/tests/dromaeo/cssquery-jquery.html) 03:47:23 INFO - PID 1636 | RSS: Main: 260091904 03:47:23 INFO - PID 1636 | 03:50:25 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49229/tests/dromaeo/cssquery-mootools.html) 03:50:26 INFO - PID 1636 | RSS: Main: 270766080 03:50:26 INFO - PID 1636 | 03:53:27 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49229/tests/dromaeo/cssquery-prototype.html) 03:53:28 INFO - PID 1636 | RSS: Main: 263229440 03:53:28 INFO - PID 1636 | 03:56:31 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49229/tests/dromaeo/cssquery-yui.html) 03:56:31 INFO - PID 1636 | RSS: Main: 272318464 03:56:31 INFO - PID 1636 | 03:59:33 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-yui.html (next: http://localhost:49229/tests/dromaeo/cssquery-dojo.html) 03:59:33 INFO - PID 1636 | RSS: Main: 267083776 03:59:33 INFO - PID 1636 | 03:59:33 INFO - PID 1636 | __start_tp_report 03:59:33 INFO - PID 1636 | _x_x_mozilla_page_load 03:59:33 INFO - PID 1636 | _x_x_mozilla_page_load_details 03:59:33 INFO - PID 1636 | |i|pagename|runs| 03:59:33 INFO - PID 1636 | |0;dojo.html;3136.6236051673804;3562.821858907054;3596.7841929484225;3607.6753092221693;3625.5286812714344;5891.175235467027;6137.9693101534485;6166.136740856273;6171.4445699887;6231.813045608639;6129.969350153243;6149.600275982058;6160.229971253593;6178.320384757673;6178.752849885999;5250.606204534656;5394.487523685244;5403.756830942597;5422.75597598108;5549.94551035304;5523.392426833045;5546.69493177875;5563.165525171236;5563.332400111992;5586.944130558703;5321.627486075976;5399.6490228135435;5448.210009548593;5478.780848766045;5498.862528436801;4918.975405122951;5067.847964561069;5349.732513374354;5423.430539793344;5509.146082357241;5372;5403.432639572828;5427.511523962823;5441.945580544183;5466.180072989044;5385.623006389555;5684.175794509814;6215.192025036761;6216.627002379872;6245.0320200369015;6389.6805159741825;6480.837979050514;6510.023496475566;6649.833754156137;6702.798916032527;6694.765683201064;6747.325267473262;6768.56004359715;6773.8983915241315;6778.694958726869;6279.4662453691035;6309.747610095591;6317.241930968267;6319.905201421982;6338.904916426257;6586.604803711697;6736.2590115087305;6918.37734603878;6939.514234003672;6963;6444.45222156122;6570.277269500351;6594.406503414716;6615.735370585123;6631.966840165768;6697.296783837724;6701.932980670228;6705.396514313735;6725.428338591177;6758.493113016543;6338.366163383717;6402.455791257796;6510.153680021567;6563.048357988065;6592.0111983202905;5267.604929630293;5369.865753356197;5923.644581325134;6654.13496245485;6660.134182556237;4417.757023363746;5272.973635131876;5288.629795914249;5311.920321195185;5324.733763311819;3667.94498082529;4706.388169537938;4725.527447255316;4726.196546587088;4736.8342108026745;6102.9437319708995;6146.968149961875;6337.176167098248;6362.872742545216;6409.294977552466;5620.606557541015;6761.628110453972;6768.593884366954;6804.047433359334;6814.931850681529;6317.1156038154695;6329.240491141092;6363.5863668861375;6368.490520758328;6372.58578192416;5622.522085622768;5679.971600141973;5705.229793977843;5714.657120572779;5726.341470730836;6870.9999999999;6954.826129346605;6955.1653801544135;6994.930050699428;7002.299770022957;6463.418292353711;6507.642079685663;6731.596104233761;6751.223609284995;6780;6807.659617019228;6932.272111428228;6957.686904089227;6992.685329160302;6993.650317484207;6407.16706828128;6474.287828338973;6570.474362050929;6611.669416529058;6652.201735791736;6248.4064013918605;6528.967355163194;6588.736450541925;6679.365460281266;6687.866242675022;5669.606020538947;6511.967440162769;6513.804585862432;6517.73929042833;6518.120053792677;6488.026795980641;6498.317676644074;6504.252011018793;6515.413612774873;6530.67346632676;5064.2403639452905;6099.268087829489;6287.308396076336;6342.460890824147;6352.015437607179;6470.126532918184;6544.574602650812;6569.24453687832;6570.11303474044;6611.834704132435;6366;6387.169667943138;6390.4248617624635;6402.03969404593;6439 03:59:33 INFO - PID 1636 | |1;ext.html;660.1615947746362;704.7498138160953;840.3781201910587;1198.5745060503516;1262.4382149943267;36257;37610.435843462335;37642.4353634695;37707.05732356692;37752.81123594382;37500.87497375083;37902.62097379025;37971.430428543594;38020.80989595048;38130;8047.879281810763;8203.425760196758;8363.83272334553;8548.914510854906;8608.698695545658;8611;8617.95691021544;8711.695090671828;8730.126987301282;8733.388662793606;7575.621218939059;8677.826443471127;8763.824723505526;8766.474011559296;8777;7415.258474152569;8692.739217823444;8699.695510657097;8706.956465217696;8707;8432.494050356998;8447.36644751646;8478.025027121897;8492.490450572985;8516.82966340676;30248.54627180594;37235.62764372376;37254.06864828374;37278.76327420336;37321.26787321273;3689.3728066228805;3728.5339332583426;3732.4401339798974;3734.9813250933844;3743.644353786386;30523.2369190772;30629.846850765603;30639.693603063908;30694.69305306963;30789.692103078905;3146.622405311354;3161.162291992624;3161.7944833585975;3189.378071276102;3192.984035079833;238877;241938.9673239205;262927;263448;283739;47953.76023119932;48251.75874120677;48254;48323;48389.516104839204;49846;49862.750686246334;50123.74938125286;50133.49866501361;50263.49736502588;14095.083819551697;14151.71696566063;14270.429182832571;14284.0001199915;14298.714025719428;11518.308901465938;11594.88405115955;11612;11621.883781162249;11624.593139240085;10899;13280.937524997977;13285.867141328656;13368;13410.12834165776;5055.6713813602;6033.064874944391;6037.486813620803;6062.181605483292;6093;1030.6753372687579;1032.2722480651123;1040.927135100551;1053.8840727519967;1065.3767545985531;20871.478213044797;21184.470388240417;23343.88328058383;24534.877325613616;24756.019518438483;1126.9661910142709;1127.7988941776982;1134.2627292260097;1176.9352685602203;1182.9408529573486;11673.94934455903;11744.882551174549;12463.376831158406;12607.180533265308;12690.11169218146;327250.5462308808;327838;327848;330618;331540;54016;54165.729171353894;54176.72911635417;54283.72858135684;54418.91162176814;1492.6492274315744;1498.048739050689;1533.8082739657543;1534.2098819108169;1553.122485795522;21471.46321341979;22557.43606409853;24320.148794792098;24391;24449.511009779348;30222.395552089274;36229.818850905576;37731.62268377281;37747.622523775506;37869.81065094657;292099;293508;294303;294739;295204;33099.84150554719;33270.66729332772;33499.665003349655;34635.4804677925;34900.77847275333;42055;45697.77151114223;45739;45783.54216457926;45835.3124703123;23895.880520597286;28409.147725568266;30908.74664912749;30930.53604195984;31726.841365793025;30005.849970750005;30021.399572008875;30582.388352232385;30901.227469313446;31096.844515777277;36647;36749;36903;36911.261774763814;36990.07524811794;29121.85439072791;30197.245068873453;30244.697553024187;30867.536986944764;31133.844330779106;23937.401564961016;24008.519829603658;24039;24357.756422436258;24454.87772561126 03:59:33 INFO - PID 1636 | |2;jquery.html;373.5013756634893;424.56057979990675;436.90169711814843;438.76087532294895;455.34885114286556;19995.400137995864;20845.791542084593;22230.444238894037;22460.989255483502;22489.775102248972;22736.77263227367;22936.541269174606;23491;23562;23645.935932883018;6027.367126451725;6223.5332350073695;6226.595271307373;6231.189945307104;6235.532335074865;5995.85010374742;6675.332466753334;7020.7191712331705;7085.539439936413;7120.572765634052;6885.173779146509;7035.226125126232;7100.147982242112;7103.147622285333;7132.750353737621;6865.313468653145;7065.328793764585;7124.3588077073055;7125.144982602095;7152.821179470503;6970;7040.119985001875;7042.471814613925;7065.2228254891925;7066.9646651766925;28469;29449.705502945126;29486.967956121433;29593.40813183746;29809.850950745324;2296.40293523685;2392.676988606533;2405.9398515037087;2406.1578447543393;2406.193925035115;17807.287708491775;18105;18854.81145188558;18881.622367552573;19163.23347066116;2271.5797577448225;2313.803326717231;2375.10933399975;2377.191754803358;2386.1886958434216;170766;172029;173936;174228.25771742247;174748;24686.876565617058;25338.366540836625;25487.74512254854;25659;25778.484430311288;42394.78802606029;42421;42443.7877810609;42645;42728.78635606802;8722.171393717586;8809.075047120088;9010.954945225232;9126;9158.81682366349;8453.957730211432;8587.613557389932;8645.654173833102;8760.91239087601;8768.386212965032;8020.318272946748;8131.7395803650525;8133.186681331819;8168.346532277404;8174.550399727953;2257.3566533537864;2258.4579700871673;2259.254446032838;2260.4348912771807;2420.4674971506242;918.8606128400735;957.2581249531529;960.9759756006156;989.2926557511414;1017.6183931025865;17359.826401736074;21357.25249616287;21693.132274708834;21830.563388732455;21886.35852311083;1006.5304655203485;1022.2180032275315;1023.2734758321675;1027.091024443358;1031.0771859185986;9839.770028746407;10232.181425485944;10649.9467502662;10948.34309941406;11012.50443730034;549550;555881;559103;565847;566075;135285;135678;139055;139623.30188348994;140202;1166.0548477650536;1181;1201.1351826684772;1201.765655697148;1205.891469767725;18483.537911552317;18605.255789768256;18622.441326760218;18712.25150993945;18961.810381896557;54854.90290194094;54872;55667.44332556622;56741;57183.71408142932;75786.24213757792;76434;77508.2249177501;78482.6075869617;78555.60722196352;8825.735227943173;8842.513661748666;8888.422252553562;9036.45781253127;9349.252059835333;14607.853921461074;14612.977091603485;14837.92581037088;14883;14891.404343826125;12025.759484810429;12149.210301330386;12324.137310388187;12332;12342.13605047674;9543;11542.653720388402;11692.766144677229;12025.699357516132;12066;11082.390468524309;12437.875621243671;12456.190347627375;12604.747905042032;12752.362381880683;8945.46327220369;9028.413153145024;9098.454092754191;9167.266618670357;9182.31132665066;10377;11972.102092342935;12260.632181034227;12352.75294494123;12357.876421235673 03:59:33 INFO - PID 1636 | |3;mootools.html;1281.692393825482;1421.9786703199447;1434.7130573885227;1438.0365155345917;1444.4583281269524;11335.149863760209;11554.19120661554;11859.881401185985;11946.283223006614;12153.574624888131;11608.59369922053;11878.990285825716;11899.524019039229;11904.880951190486;11916.34460104696;2154.6767984802327;2505.9874700626515;2540.4538024324766;2543.4150145466556;2557.2328301509565;2466.9136580219697;2495.588227942387;2506.6741323627903;2511.485145545168;2511.485145545168;2480.417101981033;2502.78726308264;2537.9873100634472;2544.0459827564664;2544.8727563621837;2447.596146635803;2476.6532685424145;2505.4237525369085;2511.7362676918933;2516.3834860459124;2393.0188622664623;2498.263012411343;2511.1713134665515;2514.371407148213;2517.773400393955;11738.589149379815;11833.526658933632;11859.881401185963;11859.940700296529;11862.347570883598;6611.404973552355;6823.624700641462;6856.897146542806;6864.347886950732;6864.4165245954155;3557.6442355764475;4095.9795201024103;4126.525449573308;4361.127774445092;4394.8901277468;1159.09590519395;1213.7875871722413;1261.8927391171762;1275.2284867655028;1315.4409376015155;13110.082294239408;13631.113977591524;16862.24119914607;16904.323827046905;16949.83050169495;5262.657927234717;5495.862603434946;5694.886102277931;5715.485606295453;5723.771049157987;12006;12091.214071085351;12103.697407564705;12107.878921210851;12134.211276267015;6089.48239399656;6514.706838192198;6584.703688334036;6585.769498067544;6594.7032383542855;5636.985342638364;6084.847878803065;6169.876602468015;6212.9068063979075;6217.906731399033;4108.77401742907;4182.665386769051;4398.428204333481;4431.844885429059;4479.283314669702;1267.6260503151593;1282.0897163014365;1299.3503248375812;1305.2233920817098;1305.8171855940177;786.7364432915037;797.8789800330545;803.9115697273295;812.9227723366271;834.5660256666499;6178;6197.1324014637985;6377.426031657081;6405.455536279375;6452.064450654629;562.1539582927668;592.7717828636006;607.0742118269674;611.7186094396627;626.223482881233;3287.7369810415107;3453.2057626745486;3954.6638535724787;4429.069895322018;4467.396901418267;13688.52090176839;15167;15210;15286.464973725866;15296.847031529765;14749.926250368893;14986.175760333286;15298.694026119416;15309.540713778604;15361;6690.899636505456;7560.130584982578;8693.608787604573;8782.033976262606;8823.382363234641;6584.637844918576;6777.423918966943;6914.619695916773;6922.27316131819;7144.071270734771;12274.877251227374;12769.489220431078;12819.294938778085;12881.8067728986;12948.482060717466;10461.424621645883;12938;12946.482140714266;13194.80207796903;13309.669033096612;8094.716684915999;8114.310283625958;8189.918100818915;8195.303399211134;8195.40189663034;10318.845217321896;10424.478776061318;10489.842652360374;10527.684169474927;10534.631287904887;8893.377463577488;8914.955425222832;9053.773655658399;9174.220191283815;9236.676716315165;8673.392862499564;8762.693305734269;8834.867476987722;8858;8889.333300002396;7978.162292959156;8038.557879316693;8130.146334634778;8137.924829168524;8366.456180348257;6058.666773327509;6093.664848433379;6157.538184636081;6170.444659980623;6269.811905642838;5996.310424301261;6224.128621993015;6283.3402492737605;6283.434490895658;6297.4647154992335 03:59:33 INFO - PID 1636 | |4;prototype.html;319.7505945362617;392.10991050315783;416.3026929892429;418.03225532891355;419.4463308432868;5933.258342707161;6061.333253342129;6113.449789518942;6201.379862013797;6219.533534984872;4737.384140061788;5948.375420580842;6008.699565021753;6078.483328917047;6107.816765497031;4629.055796565451;4636.281376386665;4646.674732768707;4658.953410465902;4678.298255261704;4494.528074552174;4662.650301227404;4669.8832529186875;4689.2966055091665;4737.289406589022;4135.524414692304;4168.791050595324;4649.8837529061875;4679.204535229019;4705.952940470603;3825.330567150765;3840.462335273036;4023.5574086850424;4678.812847486097;4685.1332503486965;3635.3456377851976;3778.5465744110606;4124.546299907008;4137.50349958004;4181.268278051329;4828.46886842447;5484.670919744788;5689.118186681071;5723.971380143114;6010.549208809357;4632.652551058684;5533.5849811263915;5592.972035139839;5596.6362186458155;5640.351359593658;6559.852025895497;6581.80254592363;6585.176852893388;6599.8550471096605;6653.53425260232;4396.406485124531;4772;4777.355057067286;4782.876024134325;4811.59101476375;5636;6922.896156557656;7010.964945175241;7052.929470705279;7087.184973728087;4297.67767417445;4857.344258525054;4858.319835223072;4872.512748725099;4900.044491324229;4862.82980095695;4952.925706114411;4978.5270399312;4982.352294201731;4993.300937868701;4941.4681448751;5276.577873770089;5495.093309603871;5528.778848846082;5620.91568626471;5393.6763794172475;6432.099506069154;6578.454063295122;6579.30917253691;6600.669966501751;1614.9838501615068;1653.5039488153507;1660.7508873668805;1686;1711.5977745229861;1082.7440169403453;1125.6960620632383;1161.8199179127248;1195.820626905971;1198.7712594590614;6140.385961403824;6142.477889379364;6170.56806023583;6187.876242475125;6188.319284878659;5828;6687.832804179837;6738.932610673928;6740.764073257413;6775.762848300285;4996.100701873697;5635.5623069927315;6197.442230199304;6266.373362663697;6277.372262773686;2962.9259268518026;3111.8372730952224;3286.967130328714;3517.4899639552123;3543.1850674345046;6143;6813.829654258683;7017.543859649107;7052.224255331909;7053.259407762213;6620.139381880324;6650.9667451662435;6888.862222755517;6924.93075069253;6994.160700715946;5975.760969561169;6223.471004964629;6426.485881129498;6995.475339349671;7042.22535521082;6739.58468721574;6802.455803535804;6840;6850.273311415108;6859.759908403182;6061.090836374579;6072.757089716361;6710.261871194262;6767.323267673193;6817;7002;7028.6134262614005;7047.753328633473;7051.753188638373;7108.751193708195;4184.267753143127;4269.701120921506;4315.201687687788;4329.4155289036835;4333.696641235083;6055.000924847527;6419.358064193543;6733.091032710521;6788.287229840993;6828.795136145924;6448.226212854487;6554.983977483497;6592.7033283503315;6611.371919667624;6620.437262832521;6526.836829079311;6530.249021362414;6534.7128505022865;6562.261000834878;6567.25967618591;5177.223416487557;5291.285676433632;6373.362663733589;6483.4164925156965;6488.059231411325;5156.510131537498;6383.202099737533;6537.378948999837;6540.247871494648;6584.209894812653;4958.8760280993265;5172.482751724948;5247.396549396715;5946.554008449297;6362.713677884599 03:59:33 INFO - PID 1636 | |5;yui.html;854.6538651846005;861.4185424838237;861.6984055580546;881.8491868112116;893.2541327991127;16594.83405165948;17376.56558586036;17467.737983930252;18221.36225232117;19758.30845920393;17852.01813900235;18096.457106286798;18156.092195390243;18462.63074738508;18493.81506184938;970.0832713086137;993.2401712689798;997.1524204426253;999.2355847776421;1011.8988101189896;964.7925695975364;997.1324947295863;999.4902599674145;1006;1041.5833666533372;1074.6023971130653;1085.6417382263835;1086.793509233247;1086.9293495922739;1087.3801932898252;1054.2830875005031;1075.8816530181673;1078.6440474643348;1078.7626722121122;1079.5250089960393;800.7877912353231;802.759172248329;804.9597520123971;805.5166899860037;811.8660421030523;16947.661046778994;17072.146392680315;17177.055261960588;17529.948203107855;17694.469165925042;16894.324227030906;17159.227834747468;17210.397636082802;17449.389271375567;17720.822791772047;13935.024548281624;14177.291135443187;14209.147451152963;14302.785458218135;14355.641108972359;3526.8589256429714;3532.0816587687127;3560.6795388414907;3562.340966921128;3569.696575791035;103398.89803305913;108164.99999999921;117869;118472.81527184704;120515;13231.536896208587;13376.59870203876;13429.529966451128;13490.797638035438;13505.864941350657;20518.58962820765;21767.455813604785;22230.777692223193;25291.735413229264;25619.487610248063;7802.024746906637;8026.9598652007535;8033.236842499953;8034.758957231293;8043.11525732169;3840.7503512271614;3841.7118716096406;3864.8260828262796;3898.1229223424502;3912.4326972588815;4270.594293542109;4309.655227581786;4370.191514569751;4392.3411488277015;4423.889402764957;885.9379843411028;910.3627460777482;925.1534845616186;928.034843762493;934.72425634438;615.8337248942761;661.652632368001;676.2426082787211;679.6329981809768;690.4855882367568;11165.553377864795;11980.520779168735;12071.57749478764;12123.818142727867;12334.876651233551;650.4713922282692;655.3282885042773;666.5900471210268;689.2797027106685;693.8889777635554;5399.676019438768;5620.409856965041;5636.098224284095;5647.858803529944;5726;96178;97009;97791;102678;112302.31546526808;90687;91530;93167;93900.53049734708;94935.52532237433;63819.680901595195;84222;84449;85918.71121933176;86154;10629.043386095289;11192.1605879561;11401.942990284995;12573.434195461408;12636.431360588611;41395.965100871515;41644.79177604214;41851.7907410461;41910.79044604758;41947.1610567793;40881;46404.07191856077;46950;54717;55128.72435637796;16078.678426431172;16281.837181628032;16588.921720088154;16615.916920415322;16681.165941702624;13818.654533636338;14639.341229644904;17760.3783867564;18027.72958405599;18589.907050464662;16525.421610243582;16622.836401451783;16629.91685041567;16706.49880503587;16945.49163525096;16222.35110595563;16730.996140231626;16738.246778894736;16868.240929158463;16874.578135546708;15737.606559835638;15835.683286333979;16490.34038638489;16588.917055414644;16634.667306654042;11585.478653460446;11629.302241865515;11729.941350293195;12310.26138431697;12332.506699732268;10608;11412.144089193509;13448.731025379633;13593;14249.572512824632 03:59:33 INFO - PID 1636 | __end_tp_report 03:59:33 INFO - PID 1636 | __start_cc_report 03:59:33 INFO - PID 1636 | _x_x_mozilla_cycle_collect,414 03:59:33 INFO - PID 1636 | __end_cc_report 03:59:33 INFO - PID 1636 | __startTimestamp1493377173844__endTimestamp 03:59:33 INFO - PID 1636 | 03:59:33 INFO - PID 1636 | ------- Summary: start ------- 03:59:33 INFO - PID 1636 | Number of tests: 6 03:59:33 INFO - PID 1636 | 03:59:33 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6089.41 Median:6362.87 stddev:767.44 (12.1%) stddev-sans-first:734.00 03:59:33 INFO - PID 1636 | Values: 3136.6 3562.8 3596.8 3607.7 3625.5 5891.2 6138.0 6166.1 6171.4 6231.8 6130.0 6149.6 6160.2 6178.3 6178.8 5250.6 5394.5 5403.8 5422.8 5549.9 5523.4 5546.7 5563.2 5563.3 5586.9 5321.6 5399.6 5448.2 5478.8 5498.9 4919.0 5067.8 5349.7 5423.4 5509.1 5372.0 5403.4 5427.5 5441.9 5466.2 5385.6 5684.2 6215.2 6216.6 6245.0 6389.7 6480.8 6510.0 6649.8 6702.8 6694.8 6747.3 6768.6 6773.9 6778.7 6279.5 6309.7 6317.2 6319.9 6338.9 6586.6 6736.3 6918.4 6939.5 6963.0 6444.5 6570.3 6594.4 6615.7 6632.0 6697.3 6701.9 6705.4 6725.4 6758.5 6338.4 6402.5 6510.2 6563.0 6592.0 5267.6 5369.9 5923.6 6654.1 6660.1 4417.8 5273.0 5288.6 5311.9 5324.7 3667.9 4706.4 4725.5 4726.2 4736.8 6102.9 6147.0 6337.2 6362.9 6409.3 5620.6 6761.6 6768.6 6804.0 6814.9 6317.1 6329.2 6363.6 6368.5 6372.6 5622.5 5680.0 5705.2 5714.7 5726.3 6871.0 6954.8 6955.2 6994.9 7002.3 6463.4 6507.6 6731.6 6751.2 6780.0 6807.7 6932.3 6957.7 6992.7 6993.7 6407.2 6474.3 6570.5 6611.7 6652.2 6248.4 6529.0 6588.7 6679.4 6687.9 5669.6 6512.0 6513.8 6517.7 6518.1 6488.0 6498.3 6504.3 6515.4 6530.7 5064.2 6099.3 6287.3 6342.5 6352.0 6470.1 6544.6 6569.2 6570.1 6611.8 6366.0 6387.2 6390.4 6402.0 6439.0 03:59:33 INFO - PID 1636 | 03:59:33 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:44402.92 Median:327843.00 stddev:77451.40 (23.6%) stddev-sans-first:77599.04 03:59:33 INFO - PID 1636 | Values: 660.2 704.7 840.4 1198.6 1262.4 36257.0 37610.4 37642.4 37707.1 37752.8 37500.9 37902.6 37971.4 38020.8 38130.0 8047.9 8203.4 8363.8 8548.9 8608.7 8611.0 8618.0 8711.7 8730.1 8733.4 7575.6 8677.8 8763.8 8766.5 8777.0 7415.3 8692.7 8699.7 8707.0 8707.0 8432.5 8447.4 8478.0 8492.5 8516.8 30248.5 37235.6 37254.1 37278.8 37321.3 3689.4 3728.5 3732.4 3735.0 3743.6 30523.2 30629.8 30639.7 30694.7 30789.7 3146.6 3161.2 3161.8 3189.4 3193.0 238877.0 241939.0 262927.0 263448.0 283739.0 47953.8 48251.8 48254.0 48323.0 48389.5 49846.0 49862.8 50123.7 50133.5 50263.5 14095.1 14151.7 14270.4 14284.0 14298.7 11518.3 11594.9 11612.0 11621.9 11624.6 10899.0 13280.9 13285.9 13368.0 13410.1 5055.7 6033.1 6037.5 6062.2 6093.0 1030.7 1032.3 1040.9 1053.9 1065.4 20871.5 21184.5 23343.9 24534.9 24756.0 1127.0 1127.8 1134.3 1176.9 1182.9 11673.9 11744.9 12463.4 12607.2 12690.1 327250.5 327838.0 327848.0 330618.0 331540.0 54016.0 54165.7 54176.7 54283.7 54418.9 1492.6 1498.0 1533.8 1534.2 1553.1 21471.5 22557.4 24320.1 24391.0 24449.5 30222.4 36229.8 37731.6 37747.6 37869.8 292099.0 293508.0 294303.0 294739.0 295204.0 33099.8 33270.7 33499.7 34635.5 34900.8 42055.0 45697.8 45739.0 45783.5 45835.3 23895.9 28409.1 30908.7 30930.5 31726.8 30005.8 30021.4 30582.4 30901.2 31096.8 36647.0 36749.0 36903.0 36911.3 36990.1 29121.9 30197.2 30244.7 30867.5 31133.8 23937.4 24008.5 24039.0 24357.8 24454.9 03:59:33 INFO - PID 1636 | 03:59:33 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:37928.87 Median:25413.06 stddev:95452.13 (375.6%) stddev-sans-first:95678.25 03:59:33 INFO - PID 1636 | Values: 373.5 424.6 436.9 438.8 455.3 19995.4 20845.8 22230.4 22461.0 22489.8 22736.8 22936.5 23491.0 23562.0 23645.9 6027.4 6223.5 6226.6 6231.2 6235.5 5995.9 6675.3 7020.7 7085.5 7120.6 6885.2 7035.2 7100.1 7103.1 7132.8 6865.3 7065.3 7124.4 7125.1 7152.8 6970.0 7040.1 7042.5 7065.2 7067.0 28469.0 29449.7 29487.0 29593.4 29809.9 2296.4 2392.7 2405.9 2406.2 2406.2 17807.3 18105.0 18854.8 18881.6 19163.2 2271.6 2313.8 2375.1 2377.2 2386.2 170766.0 172029.0 173936.0 174228.3 174748.0 24686.9 25338.4 25487.7 25659.0 25778.5 42394.8 42421.0 42443.8 42645.0 42728.8 8722.2 8809.1 9011.0 9126.0 9158.8 8454.0 8587.6 8645.7 8760.9 8768.4 8020.3 8131.7 8133.2 8168.3 8174.6 2257.4 2258.5 2259.3 2260.4 2420.5 918.9 957.3 961.0 989.3 1017.6 17359.8 21357.3 21693.1 21830.6 21886.4 1006.5 1022.2 1023.3 1027.1 1031.1 9839.8 10232.2 10649.9 10948.3 11012.5 549550.0 555881.0 559103.0 565847.0 566075.0 135285.0 135678.0 139055.0 139623.3 140202.0 1166.1 1181.0 1201.1 1201.8 1205.9 18483.5 18605.3 18622.4 18712.3 18961.8 54854.9 54872.0 55667.4 56741.0 57183.7 75786.2 76434.0 77508.2 78482.6 78555.6 8825.7 8842.5 8888.4 9036.5 9349.3 14607.9 14613.0 14837.9 14883.0 14891.4 12025.8 12149.2 12324.1 12332.0 12342.1 9543.0 11542.7 11692.8 12025.7 12066.0 11082.4 12437.9 12456.2 12604.7 12752.4 8945.5 9028.4 9098.5 9167.3 9182.3 10377.0 11972.1 12260.6 12352.8 12357.9 03:59:33 INFO - PID 1636 | 03:59:33 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:6993.05 Median:3370.47 stddev:4415.75 (131.0%) stddev-sans-first:4407.28 03:59:33 INFO - PID 1636 | Values: 1281.7 1422.0 1434.7 1438.0 1444.5 11335.1 11554.2 11859.9 11946.3 12153.6 11608.6 11879.0 11899.5 11904.9 11916.3 2154.7 2506.0 2540.5 2543.4 2557.2 2466.9 2495.6 2506.7 2511.5 2511.5 2480.4 2502.8 2538.0 2544.0 2544.9 2447.6 2476.7 2505.4 2511.7 2516.4 2393.0 2498.3 2511.2 2514.4 2517.8 11738.6 11833.5 11859.9 11859.9 11862.3 6611.4 6823.6 6856.9 6864.3 6864.4 3557.6 4096.0 4126.5 4361.1 4394.9 1159.1 1213.8 1261.9 1275.2 1315.4 13110.1 13631.1 16862.2 16904.3 16949.8 5262.7 5495.9 5694.9 5715.5 5723.8 12006.0 12091.2 12103.7 12107.9 12134.2 6089.5 6514.7 6584.7 6585.8 6594.7 5637.0 6084.8 6169.9 6212.9 6217.9 4108.8 4182.7 4398.4 4431.8 4479.3 1267.6 1282.1 1299.4 1305.2 1305.8 786.7 797.9 803.9 812.9 834.6 6178.0 6197.1 6377.4 6405.5 6452.1 562.2 592.8 607.1 611.7 626.2 3287.7 3453.2 3954.7 4429.1 4467.4 13688.5 15167.0 15210.0 15286.5 15296.8 14749.9 14986.2 15298.7 15309.5 15361.0 6690.9 7560.1 8693.6 8782.0 8823.4 6584.6 6777.4 6914.6 6922.3 7144.1 12274.9 12769.5 12819.3 12881.8 12948.5 10461.4 12938.0 12946.5 13194.8 13309.7 8094.7 8114.3 8189.9 8195.3 8195.4 10318.8 10424.5 10489.8 10527.7 10534.6 8893.4 8915.0 9053.8 9174.2 9236.7 8673.4 8762.7 8834.9 8858.0 8889.3 7978.2 8038.6 8130.1 8137.9 8366.5 6058.7 6093.7 6157.5 6170.4 6269.8 5996.3 6224.1 6283.3 6283.4 6297.5 03:59:33 INFO - PID 1636 | 03:59:33 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5320.40 Median:5880.63 stddev:1634.68 (27.8%) stddev-sans-first:1595.59 03:59:33 INFO - PID 1636 | Values: 319.8 392.1 416.3 418.0 419.4 5933.3 6061.3 6113.4 6201.4 6219.5 4737.4 5948.4 6008.7 6078.5 6107.8 4629.1 4636.3 4646.7 4659.0 4678.3 4494.5 4662.7 4669.9 4689.3 4737.3 4135.5 4168.8 4649.9 4679.2 4706.0 3825.3 3840.5 4023.6 4678.8 4685.1 3635.3 3778.5 4124.5 4137.5 4181.3 4828.5 5484.7 5689.1 5724.0 6010.5 4632.7 5533.6 5593.0 5596.6 5640.4 6559.9 6581.8 6585.2 6599.9 6653.5 4396.4 4772.0 4777.4 4782.9 4811.6 5636.0 6922.9 7011.0 7052.9 7087.2 4297.7 4857.3 4858.3 4872.5 4900.0 4862.8 4952.9 4978.5 4982.4 4993.3 4941.5 5276.6 5495.1 5528.8 5620.9 5393.7 6432.1 6578.5 6579.3 6600.7 1615.0 1653.5 1660.8 1686.0 1711.6 1082.7 1125.7 1161.8 1195.8 1198.8 6140.4 6142.5 6170.6 6187.9 6188.3 5828.0 6687.8 6738.9 6740.8 6775.8 4996.1 5635.6 6197.4 6266.4 6277.4 2962.9 3111.8 3287.0 3517.5 3543.2 6143.0 6813.8 7017.5 7052.2 7053.3 6620.1 6651.0 6888.9 6924.9 6994.2 5975.8 6223.5 6426.5 6995.5 7042.2 6739.6 6802.5 6840.0 6850.3 6859.8 6061.1 6072.8 6710.3 6767.3 6817.0 7002.0 7028.6 7047.8 7051.8 7108.8 4184.3 4269.7 4315.2 4329.4 4333.7 6055.0 6419.4 6733.1 6788.3 6828.8 6448.2 6555.0 6592.7 6611.4 6620.4 6526.8 6530.2 6534.7 6562.3 6567.3 5177.2 5291.3 6373.4 6483.4 6488.1 5156.5 6383.2 6537.4 6540.2 6584.2 4958.9 5172.5 5247.4 5946.6 6362.7 03:59:33 INFO - PID 1636 | 03:59:33 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:21245.95 Median:18342.00 stddev:29267.32 (159.6%) stddev-sans-first:29309.37 03:59:33 INFO - PID 1636 | Values: 854.7 861.4 861.7 881.8 893.3 16594.8 17376.6 17467.7 18221.4 19758.3 17852.0 18096.5 18156.1 18462.6 18493.8 970.1 993.2 997.2 999.2 1011.9 964.8 997.1 999.5 1006.0 1041.6 1074.6 1085.6 1086.8 1086.9 1087.4 1054.3 1075.9 1078.6 1078.8 1079.5 800.8 802.8 805.0 805.5 811.9 16947.7 17072.1 17177.1 17529.9 17694.5 16894.3 17159.2 17210.4 17449.4 17720.8 13935.0 14177.3 14209.1 14302.8 14355.6 3526.9 3532.1 3560.7 3562.3 3569.7 103398.9 108165.0 117869.0 118472.8 120515.0 13231.5 13376.6 13429.5 13490.8 13505.9 20518.6 21767.5 22230.8 25291.7 25619.5 7802.0 8027.0 8033.2 8034.8 8043.1 3840.8 3841.7 3864.8 3898.1 3912.4 4270.6 4309.7 4370.2 4392.3 4423.9 885.9 910.4 925.2 928.0 934.7 615.8 661.7 676.2 679.6 690.5 11165.6 11980.5 12071.6 12123.8 12334.9 650.5 655.3 666.6 689.3 693.9 5399.7 5620.4 5636.1 5647.9 5726.0 96178.0 97009.0 97791.0 102678.0 112302.3 90687.0 91530.0 93167.0 93900.5 94935.5 63819.7 84222.0 84449.0 85918.7 86154.0 10629.0 11192.2 11401.9 12573.4 12636.4 41396.0 41644.8 41851.8 41910.8 41947.2 40881.0 46404.1 46950.0 54717.0 55128.7 16078.7 16281.8 16588.9 16615.9 16681.2 13818.7 14639.3 17760.4 18027.7 18589.9 16525.4 16622.8 16629.9 16706.5 16945.5 16222.4 16731.0 16738.2 16868.2 16874.6 15737.6 15835.7 16490.3 16588.9 16634.7 11585.5 11629.3 11729.9 12310.3 12332.5 10608.0 11412.1 13448.7 13593.0 14249.6 03:59:33 INFO - PID 1636 | -------- Summary: end -------- 03:59:33 INFO - PID 1636 | 03:59:34 INFO - TEST-INFO | 1636: exit 0 03:59:34 INFO - TEST-OK | dromaeo_css | took 1114608ms 03:59:34 INFO - TEST-START | kraken 03:59:34 INFO - operating with platform_type : mac_ 03:59:34 INFO - Initialising browser for kraken test... 03:59:34 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmpjcvA79/profile http://localhost:49229/getInfo.html) 03:59:36 INFO - PID 1652 | 2017-04-28 03:59:36.786 plugin-container[1653:10181] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923b, name = 'com.apple.tsm.portname' 03:59:36 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:36 INFO - PID 1652 | 2017-04-28 03:59:36.789 plugin-container[1653:10181] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9613, name = 'com.apple.CFPasteboardClient' 03:59:36 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:36 INFO - PID 1652 | 2017-04-28 03:59:36.789 plugin-container[1653:10181] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:59:37 INFO - PID 1652 | __metrics Screen width/height:1600/1200 03:59:37 INFO - PID 1652 | colorDepth:24 03:59:37 INFO - PID 1652 | Browser inner width/height: 1024/689 03:59:37 INFO - PID 1652 | __metrics 03:59:37 ERROR - PID 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 03:59:38 INFO - TEST-INFO | 1652: exit 0 03:59:38 INFO - Browser initialized. 03:59:38 INFO - Running cycle 1/1 for kraken test... 03:59:38 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmpjcvA79/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:40 INFO - PID 1654 | 2017-04-28 03:59:40.145 plugin-container[1655:10304] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 03:59:40 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:40 INFO - PID 1654 | 2017-04-28 03:59:40.146 plugin-container[1655:10304] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970f, name = 'com.apple.CFPasteboardClient' 03:59:40 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:40 INFO - PID 1654 | 2017-04-28 03:59:40.146 plugin-container[1655:10304] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:59:50 INFO - PID 1654 | RSS: Main: 252145664 03:59:50 INFO - PID 1654 | 03:59:52 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:53 INFO - PID 1654 | RSS: Main: 259674112 03:59:53 INFO - PID 1654 | 03:59:56 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-dft) 03:59:57 INFO - PID 1654 | RSS: Main: 266756096 03:59:57 INFO - PID 1654 | 04:00:00 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-fft) 04:00:01 INFO - PID 1654 | RSS: Main: 263188480 04:00:01 INFO - PID 1654 | 04:00:03 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator) 04:00:03 INFO - PID 1654 | RSS: Main: 265064448 04:00:03 INFO - PID 1654 | 04:00:05 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:06 INFO - PID 1654 | RSS: Main: 265846784 04:00:06 INFO - PID 1654 | 04:00:09 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:10 INFO - PID 1654 | RSS: Main: 271060992 04:00:10 INFO - PID 1654 | 04:00:13 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:13 INFO - PID 1654 | RSS: Main: 272871424 04:00:13 INFO - PID 1654 | 04:00:16 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial) 04:00:17 INFO - PID 1654 | RSS: Main: 272064512 04:00:17 INFO - PID 1654 | 04:00:18 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:19 INFO - PID 1654 | RSS: Main: 271740928 04:00:19 INFO - PID 1654 | 04:00:20 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:21 INFO - PID 1654 | RSS: Main: 271974400 04:00:21 INFO - PID 1654 | 04:00:23 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:24 INFO - PID 1654 | RSS: Main: 271446016 04:00:24 INFO - PID 1654 | 04:00:27 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:28 INFO - PID 1654 | RSS: Main: 271380480 04:00:28 INFO - PID 1654 | 04:00:31 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:31 INFO - PID 1654 | RSS: Main: 271597568 04:00:31 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49229/tests/kraken/driver.html?testName=ai-astar) 04:00:33 INFO - PID 1654 | RSS: Main: 273604608 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | __start_tp_report 04:00:33 INFO - PID 1654 | _x_x_mozilla_page_load 04:00:33 INFO - PID 1654 | _x_x_mozilla_page_load_details 04:00:33 INFO - PID 1654 | |i|pagename|runs| 04:00:33 INFO - PID 1654 | |0;ai-astar;101;115;112;113;114;112;113;113;115;111 04:00:33 INFO - PID 1654 | |1;audio-beat-detection;143;109;105;157;93;129;147;146;138;116 04:00:33 INFO - PID 1654 | |2;audio-dft;198;188;189;262;265;287;269;200;200;197 04:00:33 INFO - PID 1654 | |3;audio-fft;80;59;69;82;60;82;87;82;77;57 04:00:33 INFO - PID 1654 | |4;audio-oscillator;89;71;84;70;68;72;96;105;65;117 04:00:33 INFO - PID 1654 | |5;imaging-gaussian-blur;88;88;88;88;91;88;87;122;137;94 04:00:33 INFO - PID 1654 | |6;imaging-darkroom;107;97;96;97;96;96;114;119;96;97 04:00:33 INFO - PID 1654 | |7;imaging-desaturate;91;93;96;90;93;90;88;93;90;91 04:00:33 INFO - PID 1654 | |8;json-parse-financial;52;50;48;50;51;52;51;52;50;49 04:00:33 INFO - PID 1654 | |9;json-stringify-tinderbox;56;55;60;60;60;59;56;58;58;58 04:00:33 INFO - PID 1654 | |10;stanford-crypto-aes;84;85;102;77;76;107;74;82;78;77 04:00:33 INFO - PID 1654 | |11;stanford-crypto-ccm;137;157;161;139;143;155;152;157;202;157 04:00:33 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;192;188;188;182;188;186;203;184;186;185 04:00:33 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;68;70;71;70;70;76;66;68;69;66 04:00:33 INFO - PID 1654 | __end_tp_report 04:00:33 INFO - PID 1654 | __start_cc_report 04:00:33 INFO - PID 1654 | _x_x_mozilla_cycle_collect,996 04:00:33 INFO - PID 1654 | __end_cc_report 04:00:33 INFO - PID 1654 | __startTimestamp1493377233696__endTimestamp 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | ------- Summary: start ------- 04:00:33 INFO - PID 1654 | Number of tests: 14 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:4.04 (3.6%) stddev-sans-first:1.36 04:00:33 INFO - PID 1654 | Values: 101.0 115.0 112.0 113.0 114.0 112.0 113.0 113.0 115.0 111.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:144.50 stddev:21.37 (14.8%) stddev-sans-first:21.99 04:00:33 INFO - PID 1654 | Values: 143.0 109.0 105.0 157.0 93.0 129.0 147.0 146.0 138.0 116.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:225.50 Median:231.00 stddev:39.69 (17.2%) stddev-sans-first:40.83 04:00:33 INFO - PID 1654 | Values: 198.0 188.0 189.0 262.0 265.0 287.0 269.0 200.0 200.0 197.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:73.50 Median:81.00 stddev:11.25 (13.9%) stddev-sans-first:11.68 04:00:33 INFO - PID 1654 | Values: 80.0 59.0 69.0 82.0 60.0 82.0 87.0 82.0 77.0 57.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:71.50 stddev:17.71 (24.8%) stddev-sans-first:18.68 04:00:33 INFO - PID 1654 | Values: 89.0 71.0 84.0 70.0 68.0 72.0 96.0 105.0 65.0 117.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:97.10 Median:88.00 stddev:17.56 (20.0%) stddev-sans-first:18.31 04:00:33 INFO - PID 1654 | Values: 88.0 88.0 88.0 88.0 91.0 88.0 87.0 122.0 137.0 94.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:101.50 Median:96.00 stddev:8.66 (9.0%) stddev-sans-first:8.95 04:00:33 INFO - PID 1654 | Values: 107.0 97.0 96.0 97.0 96.0 96.0 114.0 119.0 96.0 97.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:91.50 Median:92.00 stddev:2.27 (2.5%) stddev-sans-first:2.40 04:00:33 INFO - PID 1654 | Values: 91.0 93.0 96.0 90.0 93.0 90.0 88.0 93.0 90.0 91.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:1.35 (2.7%) stddev-sans-first:1.32 04:00:33 INFO - PID 1654 | Values: 52.0 50.0 48.0 50.0 51.0 52.0 51.0 52.0 50.0 49.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.50 stddev:1.83 (3.1%) stddev-sans-first:1.79 04:00:33 INFO - PID 1654 | Values: 56.0 55.0 60.0 60.0 60.0 59.0 56.0 58.0 58.0 58.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:77.50 stddev:11.33 (14.6%) stddev-sans-first:12.02 04:00:33 INFO - PID 1654 | Values: 84.0 85.0 102.0 77.0 76.0 107.0 74.0 82.0 78.0 77.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:156.00 Median:157.00 stddev:18.20 (11.6%) stddev-sans-first:17.95 04:00:33 INFO - PID 1654 | Values: 137.0 157.0 161.0 139.0 143.0 155.0 152.0 157.0 202.0 157.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.20 Median:188.00 stddev:5.87 (3.1%) stddev-sans-first:6.06 04:00:33 INFO - PID 1654 | Values: 192.0 188.0 188.0 182.0 188.0 186.0 203.0 184.0 186.0 185.0 04:00:33 INFO - PID 1654 | 04:00:33 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:2.88 (4.1%) stddev-sans-first:3.00 04:00:33 INFO - PID 1654 | Values: 68.0 70.0 71.0 70.0 70.0 76.0 66.0 68.0 69.0 66.0 04:00:33 INFO - PID 1654 | -------- Summary: end -------- 04:00:33 INFO - PID 1654 | 04:00:34 INFO - TEST-INFO | 1654: exit 0 04:00:34 INFO - TEST-OK | kraken | took 60271ms 04:00:34 INFO - SUITE-END | took 1174s 04:00:34 INFO - Completed test suite (00:19:34) 04:00:34 INFO - javascript benchmark 04:00:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7961.4100493218275, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.6236051673804, 3562.821858907054, 3596.7841929484225, 3607.6753092221693, 3625.5286812714344, 5891.175235467027, 6137.9693101534485, 6166.136740856273, 6171.4445699887, 6231.813045608639, 6129.969350153243, 6149.600275982058, 6160.229971253593, 6178.320384757673, 6178.752849885999, 5250.606204534656, 5394.487523685244, 5403.756830942597, 5422.75597598108, 5549.94551035304, 5523.392426833045, 5546.69493177875, 5563.165525171236, 5563.332400111992, 5586.944130558703, 5321.627486075976, 5399.6490228135435, 5448.210009548593, 5478.780848766045, 5498.862528436801, 4918.975405122951, 5067.847964561069, 5349.732513374354, 5423.430539793344, 5509.146082357241, 5372.0, 5403.432639572828, 5427.511523962823, 5441.945580544183, 5466.180072989044, 5385.623006389555, 5684.175794509814, 6215.192025036761, 6216.627002379872, 6245.0320200369015, 6389.6805159741825, 6480.837979050514, 6510.023496475566, 6649.833754156137, 6702.798916032527, 6694.765683201064, 6747.325267473262, 6768.56004359715, 6773.8983915241315, 6778.694958726869, 6279.4662453691035, 6309.747610095591, 6317.241930968267, 6319.905201421982, 6338.904916426257, 6586.604803711697, 6736.2590115087305, 6918.37734603878, 6939.514234003672, 6963.0, 6444.45222156122, 6570.277269500351, 6594.406503414716, 6615.735370585123, 6631.966840165768, 6697.296783837724, 6701.932980670228, 6705.396514313735, 6725.428338591177, 6758.493113016543, 6338.366163383717, 6402.455791257796, 6510.153680021567, 6563.048357988065, 6592.0111983202905, 5267.604929630293, 5369.865753356197, 5923.644581325134, 6654.13496245485, 6660.134182556237, 4417.757023363746, 5272.973635131876, 5288.629795914249, 5311.920321195185, 5324.733763311819, 3667.94498082529, 4706.388169537938, 4725.527447255316, 4726.196546587088, 4736.8342108026745, 6102.9437319708995, 6146.968149961875, 6337.176167098248, 6362.872742545216, 6409.294977552466, 5620.606557541015, 6761.628110453972, 6768.593884366954, 6804.047433359334, 6814.931850681529, 6317.1156038154695, 6329.240491141092, 6363.5863668861375, 6368.490520758328, 6372.58578192416, 5622.522085622768, 5679.971600141973, 5705.229793977843, 5714.657120572779, 5726.341470730836, 6870.9999999999, 6954.826129346605, 6955.1653801544135, 6994.930050699428, 7002.299770022957, 6463.418292353711, 6507.642079685663, 6731.596104233761, 6751.223609284995, 6780.0, 6807.659617019228, 6932.272111428228, 6957.686904089227, 6992.685329160302, 6993.650317484207, 6407.16706828128, 6474.287828338973, 6570.474362050929, 6611.669416529058, 6652.201735791736, 6248.4064013918605, 6528.967355163194, 6588.736450541925, 6679.365460281266, 6687.866242675022, 5669.606020538947, 6511.967440162769, 6513.804585862432, 6517.73929042833, 6518.120053792677, 6488.026795980641, 6498.317676644074, 6504.252011018793, 6515.413612774873, 6530.67346632676, 5064.2403639452905, 6099.268087829489, 6287.308396076336, 6342.460890824147, 6352.015437607179, 6470.126532918184, 6544.574602650812, 6569.24453687832, 6570.11303474044, 6611.834704132435, 6366.0, 6387.169667943138, 6390.4248617624635, 6402.03969404593, 6439.0], "value": 6037.264192253334, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.1615947746362, 704.7498138160953, 840.3781201910587, 1198.5745060503516, 1262.4382149943267, 36257.0, 37610.435843462335, 37642.4353634695, 37707.05732356692, 37752.81123594382, 37500.87497375083, 37902.62097379025, 37971.430428543594, 38020.80989595048, 38130.0, 8047.879281810763, 8203.425760196758, 8363.83272334553, 8548.914510854906, 8608.698695545658, 8611.0, 8617.95691021544, 8711.695090671828, 8730.126987301282, 8733.388662793606, 7575.621218939059, 8677.826443471127, 8763.824723505526, 8766.474011559296, 8777.0, 7415.258474152569, 8692.739217823444, 8699.695510657097, 8706.956465217696, 8707.0, 8432.494050356998, 8447.36644751646, 8478.025027121897, 8492.490450572985, 8516.82966340676, 30248.54627180594, 37235.62764372376, 37254.06864828374, 37278.76327420336, 37321.26787321273, 3689.3728066228805, 3728.5339332583426, 3732.4401339798974, 3734.9813250933844, 3743.644353786386, 30523.2369190772, 30629.846850765603, 30639.693603063908, 30694.69305306963, 30789.692103078905, 3146.622405311354, 3161.162291992624, 3161.7944833585975, 3189.378071276102, 3192.984035079833, 238877.0, 241938.9673239205, 262927.0, 263448.0, 283739.0, 47953.76023119932, 48251.75874120677, 48254.0, 48323.0, 48389.516104839204, 49846.0, 49862.750686246334, 50123.74938125286, 50133.49866501361, 50263.49736502588, 14095.083819551697, 14151.71696566063, 14270.429182832571, 14284.0001199915, 14298.714025719428, 11518.308901465938, 11594.88405115955, 11612.0, 11621.883781162249, 11624.593139240085, 10899.0, 13280.937524997977, 13285.867141328656, 13368.0, 13410.12834165776, 5055.6713813602, 6033.064874944391, 6037.486813620803, 6062.181605483292, 6093.0, 1030.6753372687579, 1032.2722480651123, 1040.927135100551, 1053.8840727519967, 1065.3767545985531, 20871.478213044797, 21184.470388240417, 23343.88328058383, 24534.877325613616, 24756.019518438483, 1126.9661910142709, 1127.7988941776982, 1134.2627292260097, 1176.9352685602203, 1182.9408529573486, 11673.94934455903, 11744.882551174549, 12463.376831158406, 12607.180533265308, 12690.11169218146, 327250.5462308808, 327838.0, 327848.0, 330618.0, 331540.0, 54016.0, 54165.729171353894, 54176.72911635417, 54283.72858135684, 54418.91162176814, 1492.6492274315744, 1498.048739050689, 1533.8082739657543, 1534.2098819108169, 1553.122485795522, 21471.46321341979, 22557.43606409853, 24320.148794792098, 24391.0, 24449.511009779348, 30222.395552089274, 36229.818850905576, 37731.62268377281, 37747.622523775506, 37869.81065094657, 292099.0, 293508.0, 294303.0, 294739.0, 295204.0, 33099.84150554719, 33270.66729332772, 33499.665003349655, 34635.4804677925, 34900.77847275333, 42055.0, 45697.77151114223, 45739.0, 45783.54216457926, 45835.3124703123, 23895.880520597286, 28409.147725568266, 30908.74664912749, 30930.53604195984, 31726.841365793025, 30005.849970750005, 30021.399572008875, 30582.388352232385, 30901.227469313446, 31096.844515777277, 36647.0, 36749.0, 36903.0, 36911.261774763814, 36990.07524811794, 29121.85439072791, 30197.245068873453, 30244.697553024187, 30867.536986944764, 31133.844330779106, 23937.401564961016, 24008.519829603658, 24039.0, 24357.756422436258, 24454.87772561126], "value": 17433.4001623114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.5013756634893, 424.56057979990675, 436.90169711814843, 438.76087532294895, 455.34885114286556, 19995.400137995864, 20845.791542084593, 22230.444238894037, 22460.989255483502, 22489.775102248972, 22736.77263227367, 22936.541269174606, 23491.0, 23562.0, 23645.935932883018, 6027.367126451725, 6223.5332350073695, 6226.595271307373, 6231.189945307104, 6235.532335074865, 5995.85010374742, 6675.332466753334, 7020.7191712331705, 7085.539439936413, 7120.572765634052, 6885.173779146509, 7035.226125126232, 7100.147982242112, 7103.147622285333, 7132.750353737621, 6865.313468653145, 7065.328793764585, 7124.3588077073055, 7125.144982602095, 7152.821179470503, 6970.0, 7040.119985001875, 7042.471814613925, 7065.2228254891925, 7066.9646651766925, 28469.0, 29449.705502945126, 29486.967956121433, 29593.40813183746, 29809.850950745324, 2296.40293523685, 2392.676988606533, 2405.9398515037087, 2406.1578447543393, 2406.193925035115, 17807.287708491775, 18105.0, 18854.81145188558, 18881.622367552573, 19163.23347066116, 2271.5797577448225, 2313.803326717231, 2375.10933399975, 2377.191754803358, 2386.1886958434216, 170766.0, 172029.0, 173936.0, 174228.25771742247, 174748.0, 24686.876565617058, 25338.366540836625, 25487.74512254854, 25659.0, 25778.484430311288, 42394.78802606029, 42421.0, 42443.7877810609, 42645.0, 42728.78635606802, 8722.171393717586, 8809.075047120088, 9010.954945225232, 9126.0, 9158.81682366349, 8453.957730211432, 8587.613557389932, 8645.654173833102, 8760.91239087601, 8768.386212965032, 8020.318272946748, 8131.7395803650525, 8133.186681331819, 8168.346532277404, 8174.550399727953, 2257.3566533537864, 2258.4579700871673, 2259.254446032838, 2260.4348912771807, 2420.4674971506242, 918.8606128400735, 957.2581249531529, 960.9759756006156, 989.2926557511414, 1017.6183931025865, 17359.826401736074, 21357.25249616287, 21693.132274708834, 21830.563388732455, 21886.35852311083, 1006.5304655203485, 1022.2180032275315, 1023.2734758321675, 1027.091024443358, 1031.0771859185986, 9839.770028746407, 10232.181425485944, 10649.9467502662, 10948.34309941406, 11012.50443730034, 549550.0, 555881.0, 559103.0, 565847.0, 566075.0, 135285.0, 135678.0, 139055.0, 139623.30188348994, 140202.0, 1166.0548477650536, 1181.0, 1201.1351826684772, 1201.765655697148, 1205.891469767725, 18483.537911552317, 18605.255789768256, 18622.441326760218, 18712.25150993945, 18961.810381896557, 54854.90290194094, 54872.0, 55667.44332556622, 56741.0, 57183.71408142932, 75786.24213757792, 76434.0, 77508.2249177501, 78482.6075869617, 78555.60722196352, 8825.735227943173, 8842.513661748666, 8888.422252553562, 9036.45781253127, 9349.252059835333, 14607.853921461074, 14612.977091603485, 14837.92581037088, 14883.0, 14891.404343826125, 12025.759484810429, 12149.210301330386, 12324.137310388187, 12332.0, 12342.13605047674, 9543.0, 11542.653720388402, 11692.766144677229, 12025.699357516132, 12066.0, 11082.390468524309, 12437.875621243671, 12456.190347627375, 12604.747905042032, 12752.362381880683, 8945.46327220369, 9028.413153145024, 9098.454092754191, 9167.266618670357, 9182.31132665066, 10377.0, 11972.102092342935, 12260.632181034227, 12352.75294494123, 12357.876421235673], "value": 11371.91104000518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.692393825482, 1421.9786703199447, 1434.7130573885227, 1438.0365155345917, 1444.4583281269524, 11335.149863760209, 11554.19120661554, 11859.881401185985, 11946.283223006614, 12153.574624888131, 11608.59369922053, 11878.990285825716, 11899.524019039229, 11904.880951190486, 11916.34460104696, 2154.6767984802327, 2505.9874700626515, 2540.4538024324766, 2543.4150145466556, 2557.2328301509565, 2466.9136580219697, 2495.588227942387, 2506.6741323627903, 2511.485145545168, 2511.485145545168, 2480.417101981033, 2502.78726308264, 2537.9873100634472, 2544.0459827564664, 2544.8727563621837, 2447.596146635803, 2476.6532685424145, 2505.4237525369085, 2511.7362676918933, 2516.3834860459124, 2393.0188622664623, 2498.263012411343, 2511.1713134665515, 2514.371407148213, 2517.773400393955, 11738.589149379815, 11833.526658933632, 11859.881401185963, 11859.940700296529, 11862.347570883598, 6611.404973552355, 6823.624700641462, 6856.897146542806, 6864.347886950732, 6864.4165245954155, 3557.6442355764475, 4095.9795201024103, 4126.525449573308, 4361.127774445092, 4394.8901277468, 1159.09590519395, 1213.7875871722413, 1261.8927391171762, 1275.2284867655028, 1315.4409376015155, 13110.082294239408, 13631.113977591524, 16862.24119914607, 16904.323827046905, 16949.83050169495, 5262.657927234717, 5495.862603434946, 5694.886102277931, 5715.485606295453, 5723.771049157987, 12006.0, 12091.214071085351, 12103.697407564705, 12107.878921210851, 12134.211276267015, 6089.48239399656, 6514.706838192198, 6584.703688334036, 6585.769498067544, 6594.7032383542855, 5636.985342638364, 6084.847878803065, 6169.876602468015, 6212.9068063979075, 6217.906731399033, 4108.77401742907, 4182.665386769051, 4398.428204333481, 4431.844885429059, 4479.283314669702, 1267.6260503151593, 1282.0897163014365, 1299.3503248375812, 1305.2233920817098, 1305.8171855940177, 786.7364432915037, 797.8789800330545, 803.9115697273295, 812.9227723366271, 834.5660256666499, 6178.0, 6197.1324014637985, 6377.426031657081, 6405.455536279375, 6452.064450654629, 562.1539582927668, 592.7717828636006, 607.0742118269674, 611.7186094396627, 626.223482881233, 3287.7369810415107, 3453.2057626745486, 3954.6638535724787, 4429.069895322018, 4467.396901418267, 13688.52090176839, 15167.0, 15210.0, 15286.464973725866, 15296.847031529765, 14749.926250368893, 14986.175760333286, 15298.694026119416, 15309.540713778604, 15361.0, 6690.899636505456, 7560.130584982578, 8693.608787604573, 8782.033976262606, 8823.382363234641, 6584.637844918576, 6777.423918966943, 6914.619695916773, 6922.27316131819, 7144.071270734771, 12274.877251227374, 12769.489220431078, 12819.294938778085, 12881.8067728986, 12948.482060717466, 10461.424621645883, 12938.0, 12946.482140714266, 13194.80207796903, 13309.669033096612, 8094.716684915999, 8114.310283625958, 8189.918100818915, 8195.303399211134, 8195.40189663034, 10318.845217321896, 10424.478776061318, 10489.842652360374, 10527.684169474927, 10534.631287904887, 8893.377463577488, 8914.955425222832, 9053.773655658399, 9174.220191283815, 9236.676716315165, 8673.392862499564, 8762.693305734269, 8834.867476987722, 8858.0, 8889.333300002396, 7978.162292959156, 8038.557879316693, 8130.146334634778, 8137.924829168524, 8366.456180348257, 6058.666773327509, 6093.664848433379, 6157.538184636081, 6170.444659980623, 6269.811905642838, 5996.310424301261, 6224.128621993015, 6283.3402492737605, 6283.434490895658, 6297.4647154992335], "value": 5261.134119091442, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.7505945362617, 392.10991050315783, 416.3026929892429, 418.03225532891355, 419.4463308432868, 5933.258342707161, 6061.333253342129, 6113.449789518942, 6201.379862013797, 6219.533534984872, 4737.384140061788, 5948.375420580842, 6008.699565021753, 6078.483328917047, 6107.816765497031, 4629.055796565451, 4636.281376386665, 4646.674732768707, 4658.953410465902, 4678.298255261704, 4494.528074552174, 4662.650301227404, 4669.8832529186875, 4689.2966055091665, 4737.289406589022, 4135.524414692304, 4168.791050595324, 4649.8837529061875, 4679.204535229019, 4705.952940470603, 3825.330567150765, 3840.462335273036, 4023.5574086850424, 4678.812847486097, 4685.1332503486965, 3635.3456377851976, 3778.5465744110606, 4124.546299907008, 4137.50349958004, 4181.268278051329, 4828.46886842447, 5484.670919744788, 5689.118186681071, 5723.971380143114, 6010.549208809357, 4632.652551058684, 5533.5849811263915, 5592.972035139839, 5596.6362186458155, 5640.351359593658, 6559.852025895497, 6581.80254592363, 6585.176852893388, 6599.8550471096605, 6653.53425260232, 4396.406485124531, 4772.0, 4777.355057067286, 4782.876024134325, 4811.59101476375, 5636.0, 6922.896156557656, 7010.964945175241, 7052.929470705279, 7087.184973728087, 4297.67767417445, 4857.344258525054, 4858.319835223072, 4872.512748725099, 4900.044491324229, 4862.82980095695, 4952.925706114411, 4978.5270399312, 4982.352294201731, 4993.300937868701, 4941.4681448751, 5276.577873770089, 5495.093309603871, 5528.778848846082, 5620.91568626471, 5393.6763794172475, 6432.099506069154, 6578.454063295122, 6579.30917253691, 6600.669966501751, 1614.9838501615068, 1653.5039488153507, 1660.7508873668805, 1686.0, 1711.5977745229861, 1082.7440169403453, 1125.6960620632383, 1161.8199179127248, 1195.820626905971, 1198.7712594590614, 6140.385961403824, 6142.477889379364, 6170.56806023583, 6187.876242475125, 6188.319284878659, 5828.0, 6687.832804179837, 6738.932610673928, 6740.764073257413, 6775.762848300285, 4996.100701873697, 5635.5623069927315, 6197.442230199304, 6266.373362663697, 6277.372262773686, 2962.9259268518026, 3111.8372730952224, 3286.967130328714, 3517.4899639552123, 3543.1850674345046, 6143.0, 6813.829654258683, 7017.543859649107, 7052.224255331909, 7053.259407762213, 6620.139381880324, 6650.9667451662435, 6888.862222755517, 6924.93075069253, 6994.160700715946, 5975.760969561169, 6223.471004964629, 6426.485881129498, 6995.475339349671, 7042.22535521082, 6739.58468721574, 6802.455803535804, 6840.0, 6850.273311415108, 6859.759908403182, 6061.090836374579, 6072.757089716361, 6710.261871194262, 6767.323267673193, 6817.0, 7002.0, 7028.6134262614005, 7047.753328633473, 7051.753188638373, 7108.751193708195, 4184.267753143127, 4269.701120921506, 4315.201687687788, 4329.4155289036835, 4333.696641235083, 6055.000924847527, 6419.358064193543, 6733.091032710521, 6788.287229840993, 6828.795136145924, 6448.226212854487, 6554.983977483497, 6592.7033283503315, 6611.371919667624, 6620.437262832521, 6526.836829079311, 6530.249021362414, 6534.7128505022865, 6562.261000834878, 6567.25967618591, 5177.223416487557, 5291.285676433632, 6373.362663733589, 6483.4164925156965, 6488.059231411325, 5156.510131537498, 6383.202099737533, 6537.378948999837, 6540.247871494648, 6584.209894812653, 4958.8760280993265, 5172.482751724948, 5247.396549396715, 5946.554008449297, 6362.713677884599], "value": 4822.944536773848, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.6538651846005, 861.4185424838237, 861.6984055580546, 881.8491868112116, 893.2541327991127, 16594.83405165948, 17376.56558586036, 17467.737983930252, 18221.36225232117, 19758.30845920393, 17852.01813900235, 18096.457106286798, 18156.092195390243, 18462.63074738508, 18493.81506184938, 970.0832713086137, 993.2401712689798, 997.1524204426253, 999.2355847776421, 1011.8988101189896, 964.7925695975364, 997.1324947295863, 999.4902599674145, 1006.0, 1041.5833666533372, 1074.6023971130653, 1085.6417382263835, 1086.793509233247, 1086.9293495922739, 1087.3801932898252, 1054.2830875005031, 1075.8816530181673, 1078.6440474643348, 1078.7626722121122, 1079.5250089960393, 800.7877912353231, 802.759172248329, 804.9597520123971, 805.5166899860037, 811.8660421030523, 16947.661046778994, 17072.146392680315, 17177.055261960588, 17529.948203107855, 17694.469165925042, 16894.324227030906, 17159.227834747468, 17210.397636082802, 17449.389271375567, 17720.822791772047, 13935.024548281624, 14177.291135443187, 14209.147451152963, 14302.785458218135, 14355.641108972359, 3526.8589256429714, 3532.0816587687127, 3560.6795388414907, 3562.340966921128, 3569.696575791035, 103398.89803305913, 108164.99999999921, 117869.0, 118472.81527184704, 120515.0, 13231.536896208587, 13376.59870203876, 13429.529966451128, 13490.797638035438, 13505.864941350657, 20518.58962820765, 21767.455813604785, 22230.777692223193, 25291.735413229264, 25619.487610248063, 7802.024746906637, 8026.9598652007535, 8033.236842499953, 8034.758957231293, 8043.11525732169, 3840.7503512271614, 3841.7118716096406, 3864.8260828262796, 3898.1229223424502, 3912.4326972588815, 4270.594293542109, 4309.655227581786, 4370.191514569751, 4392.3411488277015, 4423.889402764957, 885.9379843411028, 910.3627460777482, 925.1534845616186, 928.034843762493, 934.72425634438, 615.8337248942761, 661.652632368001, 676.2426082787211, 679.6329981809768, 690.4855882367568, 11165.553377864795, 11980.520779168735, 12071.57749478764, 12123.818142727867, 12334.876651233551, 650.4713922282692, 655.3282885042773, 666.5900471210268, 689.2797027106685, 693.8889777635554, 5399.676019438768, 5620.409856965041, 5636.098224284095, 5647.858803529944, 5726.0, 96178.0, 97009.0, 97791.0, 102678.0, 112302.31546526808, 90687.0, 91530.0, 93167.0, 93900.53049734708, 94935.52532237433, 63819.680901595195, 84222.0, 84449.0, 85918.71121933176, 86154.0, 10629.043386095289, 11192.1605879561, 11401.942990284995, 12573.434195461408, 12636.431360588611, 41395.965100871515, 41644.79177604214, 41851.7907410461, 41910.79044604758, 41947.1610567793, 40881.0, 46404.07191856077, 46950.0, 54717.0, 55128.72435637796, 16078.678426431172, 16281.837181628032, 16588.921720088154, 16615.916920415322, 16681.165941702624, 13818.654533636338, 14639.341229644904, 17760.3783867564, 18027.72958405599, 18589.907050464662, 16525.421610243582, 16622.836401451783, 16629.91685041567, 16706.49880503587, 16945.49163525096, 16222.35110595563, 16730.996140231626, 16738.246778894736, 16868.240929158463, 16874.578135546708, 15737.606559835638, 15835.683286333979, 16490.34038638489, 16588.917055414644, 16634.667306654042, 11585.478653460446, 11629.302241865515, 11729.941350293195, 12310.26138431697, 12332.506699732268, 10608.0, 11412.144089193509, 13448.731025379633, 13593.0, 14249.572512824632], "value": 8384.177367802746, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 115.0, 112.0, 113.0, 114.0, 112.0, 113.0, 113.0, 115.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 105.0, 157.0, 93.0, 129.0, 147.0, 146.0, 138.0, 116.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 188.0, 189.0, 262.0, 265.0, 287.0, 269.0, 200.0, 200.0, 197.0], "value": 225.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 69.0, 82.0, 60.0, 82.0, 87.0, 82.0, 77.0, 57.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 84.0, 70.0, 68.0, 72.0, 96.0, 105.0, 65.0, 117.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 88.0, 91.0, 88.0, 87.0, 122.0, 137.0, 94.0], "value": 97.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 97.0, 96.0, 97.0, 96.0, 96.0, 114.0, 119.0, 96.0, 97.0], "value": 101.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 96.0, 90.0, 93.0, 90.0, 88.0, 93.0, 90.0, 91.0], "value": 91.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 48.0, 50.0, 51.0, 52.0, 51.0, 52.0, 50.0, 49.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 60.0, 60.0, 60.0, 59.0, 56.0, 58.0, 58.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 102.0, 77.0, 76.0, 107.0, 74.0, 82.0, 78.0, 77.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 157.0, 161.0, 139.0, 143.0, 155.0, 152.0, 157.0, 202.0, 157.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 188.0, 188.0, 182.0, 188.0, 186.0, 203.0, 184.0, 186.0, 185.0], "value": 188.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 71.0, 70.0, 70.0, 76.0, 66.0, 68.0, 69.0, 66.0], "value": 69.4, "unit": "score"}]}]} 04:00:34 INFO - Return code: 0 04:00:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:35 ERROR - # TBPL SUCCESS # 04:00:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:00:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:00:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:00:35 INFO - 2017-04-28 04:00:35.067 screenresolution[1659:10695] starting screenresolution argv=screenresolution get 04:00:35 INFO - 2017-04-28 04:00:35.070 screenresolution[1659:10695] Display 0: 1600x1200x32@60 04:00:35 INFO - 2017-04-28 04:00:35.076 screenresolution[1660:10698] starting screenresolution argv=screenresolution list 04:00:35 INFO - Available Modes on Display 0 04:00:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:00:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:00:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:00:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:00:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:00:35 INFO - Intel Iris: 04:00:35 INFO - Chipset Model: Intel Iris 04:00:35 INFO - Type: GPU 04:00:35 INFO - Bus: Built-In 04:00:35 INFO - VRAM (Dynamic, Max): 1536 MB 04:00:35 INFO - Vendor: Intel (0x8086) 04:00:35 INFO - Device ID: 0x0a2e 04:00:35 INFO - Revision ID: 0x0009 04:00:35 INFO - Displays: 04:00:35 INFO - Display: 04:00:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:00:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:00:35 INFO - Display Serial Number: 1600x1200 60 04:00:35 INFO - Main Display: Yes 04:00:35 INFO - Mirror: Off 04:00:35 INFO - Online: Yes 04:00:35 INFO - Rotation: Supported 04:00:35 INFO - Return code: 0 04:00:35 INFO - Running post-action listener: _resource_record_post_action 04:00:35 INFO - [mozharness: 2017-04-28 11:00:35.319150Z] Finished run-tests step (success) 04:00:35 INFO - Running post-run listener: _resource_record_post_run 04:00:35 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 38214144; Write bytes: 515379200; Read time: 400; Write time: 1639 04:00:35 INFO - TinderboxPrint: CPU usage
54.0% 04:00:35 INFO - TinderboxPrint: I/O read bytes / time
38,214,144 / 400 04:00:35 INFO - TinderboxPrint: I/O write bytes / time
515,379,200 / 1,639 04:00:35 INFO - TinderboxPrint: CPU idle
2,197.7 (46.0%) 04:00:35 INFO - TinderboxPrint: CPU system
957.4 (20.0%) 04:00:35 INFO - TinderboxPrint: CPU user
1,626.5 (34.0%) 04:00:35 INFO - TinderboxPrint: Swap in / out
246,931,456 / 0 04:00:35 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 197497344; Write bytes: 195328000; Read time: 15023; Write time: 413 04:00:35 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37259776; Write bytes: 303208448; Read time: 384; Write time: 1177 04:00:35 INFO - Running post-run listener: _upload_blobber_files 04:00:35 INFO - Blob upload gear active. 04:00:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:35 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:00:35 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:00:35 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:00:36 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:00:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:00:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:37 INFO - (blobuploader) - INFO - Done attempting. 04:00:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:00:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:00:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:38 INFO - (blobuploader) - INFO - Done attempting. 04:00:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:00:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:00:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:39 INFO - (blobuploader) - INFO - Done attempting. 04:00:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:41 INFO - (blobuploader) - INFO - Done attempting. 04:00:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:41 INFO - Return code: 0 04:00:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b31c9d382b769e47ade81225f260aeb67dabd01eac64f82e84dac60f3b76c4704a5940faaaffea0d828d7911a99a4429b5ffa11151d07f831e09cdacf374fee3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9b28b61f3c19dcfbbeec4734804eb58f828b648a2b2ebde60b52727900eca9129c4b7ecdcfbc03a52e4596bc2d66d78a35f6f81ea55f7f8eef59ac75d7a9782", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9b347a52623b53c3cf1a99d97f955c98f12e30fc553ac0f63a10e25682c812fb6d52db6b9f00bda7d51d68d74ea1b74278715034d71b601c8180e0094fc51c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2133d675599dfbf999f2e3555d0af58c3baeb82989d8f7d179d2201511abcbfbaa01325ad023bdbc70f8320b298374087a6ae797d178d495071a533165fec669"} 04:00:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:41 INFO - Contents: 04:00:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b31c9d382b769e47ade81225f260aeb67dabd01eac64f82e84dac60f3b76c4704a5940faaaffea0d828d7911a99a4429b5ffa11151d07f831e09cdacf374fee3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9b28b61f3c19dcfbbeec4734804eb58f828b648a2b2ebde60b52727900eca9129c4b7ecdcfbc03a52e4596bc2d66d78a35f6f81ea55f7f8eef59ac75d7a9782", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9b347a52623b53c3cf1a99d97f955c98f12e30fc553ac0f63a10e25682c812fb6d52db6b9f00bda7d51d68d74ea1b74278715034d71b601c8180e0094fc51c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2133d675599dfbf999f2e3555d0af58c3baeb82989d8f7d179d2201511abcbfbaa01325ad023bdbc70f8320b298374087a6ae797d178d495071a533165fec669"} 04:00:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:41 INFO - Copying logs to upload dir... 04:00:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.676937 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-28 04:00:41.447226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 04:00:41.451297) ========= 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.n1JLik25YD/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.rRJNi5FfiD/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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/b31c9d382b769e47ade81225f260aeb67dabd01eac64f82e84dac60f3b76c4704a5940faaaffea0d828d7911a99a4429b5ffa11151d07f831e09cdacf374fee3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9b28b61f3c19dcfbbeec4734804eb58f828b648a2b2ebde60b52727900eca9129c4b7ecdcfbc03a52e4596bc2d66d78a35f6f81ea55f7f8eef59ac75d7a9782", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9b347a52623b53c3cf1a99d97f955c98f12e30fc553ac0f63a10e25682c812fb6d52db6b9f00bda7d51d68d74ea1b74278715034d71b601c8180e0094fc51c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2133d675599dfbf999f2e3555d0af58c3baeb82989d8f7d179d2201511abcbfbaa01325ad023bdbc70f8320b298374087a6ae797d178d495071a533165fec669"} build_url:https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011718 build_url: 'https://queue.taskcluster.net/v1/task/e-045QWSSvSCqxGzIGutyg/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/b31c9d382b769e47ade81225f260aeb67dabd01eac64f82e84dac60f3b76c4704a5940faaaffea0d828d7911a99a4429b5ffa11151d07f831e09cdacf374fee3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9b28b61f3c19dcfbbeec4734804eb58f828b648a2b2ebde60b52727900eca9129c4b7ecdcfbc03a52e4596bc2d66d78a35f6f81ea55f7f8eef59ac75d7a9782", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9b347a52623b53c3cf1a99d97f955c98f12e30fc553ac0f63a10e25682c812fb6d52db6b9f00bda7d51d68d74ea1b74278715034d71b601c8180e0094fc51c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2133d675599dfbf999f2e3555d0af58c3baeb82989d8f7d179d2201511abcbfbaa01325ad023bdbc70f8320b298374087a6ae797d178d495071a533165fec669"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 04:00:41.488289) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 04:00:41.488616) ========= 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.n1JLik25YD/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.rRJNi5FfiD/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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.005292 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 04:00:41.537953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 04:00:41.538274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 04:00:41.538600) ========= ========= Total master_lag: 0.19 =========