builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0164 starttime: 1493095065.33 results: success (0) buildid: 20170424202225 builduid: 612c410f1b1d42f4baf000db8f5e0536 revision: 85932a5027c024900bb0e58cdbc52ecf9a32e1f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:45.327983) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:45.328410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:45.328679) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:45.358771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:45.359563) ========= 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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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-24 21:37:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.5M=0.001s 2017-04-24 21:37:45 (14.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157539 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:45.548543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:45.548976) ========= 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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.028771 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:45.603018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 21:37:45.603790) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 85932a5027c024900bb0e58cdbc52ecf9a32e1f5 --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 85932a5027c024900bb0e58cdbc52ecf9a32e1f5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2XFdVXHPjV/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.zmUNSBIhJl/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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-24 21:37:45,702 truncating revision to first 12 chars 2017-04-24 21:37:45,702 Setting DEBUG logging. 2017-04-24 21:37:45,702 attempt 1/10 2017-04-24 21:37:45,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/85932a5027c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 21:37:47,365 unpacking tar archive at: mozilla-central-85932a5027c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.937833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 21:37:47.566461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:47.566826) ========= script_repo_revision: 85932a5027c024900bb0e58cdbc52ecf9a32e1f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:47.567228) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:47.567489) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 21:37:47.585482) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-24 21:37:47.585804) ========= /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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 21:37:47 INFO - MultiFileLogger online at 20170424 21:37:47 in /builds/slave/test 21:37:47 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 21:37:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:37:47 INFO - {'append_to_log': False, 21:37:47 INFO - 'base_work_dir': '/builds/slave/test', 21:37:47 INFO - 'blob_upload_branch': 'Firefox', 21:37:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:37:47 INFO - 'branch': 'Firefox', 21:37:47 INFO - 'buildbot_json_path': 'buildprops.json', 21:37:47 INFO - 'config_files': ('talos/mac_config.py',), 21:37:47 INFO - 'default_actions': ('clobber', 21:37:47 INFO - 'read-buildbot-config', 21:37:47 INFO - 'download-and-extract', 21:37:47 INFO - 'populate-webroot', 21:37:47 INFO - 'create-virtualenv', 21:37:47 INFO - 'install', 21:37:47 INFO - 'run-tests'), 21:37:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:37:47 INFO - 'download_minidump_stackwalk': True, 21:37:47 INFO - 'download_symbols': 'ondemand', 21:37:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:37:47 INFO - 'tooltool.py': '/tools/tooltool.py', 21:37:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:37:47 INFO - '/tools/misc-python/virtualenv.py')}, 21:37:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:37:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:37:47 INFO - 'gecko_profile': False, 21:37:47 INFO - 'gecko_profile_interval': 0, 21:37:47 INFO - 'installer_path': 'installer.exe', 21:37:47 INFO - 'log_level': 'info', 21:37:47 INFO - 'log_name': 'talos', 21:37:47 INFO - 'log_to_console': True, 21:37:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:37:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:37:47 INFO - 'opt_config_files': (), 21:37:47 INFO - 'pip_index': False, 21:37:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:37:47 INFO - 'cmd': ('bash', 21:37:47 INFO - '-c', 21:37:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:37:47 INFO - 'enabled': True, 21:37:47 INFO - 'halt_on_failure': False, 21:37:47 INFO - 'name': 'check_screen_resolution'},), 21:37:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:37:47 INFO - 'cmd': ('bash', 21:37:47 INFO - '-c', 21:37:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:37:47 INFO - 'enabled': True, 21:37:47 INFO - 'halt_on_failure': False, 21:37:47 INFO - 'name': 'check_screen_resolution'},), 21:37:47 INFO - 'run_cmd_checks_enabled': True, 21:37:47 INFO - 'suite': 'dromaeojs-e10s', 21:37:47 INFO - 'system_bits': '32', 21:37:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:37:47 INFO - 'title': 't-yosemite-r7-0164', 21:37:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:37:47 INFO - 'use_talos_json': True, 21:37:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:37:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:37:47 INFO - 'work_dir': 'build'} 21:37:47 INFO - [mozharness: 2017-04-25 04:37:47.796154Z] Running clobber step. 21:37:47 INFO - Running pre-action listener: _resource_record_pre_action 21:37:47 INFO - Running main action method: clobber 21:37:47 INFO - rmtree: /builds/slave/test/build 21:37:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:37:50 INFO - Running post-action listener: _resource_record_post_action 21:37:50 INFO - [mozharness: 2017-04-25 04:37:50.470774Z] Finished clobber step (success) 21:37:50 INFO - [mozharness: 2017-04-25 04:37:50.470898Z] Running read-buildbot-config step. 21:37:50 INFO - Running pre-action listener: _resource_record_pre_action 21:37:50 INFO - Running main action method: read_buildbot_config 21:37:50 INFO - Using buildbot properties: 21:37:50 INFO - { 21:37:50 INFO - "project": "", 21:37:50 INFO - "product": "firefox", 21:37:50 INFO - "script_repo_revision": "production", 21:37:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 21:37:50 INFO - "repository": "", 21:37:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 21:37:50 INFO - "buildid": "20170424202225", 21:37:50 INFO - "pgo_build": "False", 21:37:50 INFO - "basedir": "/builds/slave/test", 21:37:50 INFO - "buildnumber": 41, 21:37:50 INFO - "slavename": "t-yosemite-r7-0164", 21:37:50 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 21:37:50 INFO - "platform": "yosemite_r7", 21:37:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:37:50 INFO - "branch": "mozilla-central", 21:37:50 INFO - "repo_path": "mozilla-central", 21:37:50 INFO - "revision": "85932a5027c024900bb0e58cdbc52ecf9a32e1f5", 21:37:50 INFO - "stage_platform": "macosx64", 21:37:50 INFO - "builduid": "612c410f1b1d42f4baf000db8f5e0536", 21:37:50 INFO - "slavebuilddir": "test" 21:37:50 INFO - } 21:37:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 21:37:50 INFO - Running post-action listener: _resource_record_post_action 21:37:50 INFO - [mozharness: 2017-04-25 04:37:50.474253Z] Finished read-buildbot-config step (success) 21:37:50 INFO - [mozharness: 2017-04-25 04:37:50.474388Z] Running download-and-extract step. 21:37:50 INFO - Running pre-action listener: _resource_record_pre_action 21:37:50 INFO - Running main action method: download_and_extract 21:37:50 INFO - mkdir: /builds/slave/test/build/tests 21:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:50 INFO - trying https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 21:37:50 INFO - Downloading https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/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 21:37:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/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 21:37:51 INFO - Downloaded 1325 bytes. 21:37:51 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 21:37:51 INFO - Using the following test package requirements: 21:37:51 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:37:51 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 21:37:51 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:37:51 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:37:51 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 21:37:51 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:37:51 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 21:37:51 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:37:51 INFO - u'jsshell-mac.zip'], 21:37:51 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:37:51 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 21:37:51 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:37:51 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:37:51 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 21:37:51 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:37:51 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 21:37:51 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:37:51 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 21:37:51 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:37:51 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 21:37:51 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:37:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 21:37:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:37:51 INFO - Fetch https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:37:55 INFO - Content-Length response header: 52526740 21:37:55 INFO - Bytes received: 52526740 21:38:11 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 21:38:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 21:38:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:38:11 INFO - Fetch https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:38:13 INFO - Content-Length response header: 52526740 21:38:13 INFO - Bytes received: 52526740 21:38:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 21:38:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:38:28 INFO - Fetch https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 21:38:29 INFO - Content-Length response header: 14408822 21:38:29 INFO - Bytes received: 14408822 21:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:29 INFO - trying https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:38:29 INFO - Downloading https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 21:38:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/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 21:38:31 INFO - Downloaded 71105774 bytes. 21:38:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:38:31 INFO - mkdir: /builds/slave/test/properties 21:38:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:38:31 INFO - Writing to file /builds/slave/test/properties/build_url 21:38:31 INFO - Contents: 21:38:31 INFO - build_url:https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:38:32 INFO - Running post-action listener: _resource_record_post_action 21:38:32 INFO - Running post-action listener: set_extra_try_arguments 21:38:32 INFO - [mozharness: 2017-04-25 04:38:32.491975Z] Finished download-and-extract step (success) 21:38:32 INFO - [mozharness: 2017-04-25 04:38:32.492123Z] Running populate-webroot step. 21:38:32 INFO - Running pre-action listener: _resource_record_pre_action 21:38:32 INFO - Running main action method: populate_webroot 21:38:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:38:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:38:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:38:32 INFO - '--tppagecycles', 21:38:32 INFO - '7'], 21:38:32 INFO - 'tests': ['tsvgm']}}, 21:38:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:38:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:38:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:38:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:38:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:38:32 INFO - 'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:38:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:38:32 INFO - 'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['damp', 'tps']}, 21:38:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:38:32 INFO - 'tests': ['damp', 'tps']}, 21:38:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['dromaeo_dom']}, 21:38:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:38:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:38:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:38:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['a11yr', 21:38:32 INFO - 'ts_paint', 21:38:32 INFO - 'tpaint', 21:38:32 INFO - 'sessionrestore', 21:38:32 INFO - 'sessionrestore_no_auto_restore', 21:38:32 INFO - 'tabpaint']}, 21:38:32 INFO - 'other-e10s': {'tests': ['a11yr', 21:38:32 INFO - 'ts_paint', 21:38:32 INFO - 'tpaint', 21:38:32 INFO - 'sessionrestore', 21:38:32 INFO - 'sessionrestore_no_auto_restore', 21:38:32 INFO - 'tabpaint']}, 21:38:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:38:32 INFO - 'ts_paint', 21:38:32 INFO - 'tpaint', 21:38:32 INFO - 'sessionrestore', 21:38:32 INFO - 'sessionrestore_no_auto_restore', 21:38:32 INFO - 'tabpaint']}, 21:38:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:38:32 INFO - 'ts_paint', 21:38:32 INFO - 'tpaint', 21:38:32 INFO - 'sessionrestore', 21:38:32 INFO - 'sessionrestore_no_auto_restore', 21:38:32 INFO - 'tabpaint']}, 21:38:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['a11yr', 21:38:32 INFO - 'ts_paint', 21:38:32 INFO - 'tpaint', 21:38:32 INFO - 'sessionrestore', 21:38:32 INFO - 'sessionrestore_no_auto_restore', 21:38:32 INFO - 'tabpaint']}, 21:38:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['a11yr', 21:38:32 INFO - 'ts_paint', 21:38:32 INFO - 'tpaint', 21:38:32 INFO - 'sessionrestore', 21:38:32 INFO - 'sessionrestore_no_auto_restore', 21:38:32 INFO - 'tabpaint']}, 21:38:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:38:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:38:32 INFO - 'bloom_basic_ref']}, 21:38:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['tsvgx', 21:38:32 INFO - 'tsvgr_opacity', 21:38:32 INFO - 'tart', 21:38:32 INFO - 'tscrollx', 21:38:32 INFO - 'cart', 21:38:32 INFO - 'tsvg_static']}, 21:38:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:38:32 INFO - 'tsvgr_opacity', 21:38:32 INFO - 'tart', 21:38:32 INFO - 'tscrollx', 21:38:32 INFO - 'cart', 21:38:32 INFO - 'tsvg_static']}, 21:38:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:38:32 INFO - 'talos_options': ['--disable-e10s'], 21:38:32 INFO - 'tests': ['tp5o']}, 21:38:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:38:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:38:32 INFO - 'talos_options': ['--disable-e10s', 21:38:32 INFO - '--xperf_path', 21:38:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:32 INFO - 'tests': ['tp5n']}, 21:38:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:38:32 INFO - 'talos_options': ['--xperf_path', 21:38:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:32 INFO - 'tests': ['tp5n']}}, 21:38:32 INFO - 'talos.zip': {'path': '', 21:38:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:38:32 INFO - Running post-action listener: _resource_record_post_action 21:38:32 INFO - [mozharness: 2017-04-25 04:38:32.510979Z] Finished populate-webroot step (success) 21:38:32 INFO - [mozharness: 2017-04-25 04:38:32.511090Z] Running create-virtualenv step. 21:38:32 INFO - Running pre-action listener: _resource_record_pre_action 21:38:32 INFO - Running main action method: create_virtualenv 21:38:32 INFO - Creating virtualenv /builds/slave/test/build/venv 21:38:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:38:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:38:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:38:32 INFO - Using real prefix '/tools/python27' 21:38:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:38:33 INFO - Installing distribute.............................................................................................................................................................................................done. 21:38:36 INFO - Installing pip.................done. 21:38:36 INFO - Return code: 0 21:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:38:36 INFO - Reading from file tmpfile_stdout 21:38:36 INFO - Output received: 21:38:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:38:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:36 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 0x10ba63b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba66768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9c3478a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, '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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:36 INFO - 'HOME': '/Users/cltbld', 21:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:36 INFO - 'LOGNAME': 'cltbld', 21:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:36 INFO - 'MOZ_NO_REMOTE': '1', 21:38:36 INFO - 'NO_EM_RESTART': '1', 21:38:36 INFO - 'PAGER': '/bin/cat', 21:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:36 INFO - 'PWD': '/builds/slave/test', 21:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:36 INFO - 'SHELL': '/bin/bash', 21:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:38:36 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:36 INFO - 'USER': 'cltbld', 21:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:36 INFO - 'XPC_FLAGS': '0x0', 21:38:36 INFO - 'XPC_SERVICE_NAME': '0', 21:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:38:36 INFO - Cleaning up... 21:38:36 INFO - Return code: 0 21:38:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:36 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 0x10ba63b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba66768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9c3478a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, '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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:36 INFO - 'HOME': '/Users/cltbld', 21:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:36 INFO - 'LOGNAME': 'cltbld', 21:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:36 INFO - 'MOZ_NO_REMOTE': '1', 21:38:36 INFO - 'NO_EM_RESTART': '1', 21:38:36 INFO - 'PAGER': '/bin/cat', 21:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:36 INFO - 'PWD': '/builds/slave/test', 21:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:36 INFO - 'SHELL': '/bin/bash', 21:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:38:36 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:36 INFO - 'USER': 'cltbld', 21:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:36 INFO - 'XPC_FLAGS': '0x0', 21:38:36 INFO - 'XPC_SERVICE_NAME': '0', 21:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:37 INFO - Downloading/unpacking psutil>=3.1.1 21:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:40 INFO - Installing collected packages: psutil 21:38:40 INFO - Running setup.py install for psutil 21:38:40 INFO - building 'psutil._psutil_osx' extension 21:38:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:38:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:38:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:38:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 21:38:41 INFO - building 'psutil._psutil_posix' extension 21:38:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 21:38:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:38:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:38:41 INFO - ^ 21:38:41 INFO - 1 warning generated. 21:38:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 21:38:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:41 INFO - Successfully installed psutil 21:38:41 INFO - Cleaning up... 21:38:41 INFO - Return code: 0 21:38:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:42 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 0x10ba63b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba66768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9c3478a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, '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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:38:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:38:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:38:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:42 INFO - 'HOME': '/Users/cltbld', 21:38:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:42 INFO - 'LOGNAME': 'cltbld', 21:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:42 INFO - 'MOZ_NO_REMOTE': '1', 21:38:42 INFO - 'NO_EM_RESTART': '1', 21:38:42 INFO - 'PAGER': '/bin/cat', 21:38:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:42 INFO - 'PWD': '/builds/slave/test', 21:38:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:42 INFO - 'SHELL': '/bin/bash', 21:38:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:38:42 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:42 INFO - 'USER': 'cltbld', 21:38:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:42 INFO - 'XPC_FLAGS': '0x0', 21:38:42 INFO - 'XPC_SERVICE_NAME': '0', 21:38:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:38:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:38:45 INFO - Installing collected packages: mozsystemmonitor 21:38:45 INFO - Running setup.py install for mozsystemmonitor 21:38:46 INFO - Successfully installed mozsystemmonitor 21:38:46 INFO - Cleaning up... 21:38:46 INFO - Return code: 0 21:38:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:46 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 0x10ba63b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba66768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9c3478a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, '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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:38:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:38:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:38:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:46 INFO - 'HOME': '/Users/cltbld', 21:38:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:46 INFO - 'LOGNAME': 'cltbld', 21:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:46 INFO - 'MOZ_NO_REMOTE': '1', 21:38:46 INFO - 'NO_EM_RESTART': '1', 21:38:46 INFO - 'PAGER': '/bin/cat', 21:38:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:46 INFO - 'PWD': '/builds/slave/test', 21:38:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:46 INFO - 'SHELL': '/bin/bash', 21:38:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:38:46 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:46 INFO - 'USER': 'cltbld', 21:38:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:46 INFO - 'XPC_FLAGS': '0x0', 21:38:46 INFO - 'XPC_SERVICE_NAME': '0', 21:38:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:46 INFO - Downloading/unpacking jsonschema==2.5.1 21:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:38:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:49 INFO - Downloading functools32-3.2.3-2.tar.gz 21:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:38:49 INFO - warning: no files found matching '*.txt' 21:38:49 INFO - no previously-included directories found matching 'build' 21:38:49 INFO - no previously-included directories found matching 'dist' 21:38:49 INFO - no previously-included directories found matching '.git*' 21:38:49 INFO - Installing collected packages: jsonschema, functools32 21:38:49 INFO - Running setup.py install for functools32 21:38:49 INFO - warning: no files found matching '*.txt' 21:38:49 INFO - no previously-included directories found matching 'build' 21:38:49 INFO - no previously-included directories found matching 'dist' 21:38:49 INFO - no previously-included directories found matching '.git*' 21:38:49 INFO - Successfully installed jsonschema functools32 21:38:49 INFO - Cleaning up... 21:38:49 INFO - Return code: 0 21:38:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 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 0x10ba63b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba66768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9c3478a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, '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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:38:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:38:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:38:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:49 INFO - 'HOME': '/Users/cltbld', 21:38:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:49 INFO - 'LOGNAME': 'cltbld', 21:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:49 INFO - 'MOZ_NO_REMOTE': '1', 21:38:49 INFO - 'NO_EM_RESTART': '1', 21:38:49 INFO - 'PAGER': '/bin/cat', 21:38:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:49 INFO - 'PWD': '/builds/slave/test', 21:38:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:49 INFO - 'SHELL': '/bin/bash', 21:38:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:38:49 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:49 INFO - 'USER': 'cltbld', 21:38:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:49 INFO - 'XPC_FLAGS': '0x0', 21:38:49 INFO - 'XPC_SERVICE_NAME': '0', 21:38:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:38:50 INFO - Cleaning up... 21:38:50 INFO - Return code: 0 21:38:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:50 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 0x10ba63b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba66768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9c3478a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, '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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:50 INFO - 'HOME': '/Users/cltbld', 21:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:50 INFO - 'LOGNAME': 'cltbld', 21:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:50 INFO - 'MOZ_NO_REMOTE': '1', 21:38:50 INFO - 'NO_EM_RESTART': '1', 21:38:50 INFO - 'PAGER': '/bin/cat', 21:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:50 INFO - 'PWD': '/builds/slave/test', 21:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:50 INFO - 'SHELL': '/bin/bash', 21:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:38:50 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:50 INFO - 'USER': 'cltbld', 21:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:50 INFO - 'XPC_FLAGS': '0x0', 21:38:50 INFO - 'XPC_SERVICE_NAME': '0', 21:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:50 INFO - Downloading/unpacking blobuploader==1.2.4 21:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:52 INFO - Downloading blobuploader-1.2.4.tar.gz 21:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:38:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:38:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:54 INFO - Downloading docopt-0.6.1.tar.gz 21:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:38:54 INFO - Installing collected packages: blobuploader, requests, docopt 21:38:54 INFO - Running setup.py install for blobuploader 21:38:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:38:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:38:54 INFO - Running setup.py install for requests 21:38:55 INFO - Running setup.py install for docopt 21:38:55 INFO - Successfully installed blobuploader requests docopt 21:38:55 INFO - Cleaning up... 21:38:55 INFO - Return code: 0 21:38:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:55 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 0x10ba63b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba66768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9c3478a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, '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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:38:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:38:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:55 INFO - 'HOME': '/Users/cltbld', 21:38:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:55 INFO - 'LOGNAME': 'cltbld', 21:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:55 INFO - 'MOZ_NO_REMOTE': '1', 21:38:55 INFO - 'NO_EM_RESTART': '1', 21:38:55 INFO - 'PAGER': '/bin/cat', 21:38:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:55 INFO - 'PWD': '/builds/slave/test', 21:38:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:55 INFO - 'SHELL': '/bin/bash', 21:38:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:38:55 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:55 INFO - 'USER': 'cltbld', 21:38:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:55 INFO - 'XPC_FLAGS': '0x0', 21:38:55 INFO - 'XPC_SERVICE_NAME': '0', 21:38:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:55 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-dzJHAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:55 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-RTv5An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:55 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-LopaXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:55 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-1HsUeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:55 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-flSZ5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-vT_EOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-CzNAxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-BiWosq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-6kak7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-oBbt_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-niKj3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-29SOeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Of4dTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-qbujRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-FaokSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:57 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-_jBUH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:57 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-AnD9qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:38:57 INFO - Running setup.py install for manifestparser 21:38:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:38:57 INFO - Running setup.py install for mozcrash 21:38:57 INFO - Running setup.py install for mozdebug 21:38:57 INFO - Running setup.py install for mozdevice 21:38:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:38:57 INFO - Running setup.py install for mozfile 21:38:58 INFO - Running setup.py install for mozhttpd 21:38:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:38:58 INFO - Running setup.py install for mozinfo 21:38:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:38:58 INFO - Running setup.py install for mozInstall 21:38:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:38:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:38:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:38:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:38:58 INFO - Running setup.py install for mozleak 21:38:58 INFO - Running setup.py install for mozlog 21:38:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:38:58 INFO - Running setup.py install for moznetwork 21:38:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:38:58 INFO - Running setup.py install for mozprocess 21:38:59 INFO - Running setup.py install for mozprofile 21:38:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:38:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:38:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:38:59 INFO - Running setup.py install for mozrunner 21:38:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:38:59 INFO - Running setup.py install for mozscreenshot 21:38:59 INFO - Running setup.py install for moztest 21:38:59 INFO - Running setup.py install for mozversion 21:38:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:38:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:38:59 INFO - Cleaning up... 21:38:59 INFO - Return code: 0 21:38:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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')]} 21:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:59 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 0x10ba63b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba66768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9c3478a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, '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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:38:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:38:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:59 INFO - 'HOME': '/Users/cltbld', 21:38:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:59 INFO - 'LOGNAME': 'cltbld', 21:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:59 INFO - 'MOZ_NO_REMOTE': '1', 21:38:59 INFO - 'NO_EM_RESTART': '1', 21:38:59 INFO - 'PAGER': '/bin/cat', 21:38:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:59 INFO - 'PWD': '/builds/slave/test', 21:38:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:59 INFO - 'SHELL': '/bin/bash', 21:38:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:38:59 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:38:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:59 INFO - 'USER': 'cltbld', 21:38:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:59 INFO - 'XPC_FLAGS': '0x0', 21:38:59 INFO - 'XPC_SERVICE_NAME': '0', 21:38:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:39:00 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-8AdCI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:39:00 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-lK29JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:39:00 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)) 21:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:39:00 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-O2Z0P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:39:00 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-PRCtIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:39:00 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)) 21:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:39:00 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-igI53M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:39:00 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-V_ZH3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:39:00 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-pChjrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:39:00 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-BhKw7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:39:00 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-tgKl8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:39:01 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-WzG9AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:39:01 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-whBz7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:39:01 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-J10pdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:39:01 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)) 21:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:39:01 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-sCDAWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:39:01 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Q1ajTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:39:01 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)) 21:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:01 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-h6pNR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:39:01 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-50ajFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:39:01 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)) 21:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:39:01 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-11GW_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:39:01 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)) 21:39:01 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)) 21:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:39:01 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)) 21:39:01 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)) 21:39:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:05 INFO - Downloading blessings-1.6.tar.gz 21:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:39:05 INFO - Installing collected packages: blessings 21:39:05 INFO - Running setup.py install for blessings 21:39:05 INFO - Successfully installed blessings 21:39:05 INFO - Cleaning up... 21:39:05 INFO - Return code: 0 21:39:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:39:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:39:06 INFO - Reading from file tmpfile_stdout 21:39:06 INFO - Current package versions: 21:39:06 INFO - blessings == 1.6 21:39:06 INFO - blobuploader == 1.2.4 21:39:06 INFO - docopt == 0.6.1 21:39:06 INFO - functools32 == 3.2.3-2 21:39:06 INFO - jsonschema == 2.5.1 21:39:06 INFO - manifestparser == 1.1 21:39:06 INFO - mozInstall == 1.12 21:39:06 INFO - mozcrash == 1.0 21:39:06 INFO - mozdebug == 0.1 21:39:06 INFO - mozdevice == 0.50 21:39:06 INFO - mozfile == 1.2 21:39:06 INFO - mozhttpd == 0.7 21:39:06 INFO - mozinfo == 0.9 21:39:06 INFO - mozleak == 0.1 21:39:06 INFO - mozlog == 3.4 21:39:06 INFO - moznetwork == 0.27 21:39:06 INFO - mozprocess == 0.25 21:39:06 INFO - mozprofile == 0.28 21:39:06 INFO - mozrunner == 6.13 21:39:06 INFO - mozscreenshot == 0.1 21:39:06 INFO - mozsystemmonitor == 0.3 21:39:06 INFO - moztest == 0.8 21:39:06 INFO - mozversion == 1.4 21:39:06 INFO - psutil == 3.1.1 21:39:06 INFO - requests == 1.2.3 21:39:06 INFO - wsgiref == 0.1.2 21:39:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:06 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 0x10ba63b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba66768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9c3478a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, '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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:39:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:39:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:39:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:39:06 INFO - 'HOME': '/Users/cltbld', 21:39:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:39:06 INFO - 'LOGNAME': 'cltbld', 21:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:06 INFO - 'MOZ_NO_REMOTE': '1', 21:39:06 INFO - 'NO_EM_RESTART': '1', 21:39:06 INFO - 'PAGER': '/bin/cat', 21:39:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:06 INFO - 'PWD': '/builds/slave/test', 21:39:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:39:06 INFO - 'SHELL': '/bin/bash', 21:39:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:39:06 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:39:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:39:06 INFO - 'USER': 'cltbld', 21:39:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:39:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:06 INFO - 'XPC_FLAGS': '0x0', 21:39:06 INFO - 'XPC_SERVICE_NAME': '0', 21:39:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:39:06 INFO - Cleaning up... 21:39:06 INFO - Return code: 0 21:39:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:06 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 0x10ba63b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba66768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9c3478a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, '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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:39:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:39:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:39:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:39:06 INFO - 'HOME': '/Users/cltbld', 21:39:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:39:06 INFO - 'LOGNAME': 'cltbld', 21:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:06 INFO - 'MOZ_NO_REMOTE': '1', 21:39:06 INFO - 'NO_EM_RESTART': '1', 21:39:06 INFO - 'PAGER': '/bin/cat', 21:39:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:06 INFO - 'PWD': '/builds/slave/test', 21:39:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:39:06 INFO - 'SHELL': '/bin/bash', 21:39:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:39:06 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:39:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:39:06 INFO - 'USER': 'cltbld', 21:39:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:39:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:06 INFO - 'XPC_FLAGS': '0x0', 21:39:06 INFO - 'XPC_SERVICE_NAME': '0', 21:39:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:39:06 INFO - Cleaning up... 21:39:06 INFO - Return code: 0 21:39:06 INFO - Running post-action listener: _resource_record_post_action 21:39:06 INFO - Running post-action listener: _start_resource_monitoring 21:39:06 INFO - Starting resource monitoring. 21:39:06 INFO - [mozharness: 2017-04-25 04:39:06.677605Z] Finished create-virtualenv step (success) 21:39:06 INFO - [mozharness: 2017-04-25 04:39:06.678544Z] Running install step. 21:39:06 INFO - Running pre-action listener: _resource_record_pre_action 21:39:06 INFO - Running main action method: install 21:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:39:06 INFO - Reading from file tmpfile_stdout 21:39:06 INFO - Detecting whether we're running mozinstall >=1.0... 21:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:39:07 INFO - Reading from file tmpfile_stdout 21:39:07 INFO - Output received: 21:39:07 INFO - Usage: mozinstall [options] installer 21:39:07 INFO - Options: 21:39:07 INFO - -h, --help show this help message and exit 21:39:07 INFO - -d DEST, --destination=DEST 21:39:07 INFO - Directory to install application into. [default: 21:39:07 INFO - "/builds/slave/test"] 21:39:07 INFO - --app=APP Application being installed. [default: firefox] 21:39:07 INFO - mkdir: /builds/slave/test/build/application 21:39:07 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'] 21:39:07 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 21:39:27 INFO - Reading from file tmpfile_stdout 21:39:27 INFO - Output received: 21:39:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:39:27 INFO - Running post-action listener: _resource_record_post_action 21:39:27 INFO - [mozharness: 2017-04-25 04:39:27.157420Z] Finished install step (success) 21:39:27 INFO - [mozharness: 2017-04-25 04:39:27.157542Z] Running run-tests step. 21:39:27 INFO - Running pre-action listener: _resource_record_pre_action 21:39:27 INFO - Running main action method: run_tests 21:39:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:39:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:39:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:39:27 INFO - 2017-04-24 21:39:27.172 screenresolution[1627:7355] starting screenresolution argv=screenresolution get 21:39:27 INFO - 2017-04-24 21:39:27.174 screenresolution[1627:7355] Display 0: 1600x1200x32@60 21:39:27 INFO - 2017-04-24 21:39:27.180 screenresolution[1628:7358] starting screenresolution argv=screenresolution list 21:39:27 INFO - Available Modes on Display 0 21:39:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:39:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:39:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:39:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:39:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:39:27 INFO - Intel Iris: 21:39:27 INFO - Chipset Model: Intel Iris 21:39:27 INFO - Type: GPU 21:39:27 INFO - Bus: Built-In 21:39:27 INFO - VRAM (Dynamic, Max): 1536 MB 21:39:27 INFO - Vendor: Intel (0x8086) 21:39:27 INFO - Device ID: 0x0a2e 21:39:27 INFO - Revision ID: 0x0009 21:39:27 INFO - Displays: 21:39:27 INFO - Display: 21:39:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:39:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:39:27 INFO - Display Serial Number: 1600x1200 60 21:39:27 INFO - Main Display: Yes 21:39:27 INFO - Mirror: Off 21:39:27 INFO - Online: Yes 21:39:27 INFO - Rotation: Supported 21:39:27 INFO - Return code: 0 21:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:39:27 INFO - Python 2.7.3 21:39:27 INFO - Return code: 0 21:39:27 INFO - grabbing minidump binary from tooltool 21:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:27 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 0x10b841d30>, '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 0x10b767db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b836be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:39:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:39:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 21:39:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:39:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:39:27 INFO - Return code: 0 21:39:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:39:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:39:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:39:27 INFO - ENV: RUST_BACKTRACE is now 1 21:39:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:39:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:39:27 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/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:39:27 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/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0164 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:39:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XFdVXHPjV/Render', 21:39:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:39:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:39:27 INFO - 'HOME': '/Users/cltbld', 21:39:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:39:27 INFO - 'LOGNAME': 'cltbld', 21:39:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:39:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:27 INFO - 'MOZ_NO_REMOTE': '1', 21:39:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:39:27 INFO - 'NO_EM_RESTART': '1', 21:39:27 INFO - 'PAGER': '/bin/cat', 21:39:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:27 INFO - 'PWD': '/builds/slave/test', 21:39:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:39:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:39:27 INFO - 'RUST_BACKTRACE': '1', 21:39:27 INFO - 'SHELL': '/bin/bash', 21:39:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zmUNSBIhJl/Listeners', 21:39:27 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 21:39:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:39:27 INFO - 'USER': 'cltbld', 21:39:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:39:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:27 INFO - 'XPC_FLAGS': '0x0', 21:39:27 INFO - 'XPC_SERVICE_NAME': '0', 21:39:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:39:27 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/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:39:27 INFO - mozversion application_buildid: 20170424202225 21:39:27 INFO - mozversion application_changeset: 85932a5027c024900bb0e58cdbc52ecf9a32e1f5 21:39:27 INFO - mozversion application_display_name: Nightly 21:39:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:39:27 INFO - mozversion application_name: Firefox 21:39:27 INFO - mozversion application_remotingname: firefox 21:39:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:39:27 INFO - mozversion application_vendor: Mozilla 21:39:27 INFO - mozversion application_version: 55.0a1 21:39:27 INFO - mozversion platform_buildid: 20170424202225 21:39:27 INFO - mozversion platform_changeset: 85932a5027c024900bb0e58cdbc52ecf9a32e1f5 21:39:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:39:27 INFO - mozversion platform_version: 55.0a1 21:39:27 INFO - using testdate: 1493095167 21:39:27 INFO - actual date: 1493095167 21:39:27 INFO - starting webserver on 'localhost:49249' 21:39:27 INFO - SUITE-START | Running 2 tests 21:39:27 INFO - TEST-START | dromaeo_css 21:39:27 INFO - operating with platform_type : mac_ 21:39:27 INFO - Initialising browser for dromaeo_css test... 21:39:27 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpZLfMfI/profile http://localhost:49249/getInfo.html) 21:39:30 INFO - PID 1638 | 2017-04-24 21:39:30.536 plugin-container[1640:7542] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9743, name = 'com.apple.tsm.portname' 21:39:30 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:39:30 INFO - PID 1638 | 2017-04-24 21:39:30.539 plugin-container[1640:7542] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9927, name = 'com.apple.CFPasteboardClient' 21:39:30 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:39:30 INFO - PID 1638 | 2017-04-24 21:39:30.540 plugin-container[1640:7542] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:39:30 INFO - PID 1638 | __metrics Screen width/height:1600/1200 21:39:30 INFO - PID 1638 | colorDepth:24 21:39:30 INFO - PID 1638 | Browser inner width/height: 1024/689 21:39:30 INFO - PID 1638 | __metrics 21:39:30 ERROR - PID 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3414: TypeError: this.tabs is undefined 21:39:31 INFO - TEST-INFO | 1638: exit 0 21:39:31 INFO - Browser initialized. 21:39:31 INFO - Running cycle 1/1 for dromaeo_css test... 21:39:31 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpZLfMfI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:33 INFO - PID 1641 | 2017-04-24 21:39:33.994 plugin-container[1642:7674] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 21:39:33 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:39:33 INFO - PID 1641 | 2017-04-24 21:39:33.995 plugin-container[1642:7674] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 21:39:33 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:39:33 INFO - PID 1641 | 2017-04-24 21:39:33.995 plugin-container[1642:7674] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:39:43 INFO - PID 1641 | RSS: Main: 236056576 21:39:43 INFO - PID 1641 | 21:42:48 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 21:42:50 INFO - PID 1641 | RSS: Main: 252203008 21:42:50 INFO - PID 1641 | 21:44:32 INFO - PID 1641 | ************************* 21:44:32 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 21:44:32 INFO - PID 1641 | 21:44:32 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:44:32 INFO - PID 1641 | Full stack: 21:44:32 INFO - PID 1641 | ************************* 21:44:32 INFO - PID 1641 | ************************* 21:44:32 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 21:44:32 INFO - PID 1641 | 21:44:32 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:44:32 INFO - PID 1641 | Full stack: 21:44:32 INFO - PID 1641 | ************************* 21:44:32 INFO - PID 1641 | ************************* 21:44:32 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 21:44:32 INFO - PID 1641 | 21:44:32 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:44:32 INFO - PID 1641 | Full stack: 21:44:32 INFO - PID 1641 | ************************* 21:44:32 INFO - PID 1641 | ************************* 21:44:32 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 21:44:32 INFO - PID 1641 | 21:44:32 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:44:32 INFO - PID 1641 | Full stack: 21:44:32 INFO - PID 1641 | ************************* 21:45:51 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 21:45:52 INFO - PID 1641 | RSS: Main: 256491520 21:45:52 INFO - PID 1641 | 21:48:54 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 21:48:54 INFO - PID 1641 | RSS: Main: 265768960 21:48:54 INFO - PID 1641 | 21:51:56 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 21:51:57 INFO - PID 1641 | RSS: Main: 259469312 21:51:57 INFO - PID 1641 | 21:55:00 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 21:55:00 INFO - PID 1641 | RSS: Main: 271646720 21:55:00 INFO - PID 1641 | 21:58:02 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 21:58:02 INFO - PID 1641 | RSS: Main: 266596352 21:58:02 INFO - PID 1641 | 21:58:02 INFO - PID 1641 | __start_tp_report 21:58:02 INFO - PID 1641 | _x_x_mozilla_page_load 21:58:02 INFO - PID 1641 | _x_x_mozilla_page_load_details 21:58:02 INFO - PID 1641 | |i|pagename|runs| 21:58:02 INFO - PID 1641 | |0;dojo.html;3027.6064111665482;3052.526858336957;3613.313470440618;3626.7279954003457;3673.944890826637;6104.206453161083;6233.906491402627;6269.435750782429;6270.686465676721;6303.779367722131;6167.722452489637;6211.161493198417;6224.408681175292;6263.780767673133;6323.114763933041;4597.057603191354;5224.29472021278;5467.9453205468035;5484.012877682016;5600.6079574429805;5036.6222533309965;5354.785808567672;5424.0236757383655;5458.536024437927;5567.220589117527;4472.955270447319;5394.6493477924205;5492.505674489275;5516.172574113875;5573.4147914469;4562.247229207177;5477.643953143033;5493;5498.147787093007;5524.723763811793;5436.972815135899;5437.075697131497;5454.290942177491;5454.863628409282;5472.562195024429;6106.794380079854;6167.84580385494;6226.1905952225925;6299.181106456132;6304.558680892339;6626.834329141761;6667.166604174478;6687.598744075371;6691.4312283455965;6693;6715.059891615178;6757.662116894136;6761.323867613249;6776.457883369368;6780.321967803229;6134.987697083746;6147.262328520516;6363.42729154369;6369.33122022181;6374.521910856658;6483.546151769331;6504.577202481823;6864.073350097673;6952.339527744957;6965.094537710065;6280.183576135165;6361.650109243943;6373.107764912916;6429.099926010363;6613.669316534154;5524.281843360337;5907.054871220584;6620.337966203341;6634.402903738686;6695.665216739144;6007.429294217042;6596.175478065242;6596.571222870498;6620.9006864897065;6641.103451034145;5460.563154947595;6365.077063825719;6394.424501794768;6597.703103360361;6626.569272997336;5309.2036194570355;5314.1497360422145;5322.973385133049;5343.064963631349;5365.195220716923;4737.786799594027;4744.97982933664;4769.833055843098;4778.880527986758;4824.0834241494;5120;5170.431252562215;5507.421720719347;6217;6373;6770.390664840188;6793;6804.931950680529;6807.965960170168;6812.046313516112;6238.563300568917;6356.078368636522;6356.523260755462;6375.043743438521;6392.808215753535;5747.252857128547;5818.069108942634;6000.849978750566;6003.0695242237525;6030.18592490017;6801.18385793708;6810.284920083518;6918.342757438036;6961.930380696331;6979.720811167496;6779.288174741779;6791.117154769849;6795.456363491007;6802.217744959393;6809.489288303298;6976.5465244758925;6991.825204369931;6998.370146686822;7011;7025.297470253138;6388.9041664376;6497.480201583957;6575.849226385268;6624.635645039569;6683.699233534406;5933.940660593339;6663.200415949923;6702.430293425114;6703.262641109376;6717.56335838169;5376.623636345575;6163.397516645615;6302.5588208826775;6309.1167236586;6489.091527186103;6307.211598550181;6488.935110649022;6499.28507864144;6505.479561634963;6510.44661203784;6309.684515774101;6331.778387756406;6333.429991300621;6366.93633063682;6403.679816009274;6503.479721622353;6525;6526.641034743135;6535.0197470377925;6540.705668245036;5266.789328426973;5359.651622644516;6110.625109350361;6354;6359.968200159155 21:58:02 INFO - PID 1641 | |1;ext.html;684.7295318349252;742.6992068212376;814.1126172472004;1234.8765123487653;1248.744007478467;30081;35644.82177589115;36251.637483625156;37535.81232093843;37659.87020389389;37197.44203836938;37524.43713344295;37581.24837503248;37604.43593346102;37665.870023899326;7312.707491700326;7879.8030049248655;8021.518708877456;8669.826603467927;8679.826403471927;8579.742607721779;8606.010308814473;8683.435576687496;8685.478871267713;8711.259542938826;8649.443100241953;8654.783630409227;8698.56507174642;8707.521086340248;8715.041345451995;8662.52356120413;8700.303975681962;8703.216710496023;8708.869366959501;8710.172533609297;8499.235068843835;8545.2309292164;8550;8560.48637081777;8581.52801595912;36765.63234367649;36863.4470482943;36948.815255923546;36964.44553331702;36988;3601.1717305019993;3614.493970844084;3634.5638523377365;3640.3629364861044;3644.344018076745;30318;30480.8475957621;30595.08214753561;30603.69396306031;30679.846600766854;3083.198368424226;3139.1053549738444;3150.1179669692524;3151.4800057990406;3165.1612322734495;285347;286638;292907;295740;297981;47181.76409117933;47258.29112563314;47297.763511182224;47382.28926566104;47421.288680669815;49580.50419495759;49611.26360577362;52760.73619631877;53483;53534.464655353724;13789;13909.652258693613;13918;13920.58238252854;13951.511697090553;10956.726081848017;11035.227534072537;11039.448027598588;11061.723456913642;11070.169737269576;11674.299542027506;13558.576349483359;14026.789598156036;14027.649308767159;14059.297035148405;5115.437301896788;6125.1731016313115;6131.63210207389;6136.23297087864;6162.168107305456;875.3959767760225;979.2361957673027;993.3989936088562;1010.3180353261519;1021.8109649714678;24042.87978560096;24209.515809683708;24366.512669746506;24378.878105609358;24429.877850610632;1018.6892997635643;1070.1706177712335;1073.1146803886825;1107.2194103157256;1108.9722756931142;10675.252732308663;12124.5144745327;12446.06654500916;12509.186902851285;12560.497580096693;320375;320568;320796;320853;322666;53145.93708125816;53458.46541534535;53460;53491.465085348646;53519;1491.7091167222504;1502.278906125066;1538.9307481163376;1539.6766678997535;1568.8823338249676;20868.68696969577;22937.655935160652;24015.879920600284;24108.39729006789;24151.637725433782;38106;38180.6181938177;38208.51644643089;38362;38457.615423845404;216932.83067169756;271215;271792;272106;272315;34352;34935.12662183364;35005.47491787676;35162.47256291106;35174.47238291479;35370;44034.33948490711;44180.55819441893;44317;44364;29133;29490.967816126333;30754.53868191934;30834.383312334077;30872;29978.70021299759;30542;30737.38525229438;30863.9938404003;30926.22684432907;36249.456258155624;36283.637163628024;36839.63160368362;36912;37159.442608360354;28094.578581321704;30200;30515.93194238191;30833.383332333677;31342.216444588157;19544.609107818047;20408.693869592265;22556.887215563816;22647.547049059256;24505.264842054767 21:58:02 INFO - PID 1641 | |2;jquery.html;423.087958527654;426.34343111608126;430.7443801319156;442.9357743127247;449.64253418532263;20664.17343306268;20962.580748385062;21020.264290749827;21166.576668466623;21532.89233553832;20899.895500522514;21655.808930508814;22178.889105554448;22245.332640020824;22472.9887155078;5595.804146854861;6093.385252907972;6304.306526282106;6305.33793951633;6305.495560355161;6002.849928751794;6169.321374648785;6234.906476402857;6251.187345645082;6252.562320637558;5979.282486101674;6140.447359737623;6197.070439434098;6199.845003874917;6211.440970312671;6090.33006369299;6112.6638034908065;6152.907706384408;6164.137020817089;6180.165677633529;5236.947630523684;5384.40771515133;5437;5464.672119672832;5471.179323101566;25544.74455255442;25553.361165970815;25555.872220638965;25672.614910776352;25982.22053338403;2232.464208589943;2292.6446400807736;2305.7694230576976;2306.2274138163734;2308.5844547981355;17086;17098.743518847226;17212.74180887275;17735.822641773546;17987.640247194984;2147.7744836792226;2187.57342318248;2209.6133176694175;2218.0905828610353;2223.3107736601705;127246;128092;128997;129945;130045;11654.53381864716;11912.52349905994;11920.821187682192;11926.284422934652;12027.27836329823;12714.364281786058;14146.504872329419;15320.463783767515;15490;15527;7977.3618110551015;8356.623951922178;8620.137986201455;8694.608742606599;8729.083446238054;6820.6930688119155;8109.391795615353;8123.878141827878;8144.796380090426;8284.917150828534;7426.517276377018;7512.812179695551;7547.396208303323;7561;7594.392448604209;2110.2297661353496;2133.0934352899953;2133.658614621653;2134.935951921445;2135.2419890938804;946.5882341181608;947.9715608531756;958.4776296918196;996.3025881882711;1024.5901639344172;15241.847581524265;20201.49496262576;20394.184232630527;20866.47833804167;20923.79076209249;1019.1948360794889;1027.1525991057408;1056.6090546497844;1062.3148069495287;1063.1972860490434;10380.858105608377;10692.946535267274;10777.030067293981;10853.294535855144;10859.945700271606;449424;542380;542731;543098;575684;115831;117461;118902.405487972;121584;122103;1155.0701292578365;1162.2213117211488;1203.7712834561405;1209.2019267283551;1209.2683926224684;17641.382551610634;17753.201105950004;17811.081562056326;17878.91060544689;17992.640147197246;52521;53698;55153.1727024103;55502.444975549726;56253.87492250214;63957.04064438944;64952;65638;66388.33611663821;66534;8473.195046470575;8483.194096560817;8501.0223824261;8920.910790892009;8956.507392093497;12187.329696866404;13338.666533336744;13741.175529468264;13753.931230343784;13802.861971380158;7773.883391749241;10618;10732.678019659423;10867.239293249713;10940.124790016938;10534.209934254808;11053.72365690832;11247.325160490396;11252.156088293246;11273.379964102052;11810.704732381415;11962.58130965412;12121.878781212075;12153.574624888086;12215.38923053826;6242.438180563771;8660.527710289392;8853.867191991996;8864.73405797827;8881.467111973303;9159.496227707274;11124.618849273482;11928.940355298168;11971.281723096294;12009.63971080869 21:58:02 INFO - PID 1641 | |3;mootools.html;1393.5540626999357;1433.6845893903344;1445.8554144585537;1450.7968884356192;1458.5551406820919;11472.02487788538;11797.587084452045;11821.468033938472;11965.999999999989;12216.694582635439;11839.644810655695;11859.288442693445;12036.277823330607;12036.879631203685;12044.93977530111;2279.943001424961;2449.510097980411;2508.41052352697;2529.6964364276314;2545.172818833877;2484.900603975848;2526.077981536735;2545.859977701235;2549.73227811079;2556.6292887531295;2482.863442510661;2489.850608963468;2523.1673547729206;2525.8863351149243;2530.582453895105;2469.2839076667747;2493.501299740059;2520.5337012652626;2520.911768088108;2520.936976575582;2112.9118503970467;2428.805695544352;2517.609770485578;2517.8237523373373;2520.773130418271;9627.374220675703;11672.649820505398;11849.229800062969;11878.88121118795;11902.166848320621;6151.323354431009;6700.363465470821;6779.864402711967;6797.864042719168;6801.4898882584;3619.855205791765;3992.6207010333974;4088.407180958774;4093.263212621727;4283.65730741543;1245.8255844181822;1249.9999999999964;1276.8212450256972;1291.4446787881207;1293.5989843148654;13158.342082895817;14606.05060671053;16160.27278772458;16774.245158967875;16814.663706725798;4885;5006.374203224597;5930.229070220844;6179;6217.067439883963;14105.294735263402;14142.080764750259;14148.221847798264;14169.645758856112;14176.503822366167;6839.726410943606;6885.139357580302;6906.723731050803;6913.5506192097355;6915.965420172867;6043.335233124353;6158.291796443466;6297.1813664223355;6308.432241098323;6330.05049242608;4184.456020717348;4577.404937358122;4753.786079626425;4791.137595232822;4810.013947140827;1265.677252300676;1283.0633637444719;1441.3009690300196;1486.814148231471;1493.6788590453104;791.8614242507538;797.0316065979862;809.2433574607643;809.554744890308;825.2407784837964;6116.66358350295;6117.418845209698;6260.5617606768;6346;6421;582.1151849189208;588.2294194605081;588.7733222709202;596.7463827873137;597.7877853361994;3781.2815565042556;3838.405047217686;3856.652901238902;3863.8022213114023;3913.5890731473355;14323.997320187695;14723.043002204822;14944.252787360589;15236;15328.23358832054;14572.562823115111;14671.266436678337;14742.63143421423;14874.851251487564;14944.476943306932;8452.112528184574;8483.787905302293;8571.699990500303;8635.438696484709;8727.519986400936;5674.77300907959;6891.310868913069;6964.26875178099;7013.859722805413;7101.325374089453;13402.32988350559;13514.93242533781;13520.59438216855;13555.59333220005;13578.185308881499;13550.457981680622;13613;13838.723225535634;13920.930395347958;14078.296085195494;9545.761355966157;9564.56959436841;9625.32622716403;9649.662261820802;9765.414075155513;10462.21533384984;10785;10855.565777368816;10861.728456788644;10876;8998.280137588847;9125.31560133006;9221.723348299294;9275.07249275067;9304.488253145872;8933.19601235892;8954.238889694449;9004.234640055669;9023.864642030243;9194.448333100036;8144.714934977247;8207;8330.416870818985;8349.165083491602;8354;6056.9091463628965;6057.333693293822;6140.109684095871;6206.193194884636;6282.874342513215;5966.313873904556;6021.855847389157;6047.637141771508;6218.844528886814;6378.138951241709 21:58:02 INFO - PID 1641 | |4;prototype.html;382.581073724272;392.184187213203;403.3626869546117;406.84539874847565;414.8838325268925;5356.169793681981;5618.381977982429;5958.523318134549;6173.197484327036;6255.468285195758;5137.768800403981;5549.472800083996;5685.488306052454;5733.369329373765;5882.558703158657;3760.7179461540495;4075.225707115646;4487.137837797311;4499.595036446719;4500.347449619803;3725.7764534127905;4369.847055353063;4402.295632698769;4471.128130014648;4509.346144809001;4445.555444455561;4447.976965297983;4455.777211139446;4457.554244575533;4458.621017213524;3299.7690161688693;3836.865709700175;4404.647628189737;4424.867253982386;4439.067795762894;3186.2353035271367;3757.830897609614;3822.8279727412055;3856.67218286446;3880.825362858678;5448.972755136238;5812.372535690013;5875.324337701134;5920.585559010828;5962.314333851619;4975.626827987915;5297.12597421425;5307.761150748225;5307.991481618519;5341.67949923002;6078.300995385543;6288.937110628926;6378.936210637927;6434.163558737381;6462.547621666486;4014.1770936957855;4322.2436073687295;4333.739975601474;4356.499002614676;4357.6078152966065;5668.603197776158;6480.578762380477;6685.799426017227;6935.930640693629;6949.131358580177;4409.977950110229;4425.977870110629;4426.092651006536;4457.955420445754;4466.888327791831;4509.255972764523;4520.728756274634;4522.615577675869;4532.773361331921;4534.9342904417435;4426.712263702849;4459.420275364247;4842.201036828884;5250.894982100413;5313.867153321198;6495.577787443801;6504.121943537656;6521.087347591407;6533.705983230766;6550.574212676161;1536.5159974607964;1546.7834503169565;1548.4967385599725;1548.907065576069;1554.098622798774;975.1370037516849;1019.5717798524637;1022.1771473963382;1024.4314405505015;1036.3315661398506;4950.861301900511;5500.972495137578;5529.30883639545;5986.132010858489;6248.31268560458;6408.327125651833;6701.430378417792;6778.322167783281;6785.660716964132;6793.879009963301;5080.288759573663;5192.766325515361;5243.397009343898;6248.31268560458;6293.30773614902;3502.476422756109;3527.4885141654318;3541.575010998645;3546.184377593168;3567.696745776638;5940.34656187819;6012.368701286389;6882.7591034313555;7069.399101076363;7174.058635959232;6978.895316570255;7042.084529011298;7069.6111713856235;7080.433565314763;7117.608531530712;6355;6380.617162970237;6555.3772391622715;6975.546589471668;7064.646767661699;6188.44304012641;6799.558028728117;6809.9570128962105;6825.931740682529;6906.516543841883;6478.449331806849;6670.099536562502;6673.199216093905;6704.664766761545;6710.4631629470505;5785.611453251274;5972.611780234271;7060.576365417885;7092.326229008236;7114.1463024435325;4453.821847126079;4454.901490628565;4474.37358769779;4476.440444944382;4480.955190448184;6420.55056146084;6692.564983276072;6723.327667233433;6771.424428923399;6805.557638753465;5730.879574557273;6547.934520654923;6556.737730490727;6580.144581204413;6594.670266486561;4801.927971080367;6512.088307637029;6522.021696745526;6556.2788093308745;6573.835654108494;6464.903026454701;6475.190601174853;6476.481881449378;6483.222013358239;6495.512836537184;4862;6137.570370074052;6252.374762523711;6558.508111891722;6593.3736295051895;5371.919421208607;5412.296401467784;6362.586431881913;6374.012028135647;6415.166028416463 21:58:02 INFO - PID 1641 | |5;yui.html;679.6533767778433;813.6501304439089;828.1842385250527;856.8157846063098;857.6783706110209;14587.416503339853;15225.23873806308;16471;16937.814352995294;16943.15284235788;14370.425182992667;14440.277986100706;16726;17613.383531576397;17662;853.5945425922699;868.7133246028811;926.1248120526105;938.7183844846553;942.9339946203769;969.1132613658494;970.0202795176887;970.1608108985747;971.9125278724913;976.8144052630013;973.2797729680057;1012.7670635753781;1016.9694909152737;1016.983016983017;1022.0137567247605;1008.9243306751986;1013.027493606139;1013.5185786751308;1014.9847752283722;1024.2830018986701;728.1989811207682;732.7398773435407;737.5685224143882;739.2755100002028;739.3198257603018;16346.34614615414;16696.58258543534;16823.579410514834;17188;17397;16773.91613041939;16889.746653800205;17081.57296067596;17107.289271072917;17284.39504617345;13780.173189608655;13969.441222351094;14009.229492377915;14071.366788494543;14130.858691413057;3532.311199316134;3551.627079156703;3551.786892786441;3558.768680035815;3560.1099725068734;88729.55635221847;119639.80360196374;121215;121451.39274303571;134336;13264.801027984588;13701.45194192221;13710;13804.93097534506;13814.654633634038;23492.942817572908;23658.171963981524;25325.8733706334;25332.873335633572;25389.74610253911;7627.351675107567;7925.643346049442;7940.245676660708;7957.721479748181;7959.403044771665;3970.642642162219;4034.3948407739076;4055.756654600674;4057.736247143926;4061.0659548304056;4252.9367658085475;4277.973286411239;4389.18800021997;4420.138073075719;4425.535318791545;757.3070640364006;813.772143799737;845.9636944742641;856.208007592974;857.9099194584603;633.2243002322118;647.5402464250435;657.1621182991723;664.3854434647932;690.7237105157876;10790.838137427945;11489;11699.473523691455;11981.58064467757;12160.939195303967;644.5037321262602;647.5564238496551;653.5196630476596;655.2301046270613;675.9691470507418;4391.824327026883;4846.616340105727;4891.997140586172;5278.868028299246;5453.809116680897;102532.48733756284;107121.39317910082;107510;109838;111920.44039779749;95388.0461195393;100037.49981250048;101311.42787146631;102248;102612;64187.03719444212;92894.53552732329;92998.53500732454;93118;94356.52821735985;9562.95218523903;9812.313138080266;10968.451577420938;10990.945045274722;11119.83320250213;45700.57245706652;45922.08155836931;45955.770221150015;46025.76987115043;46442.07115857732;55685.72157139351;56052.43947560472;56316.71841640765;56386.718066409405;57408.42591574198;13708.86291137076;14011.579652610439;16542.255598498337;16958.915205423895;17268.136593170544;15222;18557.09033091545;18724.625507490047;18817.529561761065;18826.529336766143;16536.503904882873;16537.421190258283;17310.9613423195;17356.65286694234;17462.82537174612;16530.752038719187;16558.503244902673;17049.40327088546;17061.48815535536;17117.716171286953;16101.919490402473;16441.835581644507;16595;16912.32350705958;16928.49214523566;11912.225705329125;12069.698257543632;12146.574869879865;12158.452869621065;12218.083643726579;13148;13314.733705326033;13568.118072325267;13610.727785444433;13754.793678094637 21:58:02 INFO - PID 1641 | __end_tp_report 21:58:02 INFO - PID 1641 | __start_cc_report 21:58:02 INFO - PID 1641 | _x_x_mozilla_cycle_collect,414 21:58:02 INFO - PID 1641 | __end_cc_report 21:58:02 INFO - PID 1641 | __startTimestamp1493096282673__endTimestamp 21:58:02 INFO - PID 1641 | 21:58:02 INFO - PID 1641 | ------- Summary: start ------- 21:58:02 INFO - PID 1641 | Number of tests: 6 21:58:02 INFO - PID 1641 | 21:58:02 INFO - PID 1641 | [#0] dojo.html Cycles:165 Average:6082.04 Median:6331.78 stddev:772.22 (12.2%) stddev-sans-first:736.48 21:58:02 INFO - PID 1641 | Values: 3027.6 3052.5 3613.3 3626.7 3673.9 6104.2 6233.9 6269.4 6270.7 6303.8 6167.7 6211.2 6224.4 6263.8 6323.1 4597.1 5224.3 5467.9 5484.0 5600.6 5036.6 5354.8 5424.0 5458.5 5567.2 4473.0 5394.6 5492.5 5516.2 5573.4 4562.2 5477.6 5493.0 5498.1 5524.7 5437.0 5437.1 5454.3 5454.9 5472.6 6106.8 6167.8 6226.2 6299.2 6304.6 6626.8 6667.2 6687.6 6691.4 6693.0 6715.1 6757.7 6761.3 6776.5 6780.3 6135.0 6147.3 6363.4 6369.3 6374.5 6483.5 6504.6 6864.1 6952.3 6965.1 6280.2 6361.7 6373.1 6429.1 6613.7 5524.3 5907.1 6620.3 6634.4 6695.7 6007.4 6596.2 6596.6 6620.9 6641.1 5460.6 6365.1 6394.4 6597.7 6626.6 5309.2 5314.1 5323.0 5343.1 5365.2 4737.8 4745.0 4769.8 4778.9 4824.1 5120.0 5170.4 5507.4 6217.0 6373.0 6770.4 6793.0 6804.9 6808.0 6812.0 6238.6 6356.1 6356.5 6375.0 6392.8 5747.3 5818.1 6000.8 6003.1 6030.2 6801.2 6810.3 6918.3 6961.9 6979.7 6779.3 6791.1 6795.5 6802.2 6809.5 6976.5 6991.8 6998.4 7011.0 7025.3 6388.9 6497.5 6575.8 6624.6 6683.7 5933.9 6663.2 6702.4 6703.3 6717.6 5376.6 6163.4 6302.6 6309.1 6489.1 6307.2 6488.9 6499.3 6505.5 6510.4 6309.7 6331.8 6333.4 6366.9 6403.7 6503.5 6525.0 6526.6 6535.0 6540.7 5266.8 5359.7 6110.6 6354.0 6360.0 21:58:02 INFO - PID 1641 | 21:58:02 INFO - PID 1641 | [#1] ext.html Cycles:180 Average:44159.05 Median:34643.56 stddev:76694.20 (221.4%) stddev-sans-first:76839.89 21:58:02 INFO - PID 1641 | Values: 684.7 742.7 814.1 1234.9 1248.7 30081.0 35644.8 36251.6 37535.8 37659.9 37197.4 37524.4 37581.2 37604.4 37665.9 7312.7 7879.8 8021.5 8669.8 8679.8 8579.7 8606.0 8683.4 8685.5 8711.3 8649.4 8654.8 8698.6 8707.5 8715.0 8662.5 8700.3 8703.2 8708.9 8710.2 8499.2 8545.2 8550.0 8560.5 8581.5 36765.6 36863.4 36948.8 36964.4 36988.0 3601.2 3614.5 3634.6 3640.4 3644.3 30318.0 30480.8 30595.1 30603.7 30679.8 3083.2 3139.1 3150.1 3151.5 3165.2 285347.0 286638.0 292907.0 295740.0 297981.0 47181.8 47258.3 47297.8 47382.3 47421.3 49580.5 49611.3 52760.7 53483.0 53534.5 13789.0 13909.7 13918.0 13920.6 13951.5 10956.7 11035.2 11039.4 11061.7 11070.2 11674.3 13558.6 14026.8 14027.6 14059.3 5115.4 6125.2 6131.6 6136.2 6162.2 875.4 979.2 993.4 1010.3 1021.8 24042.9 24209.5 24366.5 24378.9 24429.9 1018.7 1070.2 1073.1 1107.2 1109.0 10675.3 12124.5 12446.1 12509.2 12560.5 320375.0 320568.0 320796.0 320853.0 322666.0 53145.9 53458.5 53460.0 53491.5 53519.0 1491.7 1502.3 1538.9 1539.7 1568.9 20868.7 22937.7 24015.9 24108.4 24151.6 38106.0 38180.6 38208.5 38362.0 38457.6 216932.8 271215.0 271792.0 272106.0 272315.0 34352.0 34935.1 35005.5 35162.5 35174.5 35370.0 44034.3 44180.6 44317.0 44364.0 29133.0 29491.0 30754.5 30834.4 30872.0 29978.7 30542.0 30737.4 30864.0 30926.2 36249.5 36283.6 36839.6 36912.0 37159.4 28094.6 30200.0 30515.9 30833.4 31342.2 19544.6 20408.7 22556.9 22647.5 24505.3 21:58:02 INFO - PID 1641 | 21:58:02 INFO - PID 1641 | [#2] jquery.html Cycles:180 Average:33291.15 Median:2220.70 stddev:89362.31 (4024.1%) stddev-sans-first:89578.92 21:58:02 INFO - PID 1641 | Values: 423.1 426.3 430.7 442.9 449.6 20664.2 20962.6 21020.3 21166.6 21532.9 20899.9 21655.8 22178.9 22245.3 22473.0 5595.8 6093.4 6304.3 6305.3 6305.5 6002.8 6169.3 6234.9 6251.2 6252.6 5979.3 6140.4 6197.1 6199.8 6211.4 6090.3 6112.7 6152.9 6164.1 6180.2 5236.9 5384.4 5437.0 5464.7 5471.2 25544.7 25553.4 25555.9 25672.6 25982.2 2232.5 2292.6 2305.8 2306.2 2308.6 17086.0 17098.7 17212.7 17735.8 17987.6 2147.8 2187.6 2209.6 2218.1 2223.3 127246.0 128092.0 128997.0 129945.0 130045.0 11654.5 11912.5 11920.8 11926.3 12027.3 12714.4 14146.5 15320.5 15490.0 15527.0 7977.4 8356.6 8620.1 8694.6 8729.1 6820.7 8109.4 8123.9 8144.8 8284.9 7426.5 7512.8 7547.4 7561.0 7594.4 2110.2 2133.1 2133.7 2134.9 2135.2 946.6 948.0 958.5 996.3 1024.6 15241.8 20201.5 20394.2 20866.5 20923.8 1019.2 1027.2 1056.6 1062.3 1063.2 10380.9 10692.9 10777.0 10853.3 10859.9 449424.0 542380.0 542731.0 543098.0 575684.0 115831.0 117461.0 118902.4 121584.0 122103.0 1155.1 1162.2 1203.8 1209.2 1209.3 17641.4 17753.2 17811.1 17878.9 17992.6 52521.0 53698.0 55153.2 55502.4 56253.9 63957.0 64952.0 65638.0 66388.3 66534.0 8473.2 8483.2 8501.0 8920.9 8956.5 12187.3 13338.7 13741.2 13753.9 13802.9 7773.9 10618.0 10732.7 10867.2 10940.1 10534.2 11053.7 11247.3 11252.2 11273.4 11810.7 11962.6 12121.9 12153.6 12215.4 6242.4 8660.5 8853.9 8864.7 8881.5 9159.5 11124.6 11928.9 11971.3 12009.6 21:58:02 INFO - PID 1641 | 21:58:02 INFO - PID 1641 | [#3] mootools.html Cycles:180 Average:7177.33 Median:3809.84 stddev:4561.78 (119.7%) stddev-sans-first:4553.87 21:58:02 INFO - PID 1641 | Values: 1393.6 1433.7 1445.9 1450.8 1458.6 11472.0 11797.6 11821.5 11966.0 12216.7 11839.6 11859.3 12036.3 12036.9 12044.9 2279.9 2449.5 2508.4 2529.7 2545.2 2484.9 2526.1 2545.9 2549.7 2556.6 2482.9 2489.9 2523.2 2525.9 2530.6 2469.3 2493.5 2520.5 2520.9 2520.9 2112.9 2428.8 2517.6 2517.8 2520.8 9627.4 11672.6 11849.2 11878.9 11902.2 6151.3 6700.4 6779.9 6797.9 6801.5 3619.9 3992.6 4088.4 4093.3 4283.7 1245.8 1250.0 1276.8 1291.4 1293.6 13158.3 14606.1 16160.3 16774.2 16814.7 4885.0 5006.4 5930.2 6179.0 6217.1 14105.3 14142.1 14148.2 14169.6 14176.5 6839.7 6885.1 6906.7 6913.6 6916.0 6043.3 6158.3 6297.2 6308.4 6330.1 4184.5 4577.4 4753.8 4791.1 4810.0 1265.7 1283.1 1441.3 1486.8 1493.7 791.9 797.0 809.2 809.6 825.2 6116.7 6117.4 6260.6 6346.0 6421.0 582.1 588.2 588.8 596.7 597.8 3781.3 3838.4 3856.7 3863.8 3913.6 14324.0 14723.0 14944.3 15236.0 15328.2 14572.6 14671.3 14742.6 14874.9 14944.5 8452.1 8483.8 8571.7 8635.4 8727.5 5674.8 6891.3 6964.3 7013.9 7101.3 13402.3 13514.9 13520.6 13555.6 13578.2 13550.5 13613.0 13838.7 13920.9 14078.3 9545.8 9564.6 9625.3 9649.7 9765.4 10462.2 10785.0 10855.6 10861.7 10876.0 8998.3 9125.3 9221.7 9275.1 9304.5 8933.2 8954.2 9004.2 9023.9 9194.4 8144.7 8207.0 8330.4 8349.2 8354.0 6056.9 6057.3 6140.1 6206.2 6282.9 5966.3 6021.9 6047.6 6218.8 6378.1 21:58:02 INFO - PID 1641 | 21:58:02 INFO - PID 1641 | [#4] prototype.html Cycles:180 Average:5217.92 Median:5708.18 stddev:1659.54 (29.1%) stddev-sans-first:1624.02 21:58:02 INFO - PID 1641 | Values: 382.6 392.2 403.4 406.8 414.9 5356.2 5618.4 5958.5 6173.2 6255.5 5137.8 5549.5 5685.5 5733.4 5882.6 3760.7 4075.2 4487.1 4499.6 4500.3 3725.8 4369.8 4402.3 4471.1 4509.3 4445.6 4448.0 4455.8 4457.6 4458.6 3299.8 3836.9 4404.6 4424.9 4439.1 3186.2 3757.8 3822.8 3856.7 3880.8 5449.0 5812.4 5875.3 5920.6 5962.3 4975.6 5297.1 5307.8 5308.0 5341.7 6078.3 6288.9 6378.9 6434.2 6462.5 4014.2 4322.2 4333.7 4356.5 4357.6 5668.6 6480.6 6685.8 6935.9 6949.1 4410.0 4426.0 4426.1 4458.0 4466.9 4509.3 4520.7 4522.6 4532.8 4534.9 4426.7 4459.4 4842.2 5250.9 5313.9 6495.6 6504.1 6521.1 6533.7 6550.6 1536.5 1546.8 1548.5 1548.9 1554.1 975.1 1019.6 1022.2 1024.4 1036.3 4950.9 5501.0 5529.3 5986.1 6248.3 6408.3 6701.4 6778.3 6785.7 6793.9 5080.3 5192.8 5243.4 6248.3 6293.3 3502.5 3527.5 3541.6 3546.2 3567.7 5940.3 6012.4 6882.8 7069.4 7174.1 6978.9 7042.1 7069.6 7080.4 7117.6 6355.0 6380.6 6555.4 6975.5 7064.6 6188.4 6799.6 6810.0 6825.9 6906.5 6478.4 6670.1 6673.2 6704.7 6710.5 5785.6 5972.6 7060.6 7092.3 7114.1 4453.8 4454.9 4474.4 4476.4 4481.0 6420.6 6692.6 6723.3 6771.4 6805.6 5730.9 6547.9 6556.7 6580.1 6594.7 4801.9 6512.1 6522.0 6556.3 6573.8 6464.9 6475.2 6476.5 6483.2 6495.5 4862.0 6137.6 6252.4 6558.5 6593.4 5371.9 5412.3 6362.6 6374.0 6415.2 21:58:02 INFO - PID 1641 | 21:58:02 INFO - PID 1641 | [#5] yui.html Cycles:180 Average:22160.41 Median:18109.55 stddev:31388.96 (173.3%) stddev-sans-first:31435.57 21:58:02 INFO - PID 1641 | Values: 679.7 813.7 828.2 856.8 857.7 14587.4 15225.2 16471.0 16937.8 16943.2 14370.4 14440.3 16726.0 17613.4 17662.0 853.6 868.7 926.1 938.7 942.9 969.1 970.0 970.2 971.9 976.8 973.3 1012.8 1017.0 1017.0 1022.0 1008.9 1013.0 1013.5 1015.0 1024.3 728.2 732.7 737.6 739.3 739.3 16346.3 16696.6 16823.6 17188.0 17397.0 16773.9 16889.7 17081.6 17107.3 17284.4 13780.2 13969.4 14009.2 14071.4 14130.9 3532.3 3551.6 3551.8 3558.8 3560.1 88729.6 119639.8 121215.0 121451.4 134336.0 13264.8 13701.5 13710.0 13804.9 13814.7 23492.9 23658.2 25325.9 25332.9 25389.7 7627.4 7925.6 7940.2 7957.7 7959.4 3970.6 4034.4 4055.8 4057.7 4061.1 4252.9 4278.0 4389.2 4420.1 4425.5 757.3 813.8 846.0 856.2 857.9 633.2 647.5 657.2 664.4 690.7 10790.8 11489.0 11699.5 11981.6 12160.9 644.5 647.6 653.5 655.2 676.0 4391.8 4846.6 4892.0 5278.9 5453.8 102532.5 107121.4 107510.0 109838.0 111920.4 95388.0 100037.5 101311.4 102248.0 102612.0 64187.0 92894.5 92998.5 93118.0 94356.5 9563.0 9812.3 10968.5 10990.9 11119.8 45700.6 45922.1 45955.8 46025.8 46442.1 55685.7 56052.4 56316.7 56386.7 57408.4 13708.9 14011.6 16542.3 16958.9 17268.1 15222.0 18557.1 18724.6 18817.5 18826.5 16536.5 16537.4 17311.0 17356.7 17462.8 16530.8 16558.5 17049.4 17061.5 17117.7 16101.9 16441.8 16595.0 16912.3 16928.5 11912.2 12069.7 12146.6 12158.5 12218.1 13148.0 13314.7 13568.1 13610.7 13754.8 21:58:02 INFO - PID 1641 | -------- Summary: end -------- 21:58:02 INFO - PID 1641 | 21:58:03 INFO - TEST-INFO | 1641: exit 0 21:58:03 INFO - TEST-OK | dromaeo_css | took 1115549ms 21:58:03 INFO - TEST-START | kraken 21:58:03 INFO - operating with platform_type : mac_ 21:58:03 INFO - Initialising browser for kraken test... 21:58:03 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpUqJ3Wf/profile http://localhost:49249/getInfo.html) 21:58:06 INFO - PID 1652 | 2017-04-24 21:58:06.118 plugin-container[1653:10044] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9337, name = 'com.apple.tsm.portname' 21:58:06 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:58:06 INFO - PID 1652 | 2017-04-24 21:58:06.121 plugin-container[1653:10044] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 21:58:06 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:58:06 INFO - PID 1652 | 2017-04-24 21:58:06.121 plugin-container[1653:10044] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:58:06 INFO - PID 1652 | __metrics Screen width/height:1600/1200 21:58:06 INFO - PID 1652 | colorDepth:24 21:58:06 INFO - PID 1652 | Browser inner width/height: 1024/689 21:58:06 INFO - PID 1652 | __metrics 21:58:06 ERROR - PID 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3414: TypeError: this.tabs is undefined 21:58:07 INFO - TEST-INFO | 1652: exit 0 21:58:07 INFO - Browser initialized. 21:58:07 INFO - Running cycle 1/1 for kraken test... 21:58:07 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpUqJ3Wf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:58:09 INFO - PID 1654 | 2017-04-24 21:58:09.531 plugin-container[1655:10169] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 21:58:09 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:58:09 INFO - PID 1654 | 2017-04-24 21:58:09.532 plugin-container[1655:10169] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.CFPasteboardClient' 21:58:09 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:58:09 INFO - PID 1654 | 2017-04-24 21:58:09.532 plugin-container[1655:10169] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:58:19 INFO - PID 1654 | RSS: Main: 235560960 21:58:19 INFO - PID 1654 | 21:58:22 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 21:58:23 INFO - PID 1654 | RSS: Main: 249053184 21:58:23 INFO - PID 1654 | 21:58:25 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 21:58:26 INFO - PID 1654 | RSS: Main: 257527808 21:58:26 INFO - PID 1654 | 21:58:29 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 21:58:30 INFO - PID 1654 | RSS: Main: 259592192 21:58:30 INFO - PID 1654 | 21:58:32 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 21:58:32 INFO - PID 1654 | RSS: Main: 261922816 21:58:32 INFO - PID 1654 | 21:58:34 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:58:35 INFO - PID 1654 | RSS: Main: 262553600 21:58:35 INFO - PID 1654 | 21:58:38 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 21:58:38 INFO - PID 1654 | RSS: Main: 268279808 21:58:38 INFO - PID 1654 | 21:58:41 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 21:58:42 INFO - PID 1654 | RSS: Main: 269926400 21:58:42 INFO - PID 1654 | 21:58:45 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 21:58:46 INFO - PID 1654 | RSS: Main: 269258752 21:58:46 INFO - PID 1654 | 21:58:47 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:48 INFO - PID 1654 | RSS: Main: 269148160 21:58:48 INFO - PID 1654 | 21:58:50 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:58:50 INFO - PID 1654 | RSS: Main: 268963840 21:58:50 INFO - PID 1654 | 21:58:52 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:58:53 INFO - PID 1654 | RSS: Main: 268492800 21:58:53 INFO - PID 1654 | 21:58:56 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:58:57 INFO - PID 1654 | RSS: Main: 268611584 21:58:57 INFO - PID 1654 | 21:59:00 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:59:00 INFO - PID 1654 | RSS: Main: 268922880 21:59:00 INFO - PID 1654 | 21:59:02 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 21:59:03 INFO - PID 1654 | RSS: Main: 270381056 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | __start_tp_report 21:59:03 INFO - PID 1654 | _x_x_mozilla_page_load 21:59:03 INFO - PID 1654 | _x_x_mozilla_page_load_details 21:59:03 INFO - PID 1654 | |i|pagename|runs| 21:59:03 INFO - PID 1654 | |0;ai-astar;102;115;115;113;113;113;112;114;114;114 21:59:03 INFO - PID 1654 | |1;audio-beat-detection;144;107;147;149;108;112;109;106;148;142 21:59:03 INFO - PID 1654 | |2;audio-dft;194;206;199;220;209;240;275;245;196;198 21:59:03 INFO - PID 1654 | |3;audio-fft;86;77;50;93;49;49;50;46;82;84 21:59:03 INFO - PID 1654 | |4;audio-oscillator;93;70;82;74;70;71;85;69;72;92 21:59:03 INFO - PID 1654 | |5;imaging-gaussian-blur;90;91;91;90;90;91;91;95;89;92 21:59:03 INFO - PID 1654 | |6;imaging-darkroom;138;132;98;98;97;98;99;97;97;101 21:59:03 INFO - PID 1654 | |7;imaging-desaturate;92;93;92;93;123;84;139;145;92;115 21:59:03 INFO - PID 1654 | |8;json-parse-financial;51;51;52;52;51;54;51;52;51;53 21:59:03 INFO - PID 1654 | |9;json-stringify-tinderbox;57;61;57;63;86;88;55;57;55;55 21:59:03 INFO - PID 1654 | |10;stanford-crypto-aes;83;81;84;84;94;80;85;85;83;83 21:59:03 INFO - PID 1654 | |11;stanford-crypto-ccm;160;136;153;139;139;139;139;142;188;167 21:59:03 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;187;187;182;187;186;189;228;185;189;186 21:59:03 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;69;69;86;95;99;100;69;92;74;72 21:59:03 INFO - PID 1654 | __end_tp_report 21:59:03 INFO - PID 1654 | __start_cc_report 21:59:03 INFO - PID 1654 | _x_x_mozilla_cycle_collect,1002 21:59:03 INFO - PID 1654 | __end_cc_report 21:59:03 INFO - PID 1654 | __startTimestamp1493096343013__endTimestamp 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | ------- Summary: start ------- 21:59:03 INFO - PID 1654 | Number of tests: 14 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.81 (3.3%) stddev-sans-first:1.00 21:59:03 INFO - PID 1654 | Values: 102.0 115.0 115.0 113.0 113.0 113.0 112.0 114.0 114.0 114.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:143.00 stddev:19.97 (14.0%) stddev-sans-first:20.24 21:59:03 INFO - PID 1654 | Values: 144.0 107.0 147.0 149.0 108.0 112.0 109.0 106.0 148.0 142.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:218.20 Median:214.50 stddev:26.90 (12.5%) stddev-sans-first:27.07 21:59:03 INFO - PID 1654 | Values: 194.0 206.0 199.0 220.0 209.0 240.0 275.0 245.0 196.0 198.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:66.60 Median:79.50 stddev:19.20 (24.1%) stddev-sans-first:19.03 21:59:03 INFO - PID 1654 | Values: 86.0 77.0 50.0 93.0 49.0 49.0 50.0 46.0 82.0 84.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:9.40 (12.1%) stddev-sans-first:8.21 21:59:03 INFO - PID 1654 | Values: 93.0 70.0 82.0 74.0 70.0 71.0 85.0 69.0 72.0 92.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:91.00 stddev:1.63 (1.8%) stddev-sans-first:1.69 21:59:03 INFO - PID 1654 | Values: 90.0 91.0 91.0 90.0 90.0 91.0 91.0 95.0 89.0 92.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:105.50 Median:97.50 stddev:15.66 (16.1%) stddev-sans-first:11.36 21:59:03 INFO - PID 1654 | Values: 138.0 132.0 98.0 98.0 97.0 98.0 99.0 97.0 97.0 101.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:106.80 Median:92.00 stddev:22.07 (24.0%) stddev-sans-first:22.75 21:59:03 INFO - PID 1654 | Values: 92.0 93.0 92.0 93.0 123.0 84.0 139.0 145.0 92.0 115.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:1.03 (2.0%) stddev-sans-first:1.05 21:59:03 INFO - PID 1654 | Values: 51.0 51.0 52.0 52.0 51.0 54.0 51.0 52.0 51.0 53.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:59.00 stddev:12.72 (21.6%) stddev-sans-first:13.28 21:59:03 INFO - PID 1654 | Values: 57.0 61.0 57.0 63.0 86.0 88.0 55.0 57.0 55.0 55.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:3.79 (4.5%) stddev-sans-first:4.00 21:59:03 INFO - PID 1654 | Values: 83.0 81.0 84.0 84.0 94.0 80.0 85.0 85.0 83.0 83.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:150.20 Median:147.50 stddev:16.95 (11.5%) stddev-sans-first:17.60 21:59:03 INFO - PID 1654 | Values: 160.0 136.0 153.0 139.0 139.0 139.0 139.0 142.0 188.0 167.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.60 Median:187.00 stddev:13.29 (7.1%) stddev-sans-first:14.04 21:59:03 INFO - PID 1654 | Values: 187.0 187.0 182.0 187.0 186.0 189.0 228.0 185.0 189.0 186.0 21:59:03 INFO - PID 1654 | 21:59:03 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.50 Median:80.00 stddev:13.19 (16.5%) stddev-sans-first:13.06 21:59:03 INFO - PID 1654 | Values: 69.0 69.0 86.0 95.0 99.0 100.0 69.0 92.0 74.0 72.0 21:59:03 INFO - PID 1654 | -------- Summary: end -------- 21:59:03 INFO - PID 1654 | 21:59:04 INFO - TEST-INFO | 1654: exit 0 21:59:04 INFO - TEST-OK | kraken | took 60959ms 21:59:04 INFO - SUITE-END | took 1176s 21:59:04 INFO - Completed test suite (00:19:36) 21:59:04 INFO - javascript benchmark 21:59:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7775.383144150574, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3027.6064111665482, 3052.526858336957, 3613.313470440618, 3626.7279954003457, 3673.944890826637, 6104.206453161083, 6233.906491402627, 6269.435750782429, 6270.686465676721, 6303.779367722131, 6167.722452489637, 6211.161493198417, 6224.408681175292, 6263.780767673133, 6323.114763933041, 4597.057603191354, 5224.29472021278, 5467.9453205468035, 5484.012877682016, 5600.6079574429805, 5036.6222533309965, 5354.785808567672, 5424.0236757383655, 5458.536024437927, 5567.220589117527, 4472.955270447319, 5394.6493477924205, 5492.505674489275, 5516.172574113875, 5573.4147914469, 4562.247229207177, 5477.643953143033, 5493.0, 5498.147787093007, 5524.723763811793, 5436.972815135899, 5437.075697131497, 5454.290942177491, 5454.863628409282, 5472.562195024429, 6106.794380079854, 6167.84580385494, 6226.1905952225925, 6299.181106456132, 6304.558680892339, 6626.834329141761, 6667.166604174478, 6687.598744075371, 6691.4312283455965, 6693.0, 6715.059891615178, 6757.662116894136, 6761.323867613249, 6776.457883369368, 6780.321967803229, 6134.987697083746, 6147.262328520516, 6363.42729154369, 6369.33122022181, 6374.521910856658, 6483.546151769331, 6504.577202481823, 6864.073350097673, 6952.339527744957, 6965.094537710065, 6280.183576135165, 6361.650109243943, 6373.107764912916, 6429.099926010363, 6613.669316534154, 5524.281843360337, 5907.054871220584, 6620.337966203341, 6634.402903738686, 6695.665216739144, 6007.429294217042, 6596.175478065242, 6596.571222870498, 6620.9006864897065, 6641.103451034145, 5460.563154947595, 6365.077063825719, 6394.424501794768, 6597.703103360361, 6626.569272997336, 5309.2036194570355, 5314.1497360422145, 5322.973385133049, 5343.064963631349, 5365.195220716923, 4737.786799594027, 4744.97982933664, 4769.833055843098, 4778.880527986758, 4824.0834241494, 5120.0, 5170.431252562215, 5507.421720719347, 6217.0, 6373.0, 6770.390664840188, 6793.0, 6804.931950680529, 6807.965960170168, 6812.046313516112, 6238.563300568917, 6356.078368636522, 6356.523260755462, 6375.043743438521, 6392.808215753535, 5747.252857128547, 5818.069108942634, 6000.849978750566, 6003.0695242237525, 6030.18592490017, 6801.18385793708, 6810.284920083518, 6918.342757438036, 6961.930380696331, 6979.720811167496, 6779.288174741779, 6791.117154769849, 6795.456363491007, 6802.217744959393, 6809.489288303298, 6976.5465244758925, 6991.825204369931, 6998.370146686822, 7011.0, 7025.297470253138, 6388.9041664376, 6497.480201583957, 6575.849226385268, 6624.635645039569, 6683.699233534406, 5933.940660593339, 6663.200415949923, 6702.430293425114, 6703.262641109376, 6717.56335838169, 5376.623636345575, 6163.397516645615, 6302.5588208826775, 6309.1167236586, 6489.091527186103, 6307.211598550181, 6488.935110649022, 6499.28507864144, 6505.479561634963, 6510.44661203784, 6309.684515774101, 6331.778387756406, 6333.429991300621, 6366.93633063682, 6403.679816009274, 6503.479721622353, 6525.0, 6526.641034743135, 6535.0197470377925, 6540.705668245036, 5266.789328426973, 5359.651622644516, 6110.625109350361, 6354.0, 6359.968200159155], "value": 6029.621861979377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.7295318349252, 742.6992068212376, 814.1126172472004, 1234.8765123487653, 1248.744007478467, 30081.0, 35644.82177589115, 36251.637483625156, 37535.81232093843, 37659.87020389389, 37197.44203836938, 37524.43713344295, 37581.24837503248, 37604.43593346102, 37665.870023899326, 7312.707491700326, 7879.8030049248655, 8021.518708877456, 8669.826603467927, 8679.826403471927, 8579.742607721779, 8606.010308814473, 8683.435576687496, 8685.478871267713, 8711.259542938826, 8649.443100241953, 8654.783630409227, 8698.56507174642, 8707.521086340248, 8715.041345451995, 8662.52356120413, 8700.303975681962, 8703.216710496023, 8708.869366959501, 8710.172533609297, 8499.235068843835, 8545.2309292164, 8550.0, 8560.48637081777, 8581.52801595912, 36765.63234367649, 36863.4470482943, 36948.815255923546, 36964.44553331702, 36988.0, 3601.1717305019993, 3614.493970844084, 3634.5638523377365, 3640.3629364861044, 3644.344018076745, 30318.0, 30480.8475957621, 30595.08214753561, 30603.69396306031, 30679.846600766854, 3083.198368424226, 3139.1053549738444, 3150.1179669692524, 3151.4800057990406, 3165.1612322734495, 285347.0, 286638.0, 292907.0, 295740.0, 297981.0, 47181.76409117933, 47258.29112563314, 47297.763511182224, 47382.28926566104, 47421.288680669815, 49580.50419495759, 49611.26360577362, 52760.73619631877, 53483.0, 53534.464655353724, 13789.0, 13909.652258693613, 13918.0, 13920.58238252854, 13951.511697090553, 10956.726081848017, 11035.227534072537, 11039.448027598588, 11061.723456913642, 11070.169737269576, 11674.299542027506, 13558.576349483359, 14026.789598156036, 14027.649308767159, 14059.297035148405, 5115.437301896788, 6125.1731016313115, 6131.63210207389, 6136.23297087864, 6162.168107305456, 875.3959767760225, 979.2361957673027, 993.3989936088562, 1010.3180353261519, 1021.8109649714678, 24042.87978560096, 24209.515809683708, 24366.512669746506, 24378.878105609358, 24429.877850610632, 1018.6892997635643, 1070.1706177712335, 1073.1146803886825, 1107.2194103157256, 1108.9722756931142, 10675.252732308663, 12124.5144745327, 12446.06654500916, 12509.186902851285, 12560.497580096693, 320375.0, 320568.0, 320796.0, 320853.0, 322666.0, 53145.93708125816, 53458.46541534535, 53460.0, 53491.465085348646, 53519.0, 1491.7091167222504, 1502.278906125066, 1538.9307481163376, 1539.6766678997535, 1568.8823338249676, 20868.68696969577, 22937.655935160652, 24015.879920600284, 24108.39729006789, 24151.637725433782, 38106.0, 38180.6181938177, 38208.51644643089, 38362.0, 38457.615423845404, 216932.83067169756, 271215.0, 271792.0, 272106.0, 272315.0, 34352.0, 34935.12662183364, 35005.47491787676, 35162.47256291106, 35174.47238291479, 35370.0, 44034.33948490711, 44180.55819441893, 44317.0, 44364.0, 29133.0, 29490.967816126333, 30754.53868191934, 30834.383312334077, 30872.0, 29978.70021299759, 30542.0, 30737.38525229438, 30863.9938404003, 30926.22684432907, 36249.456258155624, 36283.637163628024, 36839.63160368362, 36912.0, 37159.442608360354, 28094.578581321704, 30200.0, 30515.93194238191, 30833.383332333677, 31342.216444588157, 19544.609107818047, 20408.693869592265, 22556.887215563816, 22647.547049059256, 24505.264842054767], "value": 17335.558175395854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.087958527654, 426.34343111608126, 430.7443801319156, 442.9357743127247, 449.64253418532263, 20664.17343306268, 20962.580748385062, 21020.264290749827, 21166.576668466623, 21532.89233553832, 20899.895500522514, 21655.808930508814, 22178.889105554448, 22245.332640020824, 22472.9887155078, 5595.804146854861, 6093.385252907972, 6304.306526282106, 6305.33793951633, 6305.495560355161, 6002.849928751794, 6169.321374648785, 6234.906476402857, 6251.187345645082, 6252.562320637558, 5979.282486101674, 6140.447359737623, 6197.070439434098, 6199.845003874917, 6211.440970312671, 6090.33006369299, 6112.6638034908065, 6152.907706384408, 6164.137020817089, 6180.165677633529, 5236.947630523684, 5384.40771515133, 5437.0, 5464.672119672832, 5471.179323101566, 25544.74455255442, 25553.361165970815, 25555.872220638965, 25672.614910776352, 25982.22053338403, 2232.464208589943, 2292.6446400807736, 2305.7694230576976, 2306.2274138163734, 2308.5844547981355, 17086.0, 17098.743518847226, 17212.74180887275, 17735.822641773546, 17987.640247194984, 2147.7744836792226, 2187.57342318248, 2209.6133176694175, 2218.0905828610353, 2223.3107736601705, 127246.0, 128092.0, 128997.0, 129945.0, 130045.0, 11654.53381864716, 11912.52349905994, 11920.821187682192, 11926.284422934652, 12027.27836329823, 12714.364281786058, 14146.504872329419, 15320.463783767515, 15490.0, 15527.0, 7977.3618110551015, 8356.623951922178, 8620.137986201455, 8694.608742606599, 8729.083446238054, 6820.6930688119155, 8109.391795615353, 8123.878141827878, 8144.796380090426, 8284.917150828534, 7426.517276377018, 7512.812179695551, 7547.396208303323, 7561.0, 7594.392448604209, 2110.2297661353496, 2133.0934352899953, 2133.658614621653, 2134.935951921445, 2135.2419890938804, 946.5882341181608, 947.9715608531756, 958.4776296918196, 996.3025881882711, 1024.5901639344172, 15241.847581524265, 20201.49496262576, 20394.184232630527, 20866.47833804167, 20923.79076209249, 1019.1948360794889, 1027.1525991057408, 1056.6090546497844, 1062.3148069495287, 1063.1972860490434, 10380.858105608377, 10692.946535267274, 10777.030067293981, 10853.294535855144, 10859.945700271606, 449424.0, 542380.0, 542731.0, 543098.0, 575684.0, 115831.0, 117461.0, 118902.405487972, 121584.0, 122103.0, 1155.0701292578365, 1162.2213117211488, 1203.7712834561405, 1209.2019267283551, 1209.2683926224684, 17641.382551610634, 17753.201105950004, 17811.081562056326, 17878.91060544689, 17992.640147197246, 52521.0, 53698.0, 55153.1727024103, 55502.444975549726, 56253.87492250214, 63957.04064438944, 64952.0, 65638.0, 66388.33611663821, 66534.0, 8473.195046470575, 8483.194096560817, 8501.0223824261, 8920.910790892009, 8956.507392093497, 12187.329696866404, 13338.666533336744, 13741.175529468264, 13753.931230343784, 13802.861971380158, 7773.883391749241, 10618.0, 10732.678019659423, 10867.239293249713, 10940.124790016938, 10534.209934254808, 11053.72365690832, 11247.325160490396, 11252.156088293246, 11273.379964102052, 11810.704732381415, 11962.58130965412, 12121.878781212075, 12153.574624888086, 12215.38923053826, 6242.438180563771, 8660.527710289392, 8853.867191991996, 8864.73405797827, 8881.467111973303, 9159.496227707274, 11124.618849273482, 11928.940355298168, 11971.281723096294, 12009.63971080869], "value": 10064.582999833003, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.5540626999357, 1433.6845893903344, 1445.8554144585537, 1450.7968884356192, 1458.5551406820919, 11472.02487788538, 11797.587084452045, 11821.468033938472, 11965.999999999989, 12216.694582635439, 11839.644810655695, 11859.288442693445, 12036.277823330607, 12036.879631203685, 12044.93977530111, 2279.943001424961, 2449.510097980411, 2508.41052352697, 2529.6964364276314, 2545.172818833877, 2484.900603975848, 2526.077981536735, 2545.859977701235, 2549.73227811079, 2556.6292887531295, 2482.863442510661, 2489.850608963468, 2523.1673547729206, 2525.8863351149243, 2530.582453895105, 2469.2839076667747, 2493.501299740059, 2520.5337012652626, 2520.911768088108, 2520.936976575582, 2112.9118503970467, 2428.805695544352, 2517.609770485578, 2517.8237523373373, 2520.773130418271, 9627.374220675703, 11672.649820505398, 11849.229800062969, 11878.88121118795, 11902.166848320621, 6151.323354431009, 6700.363465470821, 6779.864402711967, 6797.864042719168, 6801.4898882584, 3619.855205791765, 3992.6207010333974, 4088.407180958774, 4093.263212621727, 4283.65730741543, 1245.8255844181822, 1249.9999999999964, 1276.8212450256972, 1291.4446787881207, 1293.5989843148654, 13158.342082895817, 14606.05060671053, 16160.27278772458, 16774.245158967875, 16814.663706725798, 4885.0, 5006.374203224597, 5930.229070220844, 6179.0, 6217.067439883963, 14105.294735263402, 14142.080764750259, 14148.221847798264, 14169.645758856112, 14176.503822366167, 6839.726410943606, 6885.139357580302, 6906.723731050803, 6913.5506192097355, 6915.965420172867, 6043.335233124353, 6158.291796443466, 6297.1813664223355, 6308.432241098323, 6330.05049242608, 4184.456020717348, 4577.404937358122, 4753.786079626425, 4791.137595232822, 4810.013947140827, 1265.677252300676, 1283.0633637444719, 1441.3009690300196, 1486.814148231471, 1493.6788590453104, 791.8614242507538, 797.0316065979862, 809.2433574607643, 809.554744890308, 825.2407784837964, 6116.66358350295, 6117.418845209698, 6260.5617606768, 6346.0, 6421.0, 582.1151849189208, 588.2294194605081, 588.7733222709202, 596.7463827873137, 597.7877853361994, 3781.2815565042556, 3838.405047217686, 3856.652901238902, 3863.8022213114023, 3913.5890731473355, 14323.997320187695, 14723.043002204822, 14944.252787360589, 15236.0, 15328.23358832054, 14572.562823115111, 14671.266436678337, 14742.63143421423, 14874.851251487564, 14944.476943306932, 8452.112528184574, 8483.787905302293, 8571.699990500303, 8635.438696484709, 8727.519986400936, 5674.77300907959, 6891.310868913069, 6964.26875178099, 7013.859722805413, 7101.325374089453, 13402.32988350559, 13514.93242533781, 13520.59438216855, 13555.59333220005, 13578.185308881499, 13550.457981680622, 13613.0, 13838.723225535634, 13920.930395347958, 14078.296085195494, 9545.761355966157, 9564.56959436841, 9625.32622716403, 9649.662261820802, 9765.414075155513, 10462.21533384984, 10785.0, 10855.565777368816, 10861.728456788644, 10876.0, 8998.280137588847, 9125.31560133006, 9221.723348299294, 9275.07249275067, 9304.488253145872, 8933.19601235892, 8954.238889694449, 9004.234640055669, 9023.864642030243, 9194.448333100036, 8144.714934977247, 8207.0, 8330.416870818985, 8349.165083491602, 8354.0, 6056.9091463628965, 6057.333693293822, 6140.109684095871, 6206.193194884636, 6282.874342513215, 5966.313873904556, 6021.855847389157, 6047.637141771508, 6218.844528886814, 6378.138951241709], "value": 5367.457619898938, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.581073724272, 392.184187213203, 403.3626869546117, 406.84539874847565, 414.8838325268925, 5356.169793681981, 5618.381977982429, 5958.523318134549, 6173.197484327036, 6255.468285195758, 5137.768800403981, 5549.472800083996, 5685.488306052454, 5733.369329373765, 5882.558703158657, 3760.7179461540495, 4075.225707115646, 4487.137837797311, 4499.595036446719, 4500.347449619803, 3725.7764534127905, 4369.847055353063, 4402.295632698769, 4471.128130014648, 4509.346144809001, 4445.555444455561, 4447.976965297983, 4455.777211139446, 4457.554244575533, 4458.621017213524, 3299.7690161688693, 3836.865709700175, 4404.647628189737, 4424.867253982386, 4439.067795762894, 3186.2353035271367, 3757.830897609614, 3822.8279727412055, 3856.67218286446, 3880.825362858678, 5448.972755136238, 5812.372535690013, 5875.324337701134, 5920.585559010828, 5962.314333851619, 4975.626827987915, 5297.12597421425, 5307.761150748225, 5307.991481618519, 5341.67949923002, 6078.300995385543, 6288.937110628926, 6378.936210637927, 6434.163558737381, 6462.547621666486, 4014.1770936957855, 4322.2436073687295, 4333.739975601474, 4356.499002614676, 4357.6078152966065, 5668.603197776158, 6480.578762380477, 6685.799426017227, 6935.930640693629, 6949.131358580177, 4409.977950110229, 4425.977870110629, 4426.092651006536, 4457.955420445754, 4466.888327791831, 4509.255972764523, 4520.728756274634, 4522.615577675869, 4532.773361331921, 4534.9342904417435, 4426.712263702849, 4459.420275364247, 4842.201036828884, 5250.894982100413, 5313.867153321198, 6495.577787443801, 6504.121943537656, 6521.087347591407, 6533.705983230766, 6550.574212676161, 1536.5159974607964, 1546.7834503169565, 1548.4967385599725, 1548.907065576069, 1554.098622798774, 975.1370037516849, 1019.5717798524637, 1022.1771473963382, 1024.4314405505015, 1036.3315661398506, 4950.861301900511, 5500.972495137578, 5529.30883639545, 5986.132010858489, 6248.31268560458, 6408.327125651833, 6701.430378417792, 6778.322167783281, 6785.660716964132, 6793.879009963301, 5080.288759573663, 5192.766325515361, 5243.397009343898, 6248.31268560458, 6293.30773614902, 3502.476422756109, 3527.4885141654318, 3541.575010998645, 3546.184377593168, 3567.696745776638, 5940.34656187819, 6012.368701286389, 6882.7591034313555, 7069.399101076363, 7174.058635959232, 6978.895316570255, 7042.084529011298, 7069.6111713856235, 7080.433565314763, 7117.608531530712, 6355.0, 6380.617162970237, 6555.3772391622715, 6975.546589471668, 7064.646767661699, 6188.44304012641, 6799.558028728117, 6809.9570128962105, 6825.931740682529, 6906.516543841883, 6478.449331806849, 6670.099536562502, 6673.199216093905, 6704.664766761545, 6710.4631629470505, 5785.611453251274, 5972.611780234271, 7060.576365417885, 7092.326229008236, 7114.1463024435325, 4453.821847126079, 4454.901490628565, 4474.37358769779, 4476.440444944382, 4480.955190448184, 6420.55056146084, 6692.564983276072, 6723.327667233433, 6771.424428923399, 6805.557638753465, 5730.879574557273, 6547.934520654923, 6556.737730490727, 6580.144581204413, 6594.670266486561, 4801.927971080367, 6512.088307637029, 6522.021696745526, 6556.2788093308745, 6573.835654108494, 6464.903026454701, 6475.190601174853, 6476.481881449378, 6483.222013358239, 6495.512836537184, 4862.0, 6137.570370074052, 6252.374762523711, 6558.508111891722, 6593.3736295051895, 5371.919421208607, 5412.296401467784, 6362.586431881913, 6374.012028135647, 6415.166028416463], "value": 4708.915313204505, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.6533767778433, 813.6501304439089, 828.1842385250527, 856.8157846063098, 857.6783706110209, 14587.416503339853, 15225.23873806308, 16471.0, 16937.814352995294, 16943.15284235788, 14370.425182992667, 14440.277986100706, 16726.0, 17613.383531576397, 17662.0, 853.5945425922699, 868.7133246028811, 926.1248120526105, 938.7183844846553, 942.9339946203769, 969.1132613658494, 970.0202795176887, 970.1608108985747, 971.9125278724913, 976.8144052630013, 973.2797729680057, 1012.7670635753781, 1016.9694909152737, 1016.983016983017, 1022.0137567247605, 1008.9243306751986, 1013.027493606139, 1013.5185786751308, 1014.9847752283722, 1024.2830018986701, 728.1989811207682, 732.7398773435407, 737.5685224143882, 739.2755100002028, 739.3198257603018, 16346.34614615414, 16696.58258543534, 16823.579410514834, 17188.0, 17397.0, 16773.91613041939, 16889.746653800205, 17081.57296067596, 17107.289271072917, 17284.39504617345, 13780.173189608655, 13969.441222351094, 14009.229492377915, 14071.366788494543, 14130.858691413057, 3532.311199316134, 3551.627079156703, 3551.786892786441, 3558.768680035815, 3560.1099725068734, 88729.55635221847, 119639.80360196374, 121215.0, 121451.39274303571, 134336.0, 13264.801027984588, 13701.45194192221, 13710.0, 13804.93097534506, 13814.654633634038, 23492.942817572908, 23658.171963981524, 25325.8733706334, 25332.873335633572, 25389.74610253911, 7627.351675107567, 7925.643346049442, 7940.245676660708, 7957.721479748181, 7959.403044771665, 3970.642642162219, 4034.3948407739076, 4055.756654600674, 4057.736247143926, 4061.0659548304056, 4252.9367658085475, 4277.973286411239, 4389.18800021997, 4420.138073075719, 4425.535318791545, 757.3070640364006, 813.772143799737, 845.9636944742641, 856.208007592974, 857.9099194584603, 633.2243002322118, 647.5402464250435, 657.1621182991723, 664.3854434647932, 690.7237105157876, 10790.838137427945, 11489.0, 11699.473523691455, 11981.58064467757, 12160.939195303967, 644.5037321262602, 647.5564238496551, 653.5196630476596, 655.2301046270613, 675.9691470507418, 4391.824327026883, 4846.616340105727, 4891.997140586172, 5278.868028299246, 5453.809116680897, 102532.48733756284, 107121.39317910082, 107510.0, 109838.0, 111920.44039779749, 95388.0461195393, 100037.49981250048, 101311.42787146631, 102248.0, 102612.0, 64187.03719444212, 92894.53552732329, 92998.53500732454, 93118.0, 94356.52821735985, 9562.95218523903, 9812.313138080266, 10968.451577420938, 10990.945045274722, 11119.83320250213, 45700.57245706652, 45922.08155836931, 45955.770221150015, 46025.76987115043, 46442.07115857732, 55685.72157139351, 56052.43947560472, 56316.71841640765, 56386.718066409405, 57408.42591574198, 13708.86291137076, 14011.579652610439, 16542.255598498337, 16958.915205423895, 17268.136593170544, 15222.0, 18557.09033091545, 18724.625507490047, 18817.529561761065, 18826.529336766143, 16536.503904882873, 16537.421190258283, 17310.9613423195, 17356.65286694234, 17462.82537174612, 16530.752038719187, 16558.503244902673, 17049.40327088546, 17061.48815535536, 17117.716171286953, 16101.919490402473, 16441.835581644507, 16595.0, 16912.32350705958, 16928.49214523566, 11912.225705329125, 12069.698257543632, 12146.574869879865, 12158.452869621065, 12218.083643726579, 13148.0, 13314.733705326033, 13568.118072325267, 13610.727785444433, 13754.793678094637], "value": 8309.733588390945, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 115.0, 113.0, 113.0, 113.0, 112.0, 114.0, 114.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 107.0, 147.0, 149.0, 108.0, 112.0, 109.0, 106.0, 148.0, 142.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 206.0, 199.0, 220.0, 209.0, 240.0, 275.0, 245.0, 196.0, 198.0], "value": 218.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 77.0, 50.0, 93.0, 49.0, 49.0, 50.0, 46.0, 82.0, 84.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 82.0, 74.0, 70.0, 71.0, 85.0, 69.0, 72.0, 92.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 91.0, 90.0, 90.0, 91.0, 91.0, 95.0, 89.0, 92.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 132.0, 98.0, 98.0, 97.0, 98.0, 99.0, 97.0, 97.0, 101.0], "value": 105.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 93.0, 123.0, 84.0, 139.0, 145.0, 92.0, 115.0], "value": 106.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 51.0, 54.0, 51.0, 52.0, 51.0, 53.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 57.0, 63.0, 86.0, 88.0, 55.0, 57.0, 55.0, 55.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 84.0, 84.0, 94.0, 80.0, 85.0, 85.0, 83.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 136.0, 153.0, 139.0, 139.0, 139.0, 139.0, 142.0, 188.0, 167.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 182.0, 187.0, 186.0, 189.0, 228.0, 185.0, 189.0, 186.0], "value": 190.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 86.0, 95.0, 99.0, 100.0, 69.0, 92.0, 74.0, 72.0], "value": 82.5, "unit": "score"}]}]} 21:59:04 INFO - Return code: 0 21:59:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:59:04 ERROR - # TBPL SUCCESS # 21:59:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:59:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:59:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:59:04 INFO - 2017-04-24 21:59:04.863 screenresolution[1659:10544] starting screenresolution argv=screenresolution get 21:59:04 INFO - 2017-04-24 21:59:04.866 screenresolution[1659:10544] Display 0: 1600x1200x32@60 21:59:04 INFO - 2017-04-24 21:59:04.872 screenresolution[1660:10547] starting screenresolution argv=screenresolution list 21:59:04 INFO - Available Modes on Display 0 21:59:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:59:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:59:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:59:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:59:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:59:05 INFO - Intel Iris: 21:59:05 INFO - Chipset Model: Intel Iris 21:59:05 INFO - Type: GPU 21:59:05 INFO - Bus: Built-In 21:59:05 INFO - VRAM (Dynamic, Max): 1536 MB 21:59:05 INFO - Vendor: Intel (0x8086) 21:59:05 INFO - Device ID: 0x0a2e 21:59:05 INFO - Revision ID: 0x0009 21:59:05 INFO - Displays: 21:59:05 INFO - Display: 21:59:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:59:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:59:05 INFO - Display Serial Number: 1600x1200 60 21:59:05 INFO - Main Display: Yes 21:59:05 INFO - Mirror: Off 21:59:05 INFO - Online: Yes 21:59:05 INFO - Rotation: Supported 21:59:05 INFO - Return code: 0 21:59:05 INFO - Running post-action listener: _resource_record_post_action 21:59:05 INFO - [mozharness: 2017-04-25 04:59:05.109126Z] Finished run-tests step (success) 21:59:05 INFO - Running post-run listener: _resource_record_post_run 21:59:05 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 40294912; Write bytes: 513099264; Read time: 394; Write time: 1653 21:59:05 INFO - TinderboxPrint: CPU usage
54.2% 21:59:05 INFO - TinderboxPrint: I/O read bytes / time
40,294,912 / 394 21:59:05 INFO - TinderboxPrint: I/O write bytes / time
513,099,264 / 1,653 21:59:05 INFO - TinderboxPrint: CPU idle
2,195.0 (45.8%) 21:59:05 INFO - TinderboxPrint: CPU system
966.5 (20.2%) 21:59:05 INFO - TinderboxPrint: CPU user
1,628.3 (34.0%) 21:59:05 INFO - TinderboxPrint: Swap in / out
248,311,808 / 0 21:59:05 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 204986880; Write bytes: 205927936; Read time: 16327; Write time: 416 21:59:05 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 38291968; Write bytes: 300380160; Read time: 372; Write time: 1210 21:59:05 INFO - Running post-run listener: _upload_blobber_files 21:59:05 INFO - Blob upload gear active. 21:59:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:59:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:59:05 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'] 21:59:05 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 21:59:06 INFO - (blobuploader) - INFO - Open directory for files ... 21:59:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:59:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:59:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:07 INFO - (blobuploader) - INFO - Done attempting. 21:59:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:59:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:08 INFO - (blobuploader) - INFO - Done attempting. 21:59:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:59:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:59:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:13 INFO - (blobuploader) - INFO - Done attempting. 21:59:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:59:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:59:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:16 INFO - (blobuploader) - INFO - Done attempting. 21:59:16 INFO - (blobuploader) - INFO - Iteration through files over. 21:59:16 INFO - Return code: 0 21:59:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:59:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:59:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/810fcf5222d82c4985d510421626b3da85cbfd3c6b98c55493bccda4cd16ebcc9db8a9c9c2fa28772413ab4a44c762995a61e53bfda9843833f334ab056998d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f8e47c2367cca9c84988089beeab399f6c5c4343038457a3629f7fa237493c88448295fccc84768687768b8c9518c5b643fb0e99a279124cfd242e35ef6eb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0d0bea71a4f3999f7987799811ced45f0b38edb439b37e736c5e5fd92dc9c42775aaac2ca2c1e2499367ceac37b56abc0ef5f6fc295fcf33225003f4d09af41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aa9dc86f33f3adc40a0a4163607bc3eef86c1cc74fe1bae9235812ae6fc5810809ab32d102b49abd9569558278bafac6f9751795f5d4646d640a04b41a2a8c5"} 21:59:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:59:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:59:16 INFO - Contents: 21:59:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/810fcf5222d82c4985d510421626b3da85cbfd3c6b98c55493bccda4cd16ebcc9db8a9c9c2fa28772413ab4a44c762995a61e53bfda9843833f334ab056998d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f8e47c2367cca9c84988089beeab399f6c5c4343038457a3629f7fa237493c88448295fccc84768687768b8c9518c5b643fb0e99a279124cfd242e35ef6eb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0d0bea71a4f3999f7987799811ced45f0b38edb439b37e736c5e5fd92dc9c42775aaac2ca2c1e2499367ceac37b56abc0ef5f6fc295fcf33225003f4d09af41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aa9dc86f33f3adc40a0a4163607bc3eef86c1cc74fe1bae9235812ae6fc5810809ab32d102b49abd9569558278bafac6f9751795f5d4646d640a04b41a2a8c5"} 21:59:16 INFO - Running post-run listener: copy_logs_to_upload_dir 21:59:16 INFO - Copying logs to upload dir... 21:59:16 INFO - mkdir: /builds/slave/test/build/upload/logs 21:59:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.711809 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-24 21:59:16.359037) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 21:59:16.363397) ========= 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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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/810fcf5222d82c4985d510421626b3da85cbfd3c6b98c55493bccda4cd16ebcc9db8a9c9c2fa28772413ab4a44c762995a61e53bfda9843833f334ab056998d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f8e47c2367cca9c84988089beeab399f6c5c4343038457a3629f7fa237493c88448295fccc84768687768b8c9518c5b643fb0e99a279124cfd242e35ef6eb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0d0bea71a4f3999f7987799811ced45f0b38edb439b37e736c5e5fd92dc9c42775aaac2ca2c1e2499367ceac37b56abc0ef5f6fc295fcf33225003f4d09af41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aa9dc86f33f3adc40a0a4163607bc3eef86c1cc74fe1bae9235812ae6fc5810809ab32d102b49abd9569558278bafac6f9751795f5d4646d640a04b41a2a8c5"} build_url:https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010947 build_url: 'https://queue.taskcluster.net/v1/task/M0omE3V5Qhm_nclYfDbv3A/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/810fcf5222d82c4985d510421626b3da85cbfd3c6b98c55493bccda4cd16ebcc9db8a9c9c2fa28772413ab4a44c762995a61e53bfda9843833f334ab056998d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f8e47c2367cca9c84988089beeab399f6c5c4343038457a3629f7fa237493c88448295fccc84768687768b8c9518c5b643fb0e99a279124cfd242e35ef6eb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0d0bea71a4f3999f7987799811ced45f0b38edb439b37e736c5e5fd92dc9c42775aaac2ca2c1e2499367ceac37b56abc0ef5f6fc295fcf33225003f4d09af41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aa9dc86f33f3adc40a0a4163607bc3eef86c1cc74fe1bae9235812ae6fc5810809ab32d102b49abd9569558278bafac6f9751795f5d4646d640a04b41a2a8c5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 21:59:16.401895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 21:59:16.402268) ========= 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.2XFdVXHPjV/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.zmUNSBIhJl/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005122 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 21:59:16.450781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 21:59:16.454134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 21:59:16.454451) ========= ========= Total master_lag: 0.21 =========