builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0292 starttime: 1492796493.21 results: success (0) buildid: 20170421090219 builduid: 2aefdf1402184f4aa7593241c46f042d revision: 0b1d1dfe7055a8568e1cc7ea5f74c6fd63ada14c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:33.205444) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:33.205896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:33.206186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:33.233559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:33.233949) ========= 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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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-21 10:41:33-- 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% 60.2M=0s 2017-04-21 10:41:33 (60.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.309852 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:33.569136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:33.569459) ========= 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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.027180 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:33.618899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 10:41:33.619276) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b1d1dfe7055a8568e1cc7ea5f74c6fd63ada14c --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 0b1d1dfe7055a8568e1cc7ea5f74c6fd63ada14c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RCKfX6D8f4/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.wS7hCvrxiA/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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-21 10:41:33,727 truncating revision to first 12 chars 2017-04-21 10:41:33,727 Setting DEBUG logging. 2017-04-21 10:41:33,727 attempt 1/10 2017-04-21 10:41:33,727 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b1d1dfe7055?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 10:41:34,416 unpacking tar archive at: mozilla-central-0b1d1dfe7055/testing/mozharness/ program finished with exit code 0 elapsedTime=0.976174 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 10:41:34.619975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:34.620305) ========= script_repo_revision: 0b1d1dfe7055a8568e1cc7ea5f74c6fd63ada14c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:34.620702) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:34.620985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:41:34.641806) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-21 10:41:34.642358) ========= /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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:41:34 INFO - MultiFileLogger online at 20170421 10:41:34 in /builds/slave/test 10:41:34 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 10:41:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:41:34 INFO - {'append_to_log': False, 10:41:34 INFO - 'base_work_dir': '/builds/slave/test', 10:41:34 INFO - 'blob_upload_branch': 'Firefox', 10:41:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:41:34 INFO - 'branch': 'Firefox', 10:41:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:41:34 INFO - 'config_files': ('talos/mac_config.py',), 10:41:34 INFO - 'default_actions': ('clobber', 10:41:34 INFO - 'read-buildbot-config', 10:41:34 INFO - 'download-and-extract', 10:41:34 INFO - 'populate-webroot', 10:41:34 INFO - 'create-virtualenv', 10:41:34 INFO - 'install', 10:41:34 INFO - 'run-tests'), 10:41:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:41:34 INFO - 'download_minidump_stackwalk': True, 10:41:34 INFO - 'download_symbols': 'ondemand', 10:41:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:41:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:41:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:41:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:41:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:41:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:41:34 INFO - 'gecko_profile': False, 10:41:34 INFO - 'gecko_profile_interval': 0, 10:41:34 INFO - 'installer_path': 'installer.exe', 10:41:34 INFO - 'log_level': 'info', 10:41:34 INFO - 'log_name': 'talos', 10:41:34 INFO - 'log_to_console': True, 10:41:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:41:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:41:34 INFO - 'opt_config_files': (), 10:41:34 INFO - 'pip_index': False, 10:41:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:41:34 INFO - 'cmd': ('bash', 10:41:34 INFO - '-c', 10:41:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:41:34 INFO - 'enabled': True, 10:41:34 INFO - 'halt_on_failure': False, 10:41:34 INFO - 'name': 'check_screen_resolution'},), 10:41:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:41:34 INFO - 'cmd': ('bash', 10:41:34 INFO - '-c', 10:41:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:41:34 INFO - 'enabled': True, 10:41:34 INFO - 'halt_on_failure': False, 10:41:34 INFO - 'name': 'check_screen_resolution'},), 10:41:34 INFO - 'run_cmd_checks_enabled': True, 10:41:34 INFO - 'suite': 'dromaeojs-e10s', 10:41:34 INFO - 'system_bits': '32', 10:41:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:41:34 INFO - 'title': 't-yosemite-r7-0292', 10:41:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:41:34 INFO - 'use_talos_json': True, 10:41:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:41:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:41:34 INFO - 'work_dir': 'build'} 10:41:34 INFO - [mozharness: 2017-04-21 17:41:34.856241Z] Running clobber step. 10:41:34 INFO - Running pre-action listener: _resource_record_pre_action 10:41:34 INFO - Running main action method: clobber 10:41:34 INFO - rmtree: /builds/slave/test/build 10:41:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:41:37 INFO - Running post-action listener: _resource_record_post_action 10:41:37 INFO - [mozharness: 2017-04-21 17:41:37.368515Z] Finished clobber step (success) 10:41:37 INFO - [mozharness: 2017-04-21 17:41:37.368649Z] Running read-buildbot-config step. 10:41:37 INFO - Running pre-action listener: _resource_record_pre_action 10:41:37 INFO - Running main action method: read_buildbot_config 10:41:37 INFO - Using buildbot properties: 10:41:37 INFO - { 10:41:37 INFO - "project": "", 10:41:37 INFO - "product": "firefox", 10:41:37 INFO - "script_repo_revision": "production", 10:41:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:41:37 INFO - "repository": "", 10:41:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:41:37 INFO - "buildid": "20170421090219", 10:41:37 INFO - "pgo_build": "False", 10:41:37 INFO - "basedir": "/builds/slave/test", 10:41:37 INFO - "buildnumber": 196, 10:41:37 INFO - "slavename": "t-yosemite-r7-0292", 10:41:37 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:41:37 INFO - "platform": "yosemite_r7", 10:41:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:41:37 INFO - "branch": "mozilla-central", 10:41:37 INFO - "repo_path": "mozilla-central", 10:41:37 INFO - "revision": "0b1d1dfe7055a8568e1cc7ea5f74c6fd63ada14c", 10:41:37 INFO - "stage_platform": "macosx64", 10:41:37 INFO - "builduid": "2aefdf1402184f4aa7593241c46f042d", 10:41:37 INFO - "slavebuilddir": "test" 10:41:37 INFO - } 10:41:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:41:37 INFO - Running post-action listener: _resource_record_post_action 10:41:37 INFO - [mozharness: 2017-04-21 17:41:37.371961Z] Finished read-buildbot-config step (success) 10:41:37 INFO - [mozharness: 2017-04-21 17:41:37.372099Z] Running download-and-extract step. 10:41:37 INFO - Running pre-action listener: _resource_record_pre_action 10:41:37 INFO - Running main action method: download_and_extract 10:41:37 INFO - mkdir: /builds/slave/test/build/tests 10:41:37 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')]} 10:41:37 INFO - trying https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:41:37 INFO - Downloading https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/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 10:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/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 10:41:38 INFO - Downloaded 1325 bytes. 10:41:38 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:41:38 INFO - Using the following test package requirements: 10:41:38 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:41:38 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:41:38 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:41:38 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:41:38 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:41:38 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:41:38 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:41:38 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:41:38 INFO - u'jsshell-mac.zip'], 10:41:38 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:41:38 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:41:38 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:41:38 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:41:38 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:41:38 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:41:38 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:41:38 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:41:38 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:41:38 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:41:38 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:41:38 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:41:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:41:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:41:38 INFO - Fetch https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:41:40 INFO - Expected file size: 52526540 10:41:40 INFO - Obtained file size: 52526540 10:41:56 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 10:41:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:41:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:41:56 INFO - Fetch https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:41:58 INFO - Expected file size: 52526540 10:41:58 INFO - Obtained file size: 52526540 10:42:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:42:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:42:14 INFO - Fetch https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:42:15 INFO - Expected file size: 14408811 10:42:15 INFO - Obtained file size: 14408811 10:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:15 INFO - trying https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:42:15 INFO - Downloading https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:42:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/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 10:42:17 INFO - Downloaded 71026488 bytes. 10:42:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:42:17 INFO - mkdir: /builds/slave/test/properties 10:42:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:42:17 INFO - Writing to file /builds/slave/test/properties/build_url 10:42:17 INFO - Contents: 10:42:17 INFO - build_url:https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:42:18 INFO - Running post-action listener: _resource_record_post_action 10:42:18 INFO - Running post-action listener: set_extra_try_arguments 10:42:18 INFO - [mozharness: 2017-04-21 17:42:18.457027Z] Finished download-and-extract step (success) 10:42:18 INFO - [mozharness: 2017-04-21 17:42:18.457159Z] Running populate-webroot step. 10:42:18 INFO - Running pre-action listener: _resource_record_pre_action 10:42:18 INFO - Running main action method: populate_webroot 10:42:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:42:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:42:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:42:18 INFO - '--tppagecycles', 10:42:18 INFO - '7'], 10:42:18 INFO - 'tests': ['tsvgm']}}, 10:42:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:42:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:42:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:42:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:42:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:42:18 INFO - 'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:42:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:42:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:42:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:42:18 INFO - 'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['damp', 'tps']}, 10:42:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:42:18 INFO - 'tests': ['damp', 'tps']}, 10:42:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['dromaeo_dom']}, 10:42:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:42:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:42:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:42:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['a11yr', 10:42:18 INFO - 'ts_paint', 10:42:18 INFO - 'tpaint', 10:42:18 INFO - 'sessionrestore', 10:42:18 INFO - 'sessionrestore_no_auto_restore', 10:42:18 INFO - 'tabpaint']}, 10:42:18 INFO - 'other-e10s': {'tests': ['a11yr', 10:42:18 INFO - 'ts_paint', 10:42:18 INFO - 'tpaint', 10:42:18 INFO - 'sessionrestore', 10:42:18 INFO - 'sessionrestore_no_auto_restore', 10:42:18 INFO - 'tabpaint']}, 10:42:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:42:18 INFO - 'ts_paint', 10:42:18 INFO - 'tpaint', 10:42:18 INFO - 'sessionrestore', 10:42:18 INFO - 'sessionrestore_no_auto_restore', 10:42:18 INFO - 'tabpaint']}, 10:42:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:42:18 INFO - 'ts_paint', 10:42:18 INFO - 'tpaint', 10:42:18 INFO - 'sessionrestore', 10:42:18 INFO - 'sessionrestore_no_auto_restore', 10:42:18 INFO - 'tabpaint']}, 10:42:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['a11yr', 10:42:18 INFO - 'ts_paint', 10:42:18 INFO - 'tpaint', 10:42:18 INFO - 'sessionrestore', 10:42:18 INFO - 'sessionrestore_no_auto_restore', 10:42:18 INFO - 'tabpaint']}, 10:42:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['a11yr', 10:42:18 INFO - 'ts_paint', 10:42:18 INFO - 'tpaint', 10:42:18 INFO - 'sessionrestore', 10:42:18 INFO - 'sessionrestore_no_auto_restore', 10:42:18 INFO - 'tabpaint']}, 10:42:18 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:42:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:42:18 INFO - 'bloom_basic_ref']}, 10:42:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['tsvgx', 10:42:18 INFO - 'tsvgr_opacity', 10:42:18 INFO - 'tart', 10:42:18 INFO - 'tscrollx', 10:42:18 INFO - 'cart', 10:42:18 INFO - 'tsvg_static']}, 10:42:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:42:18 INFO - 'tsvgr_opacity', 10:42:18 INFO - 'tart', 10:42:18 INFO - 'tscrollx', 10:42:18 INFO - 'cart', 10:42:18 INFO - 'tsvg_static']}, 10:42:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:42:18 INFO - 'talos_options': ['--disable-e10s'], 10:42:18 INFO - 'tests': ['tp5o']}, 10:42:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:42:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:42:18 INFO - 'talos_options': ['--disable-e10s', 10:42:18 INFO - '--xperf_path', 10:42:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:42:18 INFO - 'tests': ['tp5n']}, 10:42:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:42:18 INFO - 'talos_options': ['--xperf_path', 10:42:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:42:18 INFO - 'tests': ['tp5n']}}, 10:42:18 INFO - 'talos.zip': {'path': '', 10:42:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:42:18 INFO - Running post-action listener: _resource_record_post_action 10:42:18 INFO - [mozharness: 2017-04-21 17:42:18.475826Z] Finished populate-webroot step (success) 10:42:18 INFO - [mozharness: 2017-04-21 17:42:18.475964Z] Running create-virtualenv step. 10:42:18 INFO - Running pre-action listener: _resource_record_pre_action 10:42:18 INFO - Running main action method: create_virtualenv 10:42:18 INFO - Creating virtualenv /builds/slave/test/build/venv 10:42:18 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 10:42:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:42:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:42:18 INFO - Using real prefix '/tools/python27' 10:42:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:42:19 INFO - Installing distribute.............................................................................................................................................................................................done. 10:42:22 INFO - Installing pip.................done. 10:42:22 INFO - Return code: 0 10:42:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:42:22 INFO - Reading from file tmpfile_stdout 10:42:22 INFO - Output received: 10:42:22 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) 10:42:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:42:22 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')]} 10:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:22 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')]} 10:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:22 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 0x1061c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee91cd3ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, '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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:42:22 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 10:42:22 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 10:42:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:42:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:42:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:42:22 INFO - 'HOME': '/Users/cltbld', 10:42:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:42:22 INFO - 'LOGNAME': 'cltbld', 10:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:22 INFO - 'MOZ_NO_REMOTE': '1', 10:42:22 INFO - 'NO_EM_RESTART': '1', 10:42:22 INFO - 'PAGER': '/bin/cat', 10:42:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:22 INFO - 'PWD': '/builds/slave/test', 10:42:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:42:22 INFO - 'SHELL': '/bin/bash', 10:42:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:42:22 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:42:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:42:22 INFO - 'USER': 'cltbld', 10:42:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:42:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:22 INFO - 'XPC_FLAGS': '0x0', 10:42:22 INFO - 'XPC_SERVICE_NAME': '0', 10:42:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:22 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 10:42:22 INFO - Cleaning up... 10:42:22 INFO - Return code: 0 10:42:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:42:22 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')]} 10:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:22 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')]} 10:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:22 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 0x1061c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee91cd3ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, '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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:42:22 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 10:42:22 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 10:42:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:42:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:42:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:42:22 INFO - 'HOME': '/Users/cltbld', 10:42:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:42:22 INFO - 'LOGNAME': 'cltbld', 10:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:22 INFO - 'MOZ_NO_REMOTE': '1', 10:42:22 INFO - 'NO_EM_RESTART': '1', 10:42:22 INFO - 'PAGER': '/bin/cat', 10:42:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:22 INFO - 'PWD': '/builds/slave/test', 10:42:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:42:22 INFO - 'SHELL': '/bin/bash', 10:42:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:42:22 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:42:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:42:22 INFO - 'USER': 'cltbld', 10:42:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:42:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:22 INFO - 'XPC_FLAGS': '0x0', 10:42:22 INFO - 'XPC_SERVICE_NAME': '0', 10:42:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:22 INFO - Downloading/unpacking psutil>=3.1.1 10:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:42:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:42:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:42:26 INFO - Installing collected packages: psutil 10:42:26 INFO - Running setup.py install for psutil 10:42:26 INFO - building 'psutil._psutil_osx' extension 10:42:26 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 10:42:27 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 10:42:27 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 10:42:27 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 10:42:27 INFO - building 'psutil._psutil_posix' extension 10:42:27 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 10:42:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:42:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:42:27 INFO - ^ 10:42:27 INFO - 1 warning generated. 10:42:27 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 10:42:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:42:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:42:27 INFO - Successfully installed psutil 10:42:27 INFO - Cleaning up... 10:42:27 INFO - Return code: 0 10:42:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee91cd3ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, '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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:42:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:42:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:42:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:42:27 INFO - 'HOME': '/Users/cltbld', 10:42:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:42:27 INFO - 'LOGNAME': 'cltbld', 10:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:27 INFO - 'MOZ_NO_REMOTE': '1', 10:42:27 INFO - 'NO_EM_RESTART': '1', 10:42:27 INFO - 'PAGER': '/bin/cat', 10:42:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:27 INFO - 'PWD': '/builds/slave/test', 10:42:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:42:27 INFO - 'SHELL': '/bin/bash', 10:42:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:42:27 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:42:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:42:27 INFO - 'USER': 'cltbld', 10:42:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:42:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:27 INFO - 'XPC_FLAGS': '0x0', 10:42:27 INFO - 'XPC_SERVICE_NAME': '0', 10:42:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:42:30 INFO - Installing collected packages: mozsystemmonitor 10:42:30 INFO - Running setup.py install for mozsystemmonitor 10:42:30 INFO - Successfully installed mozsystemmonitor 10:42:30 INFO - Cleaning up... 10:42:30 INFO - Return code: 0 10:42:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:42:30 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')]} 10:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:31 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')]} 10:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:31 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 0x1061c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee91cd3ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, '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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:42:31 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 10:42:31 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 10:42:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:42:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:42:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:42:31 INFO - 'HOME': '/Users/cltbld', 10:42:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:42:31 INFO - 'LOGNAME': 'cltbld', 10:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:31 INFO - 'MOZ_NO_REMOTE': '1', 10:42:31 INFO - 'NO_EM_RESTART': '1', 10:42:31 INFO - 'PAGER': '/bin/cat', 10:42:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:31 INFO - 'PWD': '/builds/slave/test', 10:42:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:42:31 INFO - 'SHELL': '/bin/bash', 10:42:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:42:31 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:42:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:42:31 INFO - 'USER': 'cltbld', 10:42:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:42:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:31 INFO - 'XPC_FLAGS': '0x0', 10:42:31 INFO - 'XPC_SERVICE_NAME': '0', 10:42:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:31 INFO - Downloading/unpacking jsonschema==2.5.1 10:42:31 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 10:42:31 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 10:42:31 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 10:42:31 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 10:42:31 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 10:42:31 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 10:42:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:42:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:42:33 INFO - warning: no files found matching '*.txt' 10:42:33 INFO - no previously-included directories found matching 'build' 10:42:33 INFO - no previously-included directories found matching 'dist' 10:42:33 INFO - no previously-included directories found matching '.git*' 10:42:33 INFO - Installing collected packages: jsonschema, functools32 10:42:34 INFO - Running setup.py install for functools32 10:42:34 INFO - warning: no files found matching '*.txt' 10:42:34 INFO - no previously-included directories found matching 'build' 10:42:34 INFO - no previously-included directories found matching 'dist' 10:42:34 INFO - no previously-included directories found matching '.git*' 10:42:34 INFO - Successfully installed jsonschema functools32 10:42:34 INFO - Cleaning up... 10:42:34 INFO - Return code: 0 10:42:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:42:34 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')]} 10:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:34 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')]} 10:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:34 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 0x1061c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee91cd3ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, '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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:42:34 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 10:42:34 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 10:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:42:34 INFO - 'HOME': '/Users/cltbld', 10:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:42:34 INFO - 'LOGNAME': 'cltbld', 10:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:34 INFO - 'MOZ_NO_REMOTE': '1', 10:42:34 INFO - 'NO_EM_RESTART': '1', 10:42:34 INFO - 'PAGER': '/bin/cat', 10:42:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:34 INFO - 'PWD': '/builds/slave/test', 10:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:42:34 INFO - 'SHELL': '/bin/bash', 10:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:42:34 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:42:34 INFO - 'USER': 'cltbld', 10:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:34 INFO - 'XPC_FLAGS': '0x0', 10:42:34 INFO - 'XPC_SERVICE_NAME': '0', 10:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:42:34 INFO - Cleaning up... 10:42:34 INFO - Return code: 0 10:42:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:42:34 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')]} 10:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:34 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')]} 10:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:34 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 0x1061c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee91cd3ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, '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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:42:34 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 10:42:34 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 10:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:42:34 INFO - 'HOME': '/Users/cltbld', 10:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:42:34 INFO - 'LOGNAME': 'cltbld', 10:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:34 INFO - 'MOZ_NO_REMOTE': '1', 10:42:34 INFO - 'NO_EM_RESTART': '1', 10:42:34 INFO - 'PAGER': '/bin/cat', 10:42:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:34 INFO - 'PWD': '/builds/slave/test', 10:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:42:34 INFO - 'SHELL': '/bin/bash', 10:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:42:34 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:42:34 INFO - 'USER': 'cltbld', 10:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:34 INFO - 'XPC_FLAGS': '0x0', 10:42:34 INFO - 'XPC_SERVICE_NAME': '0', 10:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:34 INFO - Downloading/unpacking blobuploader==1.2.4 10:42:34 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 10:42:34 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 10:42:34 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 10:42:34 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 10:42:34 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 10:42:34 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 10:42:37 INFO - Downloading blobuploader-1.2.4.tar.gz 10:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:42:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:42:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:38 INFO - Downloading docopt-0.6.1.tar.gz 10:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:42:38 INFO - Installing collected packages: blobuploader, requests, docopt 10:42:38 INFO - Running setup.py install for blobuploader 10:42:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:42:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:42:38 INFO - Running setup.py install for requests 10:42:39 INFO - Running setup.py install for docopt 10:42:39 INFO - Successfully installed blobuploader requests docopt 10:42:39 INFO - Cleaning up... 10:42:39 INFO - Return code: 0 10:42:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:39 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 0x1061c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee91cd3ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, '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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:42:39 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 10:42:39 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 10:42:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:42:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:42:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:42:39 INFO - 'HOME': '/Users/cltbld', 10:42:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:42:39 INFO - 'LOGNAME': 'cltbld', 10:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:39 INFO - 'MOZ_NO_REMOTE': '1', 10:42:39 INFO - 'NO_EM_RESTART': '1', 10:42:39 INFO - 'PAGER': '/bin/cat', 10:42:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:39 INFO - 'PWD': '/builds/slave/test', 10:42:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:42:39 INFO - 'SHELL': '/bin/bash', 10:42:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:42:39 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:42:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:42:39 INFO - 'USER': 'cltbld', 10:42:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:42:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:39 INFO - 'XPC_FLAGS': '0x0', 10:42:39 INFO - 'XPC_SERVICE_NAME': '0', 10:42:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:39 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-dqj4u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-IlMuvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-lu6oOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-DAXBHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-iLEXoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-saONMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-v2l_S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-yCBQEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-noveKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-NarAlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-iDVi1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-jQ66Ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-ChrJTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-JFG5Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-mQaVar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-MY8Irk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-s2J8WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:42:41 INFO - Running setup.py install for manifestparser 10:42:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:42:41 INFO - Running setup.py install for mozcrash 10:42:41 INFO - Running setup.py install for mozdebug 10:42:42 INFO - Running setup.py install for mozdevice 10:42:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:42:42 INFO - Running setup.py install for mozfile 10:42:42 INFO - Running setup.py install for mozhttpd 10:42:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:42:42 INFO - Running setup.py install for mozinfo 10:42:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:42:42 INFO - Running setup.py install for mozInstall 10:42:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:42:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:42:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:42:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:42:42 INFO - Running setup.py install for mozleak 10:42:42 INFO - Running setup.py install for mozlog 10:42:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:42:43 INFO - Running setup.py install for moznetwork 10:42:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:42:43 INFO - Running setup.py install for mozprocess 10:42:43 INFO - Running setup.py install for mozprofile 10:42:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:42:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:42:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:42:43 INFO - Running setup.py install for mozrunner 10:42:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:42:43 INFO - Running setup.py install for mozscreenshot 10:42:43 INFO - Running setup.py install for moztest 10:42:44 INFO - Running setup.py install for mozversion 10:42:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:42:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:42:44 INFO - Cleaning up... 10:42:44 INFO - Return code: 0 10:42:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:44 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 0x1061c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee91cd3ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, '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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:42:44 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 10:42:44 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 10:42:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:42:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:42:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:42:44 INFO - 'HOME': '/Users/cltbld', 10:42:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:42:44 INFO - 'LOGNAME': 'cltbld', 10:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:44 INFO - 'MOZ_NO_REMOTE': '1', 10:42:44 INFO - 'NO_EM_RESTART': '1', 10:42:44 INFO - 'PAGER': '/bin/cat', 10:42:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:44 INFO - 'PWD': '/builds/slave/test', 10:42:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:42:44 INFO - 'SHELL': '/bin/bash', 10:42:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:42:44 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:42:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:42:44 INFO - 'USER': 'cltbld', 10:42:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:42:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:44 INFO - 'XPC_FLAGS': '0x0', 10:42:44 INFO - 'XPC_SERVICE_NAME': '0', 10:42:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:42:44 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-yyohE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:42:44 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)) 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:42:44 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-d0bG8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:42:44 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)) 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:42:44 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-4pr17a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:42:44 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)) 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:42:44 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-hKLoTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:42:44 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)) 10:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:42:44 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-LFTuFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:42:45 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)) 10:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:42:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-8iFCxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:42:45 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)) 10:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:42:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Xw8l89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:42:45 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)) 10:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:42:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-tk0mSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:42:45 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)) 10:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:42:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-w6W1_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:42:45 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)) 10:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:42:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-2iZOE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:42:45 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)) 10:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:42:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-nNoBZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:42:45 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)) 10:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:42:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-iZ8Ljs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:42:45 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)) 10:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:42:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Pf5Tzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:42:45 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)) 10:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:42:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-sd7guo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:42:45 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)) 10:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-MwYUPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:42:46 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)) 10:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:42:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-eZnKhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:42:46 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)) 10:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:42:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Ri1kXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:42:46 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)) 10:42:46 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)) 10:42:46 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)) 10:42:46 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)) 10:42:46 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)) 10:42:46 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)) 10:42:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42: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 10:42:48 INFO - Downloading blessings-1.6.tar.gz 10:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:42:49 INFO - Installing collected packages: blessings 10:42:49 INFO - Running setup.py install for blessings 10:42:49 INFO - Successfully installed blessings 10:42:49 INFO - Cleaning up... 10:42:49 INFO - Return code: 0 10:42:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:42:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:49 INFO - Reading from file tmpfile_stdout 10:42:49 INFO - Current package versions: 10:42:49 INFO - blessings == 1.6 10:42:49 INFO - blobuploader == 1.2.4 10:42:49 INFO - docopt == 0.6.1 10:42:49 INFO - functools32 == 3.2.3-2 10:42:49 INFO - jsonschema == 2.5.1 10:42:49 INFO - manifestparser == 1.1 10:42:49 INFO - mozInstall == 1.12 10:42:49 INFO - mozcrash == 1.0 10:42:49 INFO - mozdebug == 0.1 10:42:49 INFO - mozdevice == 0.50 10:42:49 INFO - mozfile == 1.2 10:42:49 INFO - mozhttpd == 0.7 10:42:49 INFO - mozinfo == 0.9 10:42:49 INFO - mozleak == 0.1 10:42:49 INFO - mozlog == 3.4 10:42:49 INFO - moznetwork == 0.27 10:42:49 INFO - mozprocess == 0.25 10:42:49 INFO - mozprofile == 0.28 10:42:49 INFO - mozrunner == 6.13 10:42:49 INFO - mozscreenshot == 0.1 10:42:49 INFO - mozsystemmonitor == 0.3 10:42:49 INFO - moztest == 0.8 10:42:49 INFO - mozversion == 1.4 10:42:49 INFO - psutil == 3.1.1 10:42:49 INFO - requests == 1.2.3 10:42:49 INFO - wsgiref == 0.1.2 10:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x1061c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee91cd3ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, '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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:42:49 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 10:42:49 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 10:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:42:49 INFO - 'HOME': '/Users/cltbld', 10:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:42:49 INFO - 'LOGNAME': 'cltbld', 10:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:49 INFO - 'MOZ_NO_REMOTE': '1', 10:42:49 INFO - 'NO_EM_RESTART': '1', 10:42:49 INFO - 'PAGER': '/bin/cat', 10:42:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:49 INFO - 'PWD': '/builds/slave/test', 10:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:42:49 INFO - 'SHELL': '/bin/bash', 10:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:42:49 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:42:49 INFO - 'USER': 'cltbld', 10:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:49 INFO - 'XPC_FLAGS': '0x0', 10:42:49 INFO - 'XPC_SERVICE_NAME': '0', 10:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:49 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)) 10:42:49 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)) 10:42:49 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)) 10:42:49 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)) 10:42:49 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)) 10:42:49 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)) 10:42:49 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)) 10:42:49 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)) 10:42:49 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)) 10:42:49 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)) 10:42:49 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)) 10:42:49 INFO - Cleaning up... 10:42:49 INFO - Return code: 0 10:42:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:42: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee91cd3ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, '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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 10:42: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', 'jsonschema'] in /builds/slave/test/build 10:42: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 jsonschema 10:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:42:49 INFO - 'HOME': '/Users/cltbld', 10:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:42:49 INFO - 'LOGNAME': 'cltbld', 10:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:49 INFO - 'MOZ_NO_REMOTE': '1', 10:42:49 INFO - 'NO_EM_RESTART': '1', 10:42:49 INFO - 'PAGER': '/bin/cat', 10:42:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:49 INFO - 'PWD': '/builds/slave/test', 10:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:42:49 INFO - 'SHELL': '/bin/bash', 10:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:42:49 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:42:49 INFO - 'USER': 'cltbld', 10:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:49 INFO - 'XPC_FLAGS': '0x0', 10:42:49 INFO - 'XPC_SERVICE_NAME': '0', 10:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:42:50 INFO - Cleaning up... 10:42:50 INFO - Return code: 0 10:42:50 INFO - Running post-action listener: _resource_record_post_action 10:42:50 INFO - Running post-action listener: _start_resource_monitoring 10:42:50 INFO - Starting resource monitoring. 10:42:50 INFO - [mozharness: 2017-04-21 17:42:50.181111Z] Finished create-virtualenv step (success) 10:42:50 INFO - [mozharness: 2017-04-21 17:42:50.182064Z] Running install step. 10:42:50 INFO - Running pre-action listener: _resource_record_pre_action 10:42:50 INFO - Running main action method: install 10:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:50 INFO - Reading from file tmpfile_stdout 10:42:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:42:50 INFO - Reading from file tmpfile_stdout 10:42:50 INFO - Output received: 10:42:50 INFO - Usage: mozinstall [options] installer 10:42:50 INFO - Options: 10:42:50 INFO - -h, --help show this help message and exit 10:42:50 INFO - -d DEST, --destination=DEST 10:42:50 INFO - Directory to install application into. [default: 10:42:50 INFO - "/builds/slave/test"] 10:42:50 INFO - --app=APP Application being installed. [default: firefox] 10:42:50 INFO - mkdir: /builds/slave/test/build/application 10:42:50 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'] 10:42:50 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 10:43:10 INFO - Reading from file tmpfile_stdout 10:43:10 INFO - Output received: 10:43:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:43:10 INFO - Running post-action listener: _resource_record_post_action 10:43:10 INFO - [mozharness: 2017-04-21 17:43:10.497374Z] Finished install step (success) 10:43:10 INFO - [mozharness: 2017-04-21 17:43:10.497516Z] Running run-tests step. 10:43:10 INFO - Running pre-action listener: _resource_record_pre_action 10:43:10 INFO - Running main action method: run_tests 10:43:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:43:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:43:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:43:10 INFO - 2017-04-21 10:43:10.511 screenresolution[1626:7425] starting screenresolution argv=screenresolution get 10:43:10 INFO - 2017-04-21 10:43:10.514 screenresolution[1626:7425] Display 0: 1600x1200x32@60 10:43:10 INFO - 2017-04-21 10:43:10.520 screenresolution[1627:7428] starting screenresolution argv=screenresolution list 10:43:10 INFO - Available Modes on Display 0 10:43:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:43:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:43:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:43:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:43:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:43:10 INFO - Intel Iris: 10:43:10 INFO - Chipset Model: Intel Iris 10:43:10 INFO - Type: GPU 10:43:10 INFO - Bus: Built-In 10:43:10 INFO - VRAM (Dynamic, Max): 1536 MB 10:43:10 INFO - Vendor: Intel (0x8086) 10:43:10 INFO - Device ID: 0x0a2e 10:43:10 INFO - Revision ID: 0x0009 10:43:10 INFO - Displays: 10:43:10 INFO - Display: 10:43:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:43:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:43:10 INFO - Display Serial Number: 1600x1200 60 10:43:10 INFO - Main Display: Yes 10:43:10 INFO - Mirror: Off 10:43:10 INFO - Online: Yes 10:43:10 INFO - Rotation: Supported 10:43:10 INFO - Return code: 0 10:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:43:10 INFO - Python 2.7.3 10:43:10 INFO - Return code: 0 10:43:10 INFO - grabbing minidump binary from tooltool 10:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:43:10 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 0x105fa3d30>, '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 0x105ec9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f98be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:43:10 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 10:43:10 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 10:43:10 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 10:43:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:43:10 INFO - Return code: 0 10:43:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:43:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:43:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:43:10 INFO - ENV: RUST_BACKTRACE is now 1 10:43:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:43:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:43:10 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/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--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 10:43:10 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/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0292 --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 10:43:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RCKfX6D8f4/Render', 10:43:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:10 INFO - 'HOME': '/Users/cltbld', 10:43:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:10 INFO - 'LOGNAME': 'cltbld', 10:43:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:43:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:10 INFO - 'MOZ_NO_REMOTE': '1', 10:43:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:43:10 INFO - 'NO_EM_RESTART': '1', 10:43:10 INFO - 'PAGER': '/bin/cat', 10:43:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:10 INFO - 'PWD': '/builds/slave/test', 10:43:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:43:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:10 INFO - 'RUST_BACKTRACE': '1', 10:43:10 INFO - 'SHELL': '/bin/bash', 10:43:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wS7hCvrxiA/Listeners', 10:43:10 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:43:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:10 INFO - 'USER': 'cltbld', 10:43:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:10 INFO - 'XPC_FLAGS': '0x0', 10:43:10 INFO - 'XPC_SERVICE_NAME': '0', 10:43:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:10 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/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--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 10:43:11 INFO - mozversion application_buildid: 20170421090219 10:43:11 INFO - mozversion application_changeset: 0b1d1dfe7055a8568e1cc7ea5f74c6fd63ada14c 10:43:11 INFO - mozversion application_display_name: Nightly 10:43:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:43:11 INFO - mozversion application_name: Firefox 10:43:11 INFO - mozversion application_remotingname: firefox 10:43:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:43:11 INFO - mozversion application_vendor: Mozilla 10:43:11 INFO - mozversion application_version: 55.0a1 10:43:11 INFO - mozversion platform_buildid: 20170421090219 10:43:11 INFO - mozversion platform_changeset: 0b1d1dfe7055a8568e1cc7ea5f74c6fd63ada14c 10:43:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:43:11 INFO - mozversion platform_version: 55.0a1 10:43:11 INFO - using testdate: 1492796591 10:43:11 INFO - actual date: 1492796591 10:43:11 INFO - starting webserver on 'localhost:49243' 10:43:11 INFO - SUITE-START | Running 2 tests 10:43:11 INFO - TEST-START | dromaeo_css 10:43:11 INFO - operating with platform_type : mac_ 10:43:11 INFO - Initialising browser for dromaeo_css test... 10:43:11 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmplUWscm/profile http://localhost:49243/getInfo.html) 10:43:14 INFO - PID 1637 | 2017-04-21 10:43:14.128 plugin-container[1639:7610] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname' 10:43:14 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:43:14 INFO - PID 1637 | 2017-04-21 10:43:14.132 plugin-container[1639:7610] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0b, name = 'com.apple.CFPasteboardClient' 10:43:14 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:43:14 INFO - PID 1637 | 2017-04-21 10:43:14.132 plugin-container[1639:7610] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:43:14 INFO - PID 1637 | __metrics Screen width/height:1600/1200 10:43:14 INFO - PID 1637 | colorDepth:24 10:43:14 INFO - PID 1637 | Browser inner width/height: 1024/689 10:43:14 INFO - PID 1637 | __metrics 10:43:14 ERROR - PID 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 10:43:15 INFO - TEST-INFO | 1637: exit 0 10:43:15 INFO - Browser initialized. 10:43:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:43:15 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmplUWscm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:43:17 INFO - PID 1640 | 2017-04-21 10:43:17.829 plugin-container[1641:7746] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 10:43:17 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:43:17 INFO - PID 1640 | 2017-04-21 10:43:17.830 plugin-container[1641:7746] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 10:43:17 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:43:17 INFO - PID 1640 | 2017-04-21 10:43:17.830 plugin-container[1641:7746] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:43:27 INFO - PID 1640 | RSS: Main: 236126208 10:43:27 INFO - PID 1640 | 10:46:31 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 10:46:33 INFO - PID 1640 | RSS: Main: 251916288 10:46:33 INFO - PID 1640 | 10:48:15 INFO - PID 1640 | ************************* 10:48:15 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 10:48:15 INFO - PID 1640 | 10:48:15 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:48:15 INFO - PID 1640 | Full stack: 10:48:15 INFO - PID 1640 | ************************* 10:48:15 INFO - PID 1640 | ************************* 10:48:15 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 10:48:15 INFO - PID 1640 | 10:48:15 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:48:15 INFO - PID 1640 | Full stack: 10:48:15 INFO - PID 1640 | ************************* 10:48:15 INFO - PID 1640 | ************************* 10:48:15 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 10:48:15 INFO - PID 1640 | 10:48:15 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:48:15 INFO - PID 1640 | Full stack: 10:48:15 INFO - PID 1640 | ************************* 10:48:15 INFO - PID 1640 | ************************* 10:48:15 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 10:48:15 INFO - PID 1640 | 10:48:15 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:48:15 INFO - PID 1640 | Full stack: 10:48:15 INFO - PID 1640 | ************************* 10:49:35 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 10:49:35 INFO - PID 1640 | RSS: Main: 260440064 10:49:35 INFO - PID 1640 | 10:52:37 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 10:52:37 INFO - PID 1640 | RSS: Main: 270200832 10:52:37 INFO - PID 1640 | 10:55:39 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 10:55:40 INFO - PID 1640 | RSS: Main: 264077312 10:55:40 INFO - PID 1640 | 10:58:43 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 10:58:43 INFO - PID 1640 | RSS: Main: 272785408 10:58:43 INFO - PID 1640 | 11:01:45 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 11:01:45 INFO - PID 1640 | RSS: Main: 267464704 11:01:45 INFO - PID 1640 | 11:01:45 INFO - PID 1640 | __start_tp_report 11:01:45 INFO - PID 1640 | _x_x_mozilla_page_load 11:01:45 INFO - PID 1640 | _x_x_mozilla_page_load_details 11:01:45 INFO - PID 1640 | |i|pagename|runs| 11:01:45 INFO - PID 1640 | |0;dojo.html;3060.801047931884;3592.8562857485704;3627.455881617757;3642.162302670384;3666.3217304798613;4885.364902562662;5463.7979644478255;5870.823875283749;6215.751369945202;6230.875382492348;5047.419546752125;6168.38316168383;6220.440160385564;6269.811905642827;6270.655113968742;5221.843344699665;5388.488093631099;5401.972990135064;5439.646422982493;5463.508284254416;5561.833145005657;5570.192322113291;5575.888482230353;5591.860203494904;5593.944060559404;5437.537809286216;5501.972490137524;5502.614816962814;5503.9174412383845;5515.751791169407;5473.890522189534;5479.643823151522;5484.561235101182;5491.835244942618;5523.392426833045;4734.976325118352;5435.972820135914;5440.755166017539;5478.890422191574;5519.889602207973;5109.080365534202;5625.606207565472;6172.074188871705;6182.845428864314;6184.690765461709;6628.237752658458;6640.535162538624;6645.102911106987;6653.234877989044;6662.900056499157;6722.092517510123;6740.8314792130095;6755.121834161577;6775.491838112112;6777.2545020047755;6135.171751813537;6238.313785483593;6333.1766870306565;6341.460975817061;6380.553361264713;5609.906068316721;6819.454443644497;6830.8633827324165;6869.072675188885;6874.690638921261;6260.467860231931;6359.046143078575;6364.809055728336;6380.968095159495;6559.442447392025;6542.443892269211;6543.640099794557;6744.393004629607;6757;6762.628055456898;6600.669966501656;6604.933950660432;6613;6620.569662971891;6626.337366263335;6368.012957991518;6374.107624932513;6446.484281257488;6552.50856185788;6609.140811694545;5297.735113244323;5343.839684809462;5347.25138480613;5353.892922141613;5394.460553944574;4731;4742.288656701522;4751.477337492873;4752.881177970578;4776.2119250324;6211.9689401552705;6287.056941458818;6322.4942004639515;6331.271903731038;6351.174347334817;6711.127553418024;6742.157230346207;6765.594064356154;6785.728570857209;6794.898076528856;6331.96834015827;6376.39424254695;6384.872302554016;6387.840303992437;6397.744090236339;4921.803127874845;5763.250777398911;5831.504322132666;5855.502282305966;5959.255093113361;5714.942850571608;6835.624040677711;6882.724691012303;6970.581765094111;6980.301969802979;5513.724313784214;6734.898976515454;6758.898616520658;6766.289539598271;6767.255601883888;5700.5154561861045;6912.101426814482;6926.411255043176;6987.266337034538;6998.930010699828;6373.8725225496155;6453.096566480603;6556.967215164084;6601.768938087144;6629.933700662931;6753.3921947025;6765.560238584476;6801.557898736566;6805.9659701701175;6815.556988795713;6237.313895471585;6363.395477429637;6476.222853257639;6564.606123632598;6601.504887133388;5781.942180578309;6395.808125756234;6398.87202255943;6462.450691691259;6541.215054193337;5579.972100139474;6070.089486577049;6388.968055159695;6413.102165696713;6419.2938776735455;6520.641364724986;6539.182602174728;6552.541322107407;6558.442532384801;6587.835304117244;5478.945210547843;6159.476444502267;6241.188645476059;6329.5569310149685;6333.58831675958 11:01:45 INFO - PID 1640 | |1;ext.html;715.5670819154411;791.4499422901082;805.7300804230581;1014.9340292880962;1242.1180961517323;35558.75544355948;36593.81703091484;36660.26679466416;36719.89840304788;36744;36923.892283231544;37253.88238352847;37292;37292.62707372926;37378.81310593443;7177.85644287114;7798.610069496531;7924.722634707787;8299.29455996241;8407.285380742644;8363.498190108583;8407.70573029944;8472.74581762548;8473.279771219453;8507.9587196082;8388.916110838905;8434.493930364199;8479.872801907977;8480.618372173236;8491.15088491149;8441.02928163263;8470.407071504935;8474.1949514796;8482.36382271329;8491.66033358668;8196.42625016249;8237.093919668832;8256.83486330276;8256.917430825675;8278.130796266365;35418.822905885565;35444;35456.46815297772;35472.64527354745;35601.93194204178;3559.501669766209;3560.572731272238;3599.5500562429697;3605.5312809334882;3607.981960090183;29470.85264573685;29758.726540080574;29982.400351993056;30069.849650751825;30078.699213007807;3078.9076327710204;3096;3106.6272047354464;3107.787962694551;3117.7817552771317;315448;317460;319472.40263798763;325554;327563;47469.762651186524;47520.76239618849;47522.762386187846;47613.28580071302;47674.76162619165;50461;50556.747216263684;53663.73168134213;54348.91302173935;54471.182932256044;11220.719482012852;13886.305684715724;13967.720645587235;13980.720385592434;13982;11031.779364412827;11106.500207490682;11137.721556961142;11149.331040137618;11153.442327883735;13927.164370137823;14084;14133.505327313494;14139.879018147154;14147;6089.934261504219;6095.05526643371;6123.387661233841;6129.785457508966;6132.344267047962;946.9810603787886;948.6158105967095;959.9632397011351;1003.4581326083833;1045.1429827541342;20117.597648046958;21741.67387489189;23496.882515587313;23942.88028559881;24135.63796543053;976.6386437018349;1100.834874768791;1105.2484310668822;1130.7908037013178;1139.7861277739346;8995.775105622412;10982.395968221665;12178.391080445943;12191.207571507824;12251.081168912368;310853;337776.24447511404;343049;345548;346792;51111.72220694438;51278.230826537634;51382.71543211375;51445.742771285906;51456.97086058258;1447.7176950494552;1456.9125852448888;1492.1271056431892;1499.8200215974152;1521.5131158029324;19284.807151928864;23292.767072329738;23354.299371018897;23500.764992349857;23667;36715.81642091773;36812.44781328336;36984;37083.814580926926;37260.6273937268;304392;304927;305031;305413;307304;33300;33501.66498334985;33540;33545.329093418484;33548.49677254892;41670.54153104627;42464.938376540835;42522;42570.361444577735;42600.57399425966;29413.55879661764;29442.411151776418;29730;30303.69696303009;30466.390672186877;23348.53302933966;29739.553906690984;30241.69758302477;30367;30427.087187384415;34892;34898;35296.647033529334;35334.46998295079;35471;29097.85451072731;29369.706302937553;30096.097117086523;30329.848350758104;30339;21170.682439763725;22678.773212268326;24479.63280550829;24480.387990300384;24695.7652117397 11:01:45 INFO - PID 1640 | |2;jquery.html;436.7248633360986;440.85011096227277;441.41292081531554;458.3537212530332;463.8608417474759;21092;21541.353759387224;21763.67354489682;22339.6649050264;22467;22240;22732.431689207777;22839.42901427465;23204.41988950277;23364;5959.761609535613;6192.473639740628;6208.2239720034995;6209.099680546341;6806.557573757715;7099.716011359539;7217.855642887139;7225.927740722578;7241.855162896765;7253.854922901539;6947.79156625302;7083.327083927019;7102.39629631482;7158.6040722059215;7204.459665525081;5782.10377391505;6109.938900610981;7057.752978645748;7103.0766000420135;7115.78652640419;6252.437280644718;6281.3404592518045;6282.811515654537;6287.1198032275515;6292.748290068392;27704.86147569249;28961.855190723913;28972.42055158906;29196.41607167866;29339.85330073336;2381.8570885746913;2415.1788391946648;2434.6469761884605;2435.281591930385;2438.573249681299;19089.80910190894;19330;19708.80291197084;19952.70070948937;20044.69932951007;2255.6052690779047;2374.3470545599926;2422.176460003607;2441.8046556275453;2443.144899285254;164502;165215;167530.32469675268;168059;172113;23818.880905595706;24299.757002430102;24950.12674556382;24953.636822610482;25169.62245566318;41739.15651808749;41782.582174178475;41820.79089604593;41968;42124.57875421207;7736.381089512825;8041.597920103972;8889.73330800077;9291.953540232256;9649.083337082966;7115.466340024519;8579.485230886043;8623.827523449496;8793;8795.340349473816;6767;8107.959460202779;8142.307903828241;8142.51144931306;8257;2299.942501437444;2300.194931773866;2305.2853615379286;2314.305708287507;2488.5147396257917;840.5545061117617;976.2482888176065;993.339429279521;1014.497823577334;1036.6371769880632;21528.354149375544;21987.34037978863;22139.225127120473;22200.444988875406;22737.09051637949;942.9292803039799;1015.5277795824829;1022.504085518523;1049.6011515624014;1059.6185373265619;9800.264980126376;10581.62964296246;11367.147463940237;11388.886111138783;11398.658040258806;574667;581361;587390;589366;590510;128735.06897396546;130130.34934825265;132391;141463;144989.10021799715;1060.7931453366673;1112.6383925224334;1224.9281878356437;1267.6387229639508;1272.4337669737063;17261.65476690434;22472;22621.547569048857;23035.539289214455;23144.421389464726;47088.76455617837;51241.46275611738;60539;60815.39184608097;61969;84485.57757211174;84861;85289;85706.57146714476;87559;7613.619319034137;8877.822443550964;9133.77165570866;9142.954285228532;9157.679481218125;13612.319384030561;13630.591082267549;13845.51540696111;14512.782308265174;14882.479113230986;11973.281603103842;12075.879241207476;12131.575394861138;12210.633680989584;12233;11545;11578;11579.594714184963;11596.304221746723;11798.941005294919;12254.87745122573;12266.325352105363;12398.504059837505;12431.254124752544;12618.116731828684;8150.9184908150155;8268.297194738274;8280;8328.958355208186;8364.247217750431;11411.885881141083;11615.883841161818;11661.825072623747;11738.647840564796;11750.529978801094 11:01:45 INFO - PID 1640 | |3;mootools.html;1340.4906135668446;1387.299413796033;1388.2503448138011;1456.089943785134;1462.64896424858;11575.553055868017;11878.940605296983;12053.975412089972;12063.577774777885;12076.81884771727;11820.349880756556;11977.700557486067;11985.580504682337;12015.999999999978;12041.518339266418;2555.6038813983864;2581.586946088626;2598.4803039392104;2602.1412933731917;2604.2317516332632;2483.3295010347197;2578.6003169508663;2584.4443444659396;2586.4439145583697;2588.1847218126322;2507;2562.5771747661706;2567.8972841086334;2582.6384306197056;2591.507613553428;2519.987400063006;2552.221572420411;2562.167295628919;2563.4104156044027;2566.448213634059;2130.137294395772;2216.047099747108;2524.116559204264;2549.6614277504273;2564.192279431973;11630.883691163064;11834.112441566916;11951.163418560704;11960.102992275528;11978.401079945968;6676.532642715012;6896.862062758767;6908.171019477695;6925.757598484029;6939.965300173517;3644.599094099647;4399.868003959887;4430.689851710382;4498.302763071729;4508.204912953956;1217.6103646833017;1241.342088692985;1254.943527541263;1273.4651446392538;1305.5169587252776;16622.916885415616;16751.413700520545;16791.412300569544;16793.496195114167;16944;5719.456651618089;5867.207926929896;5874.647521148745;5987.940120598825;6086.2087928569;12489.18820276679;12538.874611253954;12542.24746515212;12548.18436801605;12560.685982850502;5727.5131613812455;6656.633885136364;6783.525153239325;6793.45652347811;6799.490038247052;6118.510519158456;6132.908006379907;6184.134221209034;6257.655828929453;6271.498280137669;4334.43652325202;4507.684462087688;4513.616342610849;4524.185646583581;4611.608013318838;1308.5289295853486;1327.057788969823;1333.4999375234288;1347.6091933339417;1352.7700290950563;790.1584812175015;799.0451410564436;816.7998840284168;824.826786374856;835.5863847395578;5087.796488140507;5244.868878278074;5698.971505142447;6377.0868739378;6555.541112122201;510.4512648902445;521.4472658981492;599.796069336419;612.1919066831739;624.3444383397415;3753.305638456894;3855.749376290532;3927.4501569780255;3946.0134966258433;4816.95183048165;14601.561953141423;15217.391304347924;15484.07095574269;15488.303026363841;15504.689906201813;14732.558023259106;15194.924025379802;15303.846961530466;15315.61710957235;15408.614784630474;8532.8720069199;8592.140785921483;8726.301895848317;8802.251808596213;8910.465372077566;5789.478946894799;6994.195667498303;7092.503524753218;7142.714291428285;7143.1428228612895;10997;13521.729565408834;13813.654658633615;13835.446582137005;13839.169649821042;14012.719745604827;14137.222452765196;14156.221407822668;14324.355404006636;14446.349914254093;9657.613695452103;9951.751206219902;9963.452010139223;9965.750856228653;9990.200783937413;10913.181511386836;10960;10983.39591322485;10991.835122473329;11031.172662050218;9154.588043537924;9155.26757859383;9158.305713443035;9376.249900007846;9377.156055954996;9057;9135;9194.95402522983;9215.170634642915;9313.25493960495;8353.498790072616;8395.790105247417;8436.831263374821;8489.405741598275;8490.533020683675;5201.7399130044105;5782.710864456844;5829.446202610745;5959.195508606456;6027.36712645166;5436.864078398072;5791.783725417709;6236.438720515175;6246.094316324198;6275.435210831047 11:01:45 INFO - PID 1640 | |4;prototype.html;402.52703073888176;405.48705887052876;409.1857204163715;410.54019498162063;421.6837371971022;5007;5725.2843394575675;5885.9411405885985;6233.937660623398;6245.437910588046;5681.744321505532;5849.532037437006;6024.75900963962;6034.306054803699;6125.601835880665;4158.97920510397;4514.255147900592;4536.455625324966;4540.387047748544;4566.086782643468;3367.7979321240805;4445.8659843275245;4566.223741963874;4579.427571553556;4592.517785632511;3486.3550243205086;4298.441202643668;4506.59440650343;4536.27419612862;4541.931871021938;3908.8045597720284;4002.1795531916177;4475.462944446687;4512.075024619945;4512.774361281923;3440.95051009442;3754.6620804127488;3912.1784425270725;3912.784796836173;3929.2337994091163;5485.4788795064405;5507.394186639466;5917.852053698649;6047.941610218239;6055.90993621148;4016.6585840203616;4716.457607375161;4895.828645997373;4938.950610493885;5438.401775804658;6208.2239720034995;6526.379993900572;6568.474522038226;6576.276609572991;6597.373249541286;3531.964680353215;3673.2102597941303;3753.7935413552245;3785.6403641653997;4307.719998200107;5553.944460555424;6361.713722882481;6855.931440685529;6936.237013928464;7027.578345299298;3861.903452413656;4270.871873843789;4343.500497442771;4384.846530371422;4487.88780280489;3629.546306711661;3998.2403343364667;4560.521145279764;4577.977110114494;4581.289900065495;5161.561267292247;5343.973280133574;5358.115910874662;5368.8389348319615;5370.8657283567445;5392.757325920343;6557.836054098686;6574.769883054166;6600.831600831628;6633.834154146089;1278.3224890807887;1524.3216768537893;1525.6719805241926;1553.720330340527;1560.508439841469;837.8073043200098;873.6156091319799;879.3844308983737;1023.764534157148;1031.3966329697212;5864.67744274069;5966.836466888915;6292.968535157295;6295.527835412362;6298.212723409574;5443.42844001382;5815.854603634943;6798.082258894986;6801.755420711253;6816.965915170393;5522.447755224526;5955.225820643289;6176.258848938156;6378.234611846516;6409.9679501602195;3218.951715724266;3564;3567.785932843986;3576.7675101118343;3589.335972845032;5951.0489510489515;6771.661416929134;6814;7106.2183159852375;7180.856382872314;5356.8660783479945;5425.755840987165;6409.359064093646;6923.134608173978;7074.823129421806;6777.475068109636;7038.8944165838575;7170.677319520634;7183.245759195313;7205.567665940061;6257.78097766576;6830.5218634697085;6838.674850550837;6854.862902742017;6871.862562748817;6526.24948130971;6726.8654626908165;6772.187337519529;6776.6950487227205;6777.89833152513;6901.896471553031;7035.753748618774;7122.928770712227;7145.427646047523;7159.355657990805;4246.089259833026;4463.687541872037;4463.776811159494;4474.149911516802;4514.164879497303;6607.306232845482;6686.448673513768;6712.060311556484;6715.597064176165;6803.421709154777;6532.530180709492;6546.967265163644;6553.574017688835;6569.507286953402;6589.374009469093;5104.4129925057605;5973.880522389615;6287.591306565058;6311.337309582428;6560.507961902781;6360.713767880549;6426.775062872777;6447.419732223935;6450.967745161244;6468.644224567505;6556.114924485133;6585.473162146921;6587.505937054644;6591.242007169237;6596.538242322991;6045.153678484928;6213.813585592439;6369.617822930639;6383.585066970818;6404.871902561829 11:01:45 INFO - PID 1640 | |5;yui.html;817.4114637461026;822.5434883639581;839.9160083991601;852.0882655558555;863.7883718488969;16074.437394691187;16615.086170260616;16657.666846663058;18228;18829.811701882976;17426.651466970652;17855.464336069905;17960;18126.3655772048;18305.267789288446;967.6709918627682;986.3342243985317;992.057545331934;992.9156021738124;995.422654860183;966.1980556138424;979.6767066867952;985.8225519406504;988.0712130597216;991.6281394477071;967.1295833749612;1025.5795123999162;1030.6289735695143;1035.3891204189526;1042.0413219837767;1015.2740790334946;1015.405987497315;1028.686250693538;1032.7521394865253;1038.1383451735041;732.3994324653786;747.1706405889458;752.9661165247577;761.223551976986;761.8285885675734;16717.582060448465;16829.747553786703;16913.40803071899;16917.3233070677;16930.40743573969;14475.638109047253;16721.91639041797;17006.744898826528;17011.23449444778;17316.653666926715;13715.794263086062;13760.243186624732;14048.85951140496;14052.437902483889;14066.156030638092;3407.5740532433447;3464.116650254194;3481.599616044162;3487.389706801325;3496.5454490916272;128277;128854.3557282217;129825;130321;131799;12811.359432028548;12894.742105157844;12945.805812912813;13021;13053.086283960032;24271.393215169763;24651.137210197558;24684.382890427525;24999.375015624755;25222.873885630823;7762.146163921964;7905.683772649029;7946.483478573874;7948.085970113395;7963.482373645695;3853.325668008087;3970.967548437427;3996.440498330236;4013.2776100302226;4018.6584140347813;4355.825766969286;4392.165488557228;4408.25059739845;4445.977425192159;4447.399601053817;911.6535716427848;914.5884352041608;925.6251218256617;928.9163975242261;928.9674861379955;641.666333506574;651.9087327774115;656.8620589676221;657.0275991532559;674.2919934069208;10739.409332486788;11226.607068752555;11660.657391408615;11965.700857478632;12160.209586377034;623.3454872383978;638.8243233110932;643.1799455693935;662.7986922091537;668.044696084594;5287.07476191665;5345.946540534623;5386.757595908193;5611.494965453047;5634.943650563524;94710.52644736732;98853.10322071049;99216;102230.48884755677;102467;84423;84666.15333846706;84764;86132.67872230805;86565.26869462576;72943.27056729364;73577.63211184017;73616.89574656384;74050;75444.62277688686;12232.082593805679;12413.317267550372;12519.186252893533;12521.812172817597;12523.24860508336;41106.9723256921;41393.23977742598;41671.58328416798;41771.7911410441;42138.57861421347;52064.479355205964;52100.47899520956;52729.94540109253;53207.20189197243;53875.191872122734;15997.920010399874;16134.838651613334;16375.263113160174;16513.91743041277;16522;17894.642107158044;17907.820921791135;18158.5460363492;18404.81595184031;18505;16091;16346.058206847087;16563.66872662564;16604.75092873632;16781.077040762877;16652.667786577287;16757.916210419357;16760.497185084467;16770;16931.32274708998;13709.314534273446;16250.268737906586;16415.589610259838;16422.178891055162;16576;9642.903570964201;11645.76708465843;11694.824577631172;12213.206141600767;12387.256764594153;12320.199187052813;12925.935370323088;12955.352232388532;12988.480460781462;13404.128731632412 11:01:45 INFO - PID 1640 | __end_tp_report 11:01:45 INFO - PID 1640 | __start_cc_report 11:01:45 INFO - PID 1640 | _x_x_mozilla_cycle_collect,419 11:01:45 INFO - PID 1640 | __end_cc_report 11:01:45 INFO - PID 1640 | __startTimestamp1492797705833__endTimestamp 11:01:45 INFO - PID 1640 | 11:01:45 INFO - PID 1640 | ------- Summary: start ------- 11:01:45 INFO - PID 1640 | Number of tests: 6 11:01:45 INFO - PID 1640 | 11:01:45 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6084.70 Median:6341.46 stddev:743.51 (11.7%) stddev-sans-first:706.94 11:01:45 INFO - PID 1640 | Values: 3060.8 3592.9 3627.5 3642.2 3666.3 4885.4 5463.8 5870.8 6215.8 6230.9 5047.4 6168.4 6220.4 6269.8 6270.7 5221.8 5388.5 5402.0 5439.6 5463.5 5561.8 5570.2 5575.9 5591.9 5593.9 5437.5 5502.0 5502.6 5503.9 5515.8 5473.9 5479.6 5484.6 5491.8 5523.4 4735.0 5436.0 5440.8 5478.9 5519.9 5109.1 5625.6 6172.1 6182.8 6184.7 6628.2 6640.5 6645.1 6653.2 6662.9 6722.1 6740.8 6755.1 6775.5 6777.3 6135.2 6238.3 6333.2 6341.5 6380.6 5609.9 6819.5 6830.9 6869.1 6874.7 6260.5 6359.0 6364.8 6381.0 6559.4 6542.4 6543.6 6744.4 6757.0 6762.6 6600.7 6604.9 6613.0 6620.6 6626.3 6368.0 6374.1 6446.5 6552.5 6609.1 5297.7 5343.8 5347.3 5353.9 5394.5 4731.0 4742.3 4751.5 4752.9 4776.2 6212.0 6287.1 6322.5 6331.3 6351.2 6711.1 6742.2 6765.6 6785.7 6794.9 6332.0 6376.4 6384.9 6387.8 6397.7 4921.8 5763.3 5831.5 5855.5 5959.3 5714.9 6835.6 6882.7 6970.6 6980.3 5513.7 6734.9 6758.9 6766.3 6767.3 5700.5 6912.1 6926.4 6987.3 6998.9 6373.9 6453.1 6557.0 6601.8 6629.9 6753.4 6765.6 6801.6 6806.0 6815.6 6237.3 6363.4 6476.2 6564.6 6601.5 5781.9 6395.8 6398.9 6462.5 6541.2 5580.0 6070.1 6389.0 6413.1 6419.3 6520.6 6539.2 6552.5 6558.4 6587.8 5478.9 6159.5 6241.2 6329.6 6333.6 11:01:45 INFO - PID 1640 | 11:01:45 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:46334.41 Median:346170.00 stddev:84570.58 (24.4%) stddev-sans-first:84738.46 11:01:45 INFO - PID 1640 | Values: 715.6 791.4 805.7 1014.9 1242.1 35558.8 36593.8 36660.3 36719.9 36744.0 36923.9 37253.9 37292.0 37292.6 37378.8 7177.9 7798.6 7924.7 8299.3 8407.3 8363.5 8407.7 8472.7 8473.3 8508.0 8388.9 8434.5 8479.9 8480.6 8491.2 8441.0 8470.4 8474.2 8482.4 8491.7 8196.4 8237.1 8256.8 8256.9 8278.1 35418.8 35444.0 35456.5 35472.6 35601.9 3559.5 3560.6 3599.6 3605.5 3608.0 29470.9 29758.7 29982.4 30069.8 30078.7 3078.9 3096.0 3106.6 3107.8 3117.8 315448.0 317460.0 319472.4 325554.0 327563.0 47469.8 47520.8 47522.8 47613.3 47674.8 50461.0 50556.7 53663.7 54348.9 54471.2 11220.7 13886.3 13967.7 13980.7 13982.0 11031.8 11106.5 11137.7 11149.3 11153.4 13927.2 14084.0 14133.5 14139.9 14147.0 6089.9 6095.1 6123.4 6129.8 6132.3 947.0 948.6 960.0 1003.5 1045.1 20117.6 21741.7 23496.9 23942.9 24135.6 976.6 1100.8 1105.2 1130.8 1139.8 8995.8 10982.4 12178.4 12191.2 12251.1 310853.0 337776.2 343049.0 345548.0 346792.0 51111.7 51278.2 51382.7 51445.7 51457.0 1447.7 1456.9 1492.1 1499.8 1521.5 19284.8 23292.8 23354.3 23500.8 23667.0 36715.8 36812.4 36984.0 37083.8 37260.6 304392.0 304927.0 305031.0 305413.0 307304.0 33300.0 33501.7 33540.0 33545.3 33548.5 41670.5 42464.9 42522.0 42570.4 42600.6 29413.6 29442.4 29730.0 30303.7 30466.4 23348.5 29739.6 30241.7 30367.0 30427.1 34892.0 34898.0 35296.6 35334.5 35471.0 29097.9 29369.7 30096.1 30329.8 30339.0 21170.7 22678.8 24479.6 24480.4 24695.8 11:01:45 INFO - PID 1640 | 11:01:45 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:38672.87 Median:2465.83 stddev:99167.24 (4021.7%) stddev-sans-first:99403.87 11:01:45 INFO - PID 1640 | Values: 436.7 440.9 441.4 458.4 463.9 21092.0 21541.4 21763.7 22339.7 22467.0 22240.0 22732.4 22839.4 23204.4 23364.0 5959.8 6192.5 6208.2 6209.1 6806.6 7099.7 7217.9 7225.9 7241.9 7253.9 6947.8 7083.3 7102.4 7158.6 7204.5 5782.1 6109.9 7057.8 7103.1 7115.8 6252.4 6281.3 6282.8 6287.1 6292.7 27704.9 28961.9 28972.4 29196.4 29339.9 2381.9 2415.2 2434.6 2435.3 2438.6 19089.8 19330.0 19708.8 19952.7 20044.7 2255.6 2374.3 2422.2 2441.8 2443.1 164502.0 165215.0 167530.3 168059.0 172113.0 23818.9 24299.8 24950.1 24953.6 25169.6 41739.2 41782.6 41820.8 41968.0 42124.6 7736.4 8041.6 8889.7 9292.0 9649.1 7115.5 8579.5 8623.8 8793.0 8795.3 6767.0 8108.0 8142.3 8142.5 8257.0 2299.9 2300.2 2305.3 2314.3 2488.5 840.6 976.2 993.3 1014.5 1036.6 21528.4 21987.3 22139.2 22200.4 22737.1 942.9 1015.5 1022.5 1049.6 1059.6 9800.3 10581.6 11367.1 11388.9 11398.7 574667.0 581361.0 587390.0 589366.0 590510.0 128735.1 130130.3 132391.0 141463.0 144989.1 1060.8 1112.6 1224.9 1267.6 1272.4 17261.7 22472.0 22621.5 23035.5 23144.4 47088.8 51241.5 60539.0 60815.4 61969.0 84485.6 84861.0 85289.0 85706.6 87559.0 7613.6 8877.8 9133.8 9143.0 9157.7 13612.3 13630.6 13845.5 14512.8 14882.5 11973.3 12075.9 12131.6 12210.6 12233.0 11545.0 11578.0 11579.6 11596.3 11798.9 12254.9 12266.3 12398.5 12431.3 12618.1 8150.9 8268.3 8280.0 8329.0 8364.2 11411.9 11615.9 11661.8 11738.6 11750.5 11:01:45 INFO - PID 1640 | 11:01:45 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:7228.26 Median:3698.95 stddev:4634.46 (125.3%) stddev-sans-first:4626.35 11:01:45 INFO - PID 1640 | Values: 1340.5 1387.3 1388.3 1456.1 1462.6 11575.6 11878.9 12054.0 12063.6 12076.8 11820.3 11977.7 11985.6 12016.0 12041.5 2555.6 2581.6 2598.5 2602.1 2604.2 2483.3 2578.6 2584.4 2586.4 2588.2 2507.0 2562.6 2567.9 2582.6 2591.5 2520.0 2552.2 2562.2 2563.4 2566.4 2130.1 2216.0 2524.1 2549.7 2564.2 11630.9 11834.1 11951.2 11960.1 11978.4 6676.5 6896.9 6908.2 6925.8 6940.0 3644.6 4399.9 4430.7 4498.3 4508.2 1217.6 1241.3 1254.9 1273.5 1305.5 16622.9 16751.4 16791.4 16793.5 16944.0 5719.5 5867.2 5874.6 5987.9 6086.2 12489.2 12538.9 12542.2 12548.2 12560.7 5727.5 6656.6 6783.5 6793.5 6799.5 6118.5 6132.9 6184.1 6257.7 6271.5 4334.4 4507.7 4513.6 4524.2 4611.6 1308.5 1327.1 1333.5 1347.6 1352.8 790.2 799.0 816.8 824.8 835.6 5087.8 5244.9 5699.0 6377.1 6555.5 510.5 521.4 599.8 612.2 624.3 3753.3 3855.7 3927.5 3946.0 4817.0 14601.6 15217.4 15484.1 15488.3 15504.7 14732.6 15194.9 15303.8 15315.6 15408.6 8532.9 8592.1 8726.3 8802.3 8910.5 5789.5 6994.2 7092.5 7142.7 7143.1 10997.0 13521.7 13813.7 13835.4 13839.2 14012.7 14137.2 14156.2 14324.4 14446.3 9657.6 9951.8 9963.5 9965.8 9990.2 10913.2 10960.0 10983.4 10991.8 11031.2 9154.6 9155.3 9158.3 9376.2 9377.2 9057.0 9135.0 9195.0 9215.2 9313.3 8353.5 8395.8 8436.8 8489.4 8490.5 5201.7 5782.7 5829.4 5959.2 6027.4 5436.9 5791.8 6236.4 6246.1 6275.4 11:01:45 INFO - PID 1640 | 11:01:45 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5252.46 Median:5961.03 stddev:1707.56 (28.6%) stddev-sans-first:1673.09 11:01:45 INFO - PID 1640 | Values: 402.5 405.5 409.2 410.5 421.7 5007.0 5725.3 5885.9 6233.9 6245.4 5681.7 5849.5 6024.8 6034.3 6125.6 4159.0 4514.3 4536.5 4540.4 4566.1 3367.8 4445.9 4566.2 4579.4 4592.5 3486.4 4298.4 4506.6 4536.3 4541.9 3908.8 4002.2 4475.5 4512.1 4512.8 3441.0 3754.7 3912.2 3912.8 3929.2 5485.5 5507.4 5917.9 6047.9 6055.9 4016.7 4716.5 4895.8 4939.0 5438.4 6208.2 6526.4 6568.5 6576.3 6597.4 3532.0 3673.2 3753.8 3785.6 4307.7 5553.9 6361.7 6855.9 6936.2 7027.6 3861.9 4270.9 4343.5 4384.8 4487.9 3629.5 3998.2 4560.5 4578.0 4581.3 5161.6 5344.0 5358.1 5368.8 5370.9 5392.8 6557.8 6574.8 6600.8 6633.8 1278.3 1524.3 1525.7 1553.7 1560.5 837.8 873.6 879.4 1023.8 1031.4 5864.7 5966.8 6293.0 6295.5 6298.2 5443.4 5815.9 6798.1 6801.8 6817.0 5522.4 5955.2 6176.3 6378.2 6410.0 3219.0 3564.0 3567.8 3576.8 3589.3 5951.0 6771.7 6814.0 7106.2 7180.9 5356.9 5425.8 6409.4 6923.1 7074.8 6777.5 7038.9 7170.7 7183.2 7205.6 6257.8 6830.5 6838.7 6854.9 6871.9 6526.2 6726.9 6772.2 6776.7 6777.9 6901.9 7035.8 7122.9 7145.4 7159.4 4246.1 4463.7 4463.8 4474.1 4514.2 6607.3 6686.4 6712.1 6715.6 6803.4 6532.5 6547.0 6553.6 6569.5 6589.4 5104.4 5973.9 6287.6 6311.3 6560.5 6360.7 6426.8 6447.4 6451.0 6468.6 6556.1 6585.5 6587.5 6591.2 6596.5 6045.2 6213.8 6369.6 6383.6 6404.9 11:01:45 INFO - PID 1640 | 11:01:45 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:21340.50 Median:24461.27 stddev:29861.23 (122.1%) stddev-sans-first:29905.23 11:01:45 INFO - PID 1640 | Values: 817.4 822.5 839.9 852.1 863.8 16074.4 16615.1 16657.7 18228.0 18829.8 17426.7 17855.5 17960.0 18126.4 18305.3 967.7 986.3 992.1 992.9 995.4 966.2 979.7 985.8 988.1 991.6 967.1 1025.6 1030.6 1035.4 1042.0 1015.3 1015.4 1028.7 1032.8 1038.1 732.4 747.2 753.0 761.2 761.8 16717.6 16829.7 16913.4 16917.3 16930.4 14475.6 16721.9 17006.7 17011.2 17316.7 13715.8 13760.2 14048.9 14052.4 14066.2 3407.6 3464.1 3481.6 3487.4 3496.5 128277.0 128854.4 129825.0 130321.0 131799.0 12811.4 12894.7 12945.8 13021.0 13053.1 24271.4 24651.1 24684.4 24999.4 25222.9 7762.1 7905.7 7946.5 7948.1 7963.5 3853.3 3971.0 3996.4 4013.3 4018.7 4355.8 4392.2 4408.3 4446.0 4447.4 911.7 914.6 925.6 928.9 929.0 641.7 651.9 656.9 657.0 674.3 10739.4 11226.6 11660.7 11965.7 12160.2 623.3 638.8 643.2 662.8 668.0 5287.1 5345.9 5386.8 5611.5 5634.9 94710.5 98853.1 99216.0 102230.5 102467.0 84423.0 84666.2 84764.0 86132.7 86565.3 72943.3 73577.6 73616.9 74050.0 75444.6 12232.1 12413.3 12519.2 12521.8 12523.2 41107.0 41393.2 41671.6 41771.8 42138.6 52064.5 52100.5 52729.9 53207.2 53875.2 15997.9 16134.8 16375.3 16513.9 16522.0 17894.6 17907.8 18158.5 18404.8 18505.0 16091.0 16346.1 16563.7 16604.8 16781.1 16652.7 16757.9 16760.5 16770.0 16931.3 13709.3 16250.3 16415.6 16422.2 16576.0 9642.9 11645.8 11694.8 12213.2 12387.3 12320.2 12925.9 12955.4 12988.5 13404.1 11:01:45 INFO - PID 1640 | -------- Summary: end -------- 11:01:45 INFO - PID 1640 | 11:01:46 INFO - TEST-INFO | 1640: exit 0 11:01:46 INFO - TEST-OK | dromaeo_css | took 1115462ms 11:01:46 INFO - TEST-START | kraken 11:01:46 INFO - operating with platform_type : mac_ 11:01:46 INFO - Initialising browser for kraken test... 11:01:46 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmp_LPNED/profile http://localhost:49243/getInfo.html) 11:01:49 INFO - PID 1652 | 2017-04-21 11:01:49.568 plugin-container[1653:10150] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 11:01:49 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:01:49 INFO - PID 1652 | 2017-04-21 11:01:49.573 plugin-container[1653:10150] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x990b, name = 'com.apple.CFPasteboardClient' 11:01:49 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:01:49 INFO - PID 1652 | 2017-04-21 11:01:49.573 plugin-container[1653:10150] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:01:49 INFO - PID 1652 | __metrics Screen width/height:1600/1200 11:01:49 INFO - PID 1652 | colorDepth:24 11:01:49 INFO - PID 1652 | Browser inner width/height: 1024/689 11:01:49 INFO - PID 1652 | __metrics 11:01:49 ERROR - PID 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 11:01:50 INFO - TEST-INFO | 1652: exit 0 11:01:50 INFO - Browser initialized. 11:01:50 INFO - Running cycle 1/1 for kraken test... 11:01:50 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmp_LPNED/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:52 INFO - PID 1654 | 2017-04-21 11:01:52.949 plugin-container[1655:10282] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 11:01:52 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:01:52 INFO - PID 1654 | 2017-04-21 11:01:52.950 plugin-container[1655:10282] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9423, name = 'com.apple.CFPasteboardClient' 11:01:52 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:01:52 INFO - PID 1654 | 2017-04-21 11:01:52.950 plugin-container[1655:10282] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:02:03 INFO - PID 1654 | RSS: Main: 237096960 11:02:03 INFO - PID 1654 | 11:02:05 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 11:02:06 INFO - PID 1654 | RSS: Main: 249163776 11:02:06 INFO - PID 1654 | 11:02:09 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 11:02:10 INFO - PID 1654 | RSS: Main: 257376256 11:02:10 INFO - PID 1654 | 11:02:13 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 11:02:14 INFO - PID 1654 | RSS: Main: 260075520 11:02:14 INFO - PID 1654 | 11:02:16 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 11:02:16 INFO - PID 1654 | RSS: Main: 261283840 11:02:16 INFO - PID 1654 | 11:02:18 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:02:19 INFO - PID 1654 | RSS: Main: 262848512 11:02:19 INFO - PID 1654 | 11:02:22 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 11:02:22 INFO - PID 1654 | RSS: Main: 268591104 11:02:22 INFO - PID 1654 | 11:02:25 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 11:02:26 INFO - PID 1654 | RSS: Main: 269606912 11:02:26 INFO - PID 1654 | 11:02:29 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 11:02:29 INFO - PID 1654 | RSS: Main: 268427264 11:02:29 INFO - PID 1654 | 11:02:31 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:02:32 INFO - PID 1654 | RSS: Main: 268431360 11:02:32 INFO - PID 1654 | 11:02:33 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:02:34 INFO - PID 1654 | RSS: Main: 268619776 11:02:34 INFO - PID 1654 | 11:02:36 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:02:37 INFO - PID 1654 | RSS: Main: 268087296 11:02:37 INFO - PID 1654 | 11:02:40 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:02:41 INFO - PID 1654 | RSS: Main: 268402688 11:02:41 INFO - PID 1654 | 11:02:44 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:02:45 INFO - PID 1654 | RSS: Main: 265703424 11:02:45 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 11:02:47 INFO - PID 1654 | RSS: Main: 267304960 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | __start_tp_report 11:02:47 INFO - PID 1654 | _x_x_mozilla_page_load 11:02:47 INFO - PID 1654 | _x_x_mozilla_page_load_details 11:02:47 INFO - PID 1654 | |i|pagename|runs| 11:02:47 INFO - PID 1654 | |0;ai-astar;110;171;112;111;135;114;115;115;115;115 11:02:47 INFO - PID 1654 | |1;audio-beat-detection;143;129;101;178;96;130;145;147;158;108 11:02:47 INFO - PID 1654 | |2;audio-dft;201;200;204;214;261;239;238;201;264;246 11:02:47 INFO - PID 1654 | |3;audio-fft;79;58;60;83;57;57;59;58;76;58 11:02:47 INFO - PID 1654 | |4;audio-oscillator;84;70;82;72;71;72;87;73;84;78 11:02:47 INFO - PID 1654 | |5;imaging-gaussian-blur;90;89;94;90;90;89;88;104;89;89 11:02:47 INFO - PID 1654 | |6;imaging-darkroom;106;95;97;97;97;138;153;118;98;98 11:02:47 INFO - PID 1654 | |7;imaging-desaturate;97;91;92;89;93;91;89;94;90;114 11:02:47 INFO - PID 1654 | |8;json-parse-financial;51;51;51;49;51;52;52;52;52;50 11:02:47 INFO - PID 1654 | |9;json-stringify-tinderbox;56;62;58;57;63;62;65;79;83;66 11:02:47 INFO - PID 1654 | |10;stanford-crypto-aes;80;82;85;107;110;105;84;84;83;85 11:02:47 INFO - PID 1654 | |11;stanford-crypto-ccm;142;133;126;148;163;139;139;159;199;155 11:02:47 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;188;203;217;175;216;241;187;194;242;238 11:02:47 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;75;86;98;98;98;78;69;69;67;68 11:02:47 INFO - PID 1654 | __end_tp_report 11:02:47 INFO - PID 1654 | __start_cc_report 11:02:47 INFO - PID 1654 | _x_x_mozilla_cycle_collect,1007 11:02:47 INFO - PID 1654 | __end_cc_report 11:02:47 INFO - PID 1654 | __startTimestamp1492797767301__endTimestamp 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | ------- Summary: start ------- 11:02:47 INFO - PID 1654 | Number of tests: 14 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:121.30 Median:115.00 stddev:18.83 (16.4%) stddev-sans-first:19.52 11:02:47 INFO - PID 1654 | Values: 110.0 171.0 112.0 111.0 135.0 114.0 115.0 115.0 115.0 115.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:146.00 stddev:26.10 (17.9%) stddev-sans-first:27.46 11:02:47 INFO - PID 1654 | Values: 143.0 129.0 101.0 178.0 96.0 130.0 145.0 147.0 158.0 108.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:226.80 Median:238.50 stddev:25.67 (10.8%) stddev-sans-first:25.47 11:02:47 INFO - PID 1654 | Values: 201.0 200.0 204.0 214.0 261.0 239.0 238.0 201.0 264.0 246.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:64.50 Median:59.50 stddev:10.41 (17.5%) stddev-sans-first:9.62 11:02:47 INFO - PID 1654 | Values: 79.0 58.0 60.0 83.0 57.0 57.0 59.0 58.0 76.0 58.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:80.00 stddev:6.45 (8.1%) stddev-sans-first:6.37 11:02:47 INFO - PID 1654 | Values: 84.0 70.0 82.0 72.0 71.0 72.0 87.0 73.0 84.0 78.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:89.50 stddev:4.78 (5.3%) stddev-sans-first:5.05 11:02:47 INFO - PID 1654 | Values: 90.0 89.0 94.0 90.0 90.0 89.0 88.0 104.0 89.0 89.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:109.70 Median:97.00 stddev:20.36 (21.0%) stddev-sans-first:21.55 11:02:47 INFO - PID 1654 | Values: 106.0 95.0 97.0 97.0 97.0 138.0 153.0 118.0 98.0 98.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:91.50 stddev:7.44 (8.1%) stddev-sans-first:7.81 11:02:47 INFO - PID 1654 | Values: 97.0 91.0 92.0 89.0 93.0 91.0 89.0 94.0 90.0 114.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.50 stddev:0.99 (1.9%) stddev-sans-first:1.05 11:02:47 INFO - PID 1654 | Values: 51.0 51.0 51.0 49.0 51.0 52.0 52.0 52.0 52.0 50.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:64.00 stddev:9.05 (14.1%) stddev-sans-first:8.98 11:02:47 INFO - PID 1654 | Values: 56.0 62.0 58.0 57.0 63.0 62.0 65.0 79.0 83.0 66.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:83.50 stddev:11.77 (14.1%) stddev-sans-first:11.85 11:02:47 INFO - PID 1654 | Values: 80.0 82.0 85.0 107.0 110.0 105.0 84.0 84.0 83.0 85.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:151.50 stddev:20.68 (13.7%) stddev-sans-first:21.72 11:02:47 INFO - PID 1654 | Values: 142.0 133.0 126.0 148.0 163.0 139.0 139.0 159.0 199.0 155.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:210.10 Median:216.50 stddev:24.49 (11.3%) stddev-sans-first:24.63 11:02:47 INFO - PID 1654 | Values: 188.0 203.0 217.0 175.0 216.0 241.0 187.0 194.0 242.0 238.0 11:02:47 INFO - PID 1654 | 11:02:47 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.60 Median:82.00 stddev:13.28 (16.2%) stddev-sans-first:13.94 11:02:47 INFO - PID 1654 | Values: 75.0 86.0 98.0 98.0 98.0 78.0 69.0 69.0 67.0 68.0 11:02:47 INFO - PID 1654 | -------- Summary: end -------- 11:02:47 INFO - PID 1654 | 11:02:48 INFO - TEST-INFO | 1654: exit 0 11:02:48 INFO - TEST-OK | kraken | took 61796ms 11:02:48 INFO - SUITE-END | took 1177s 11:02:48 INFO - Completed test suite (00:19:37) 11:02:48 INFO - javascript benchmark 11:02:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7940.5817853130775, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.801047931884, 3592.8562857485704, 3627.455881617757, 3642.162302670384, 3666.3217304798613, 4885.364902562662, 5463.7979644478255, 5870.823875283749, 6215.751369945202, 6230.875382492348, 5047.419546752125, 6168.38316168383, 6220.440160385564, 6269.811905642827, 6270.655113968742, 5221.843344699665, 5388.488093631099, 5401.972990135064, 5439.646422982493, 5463.508284254416, 5561.833145005657, 5570.192322113291, 5575.888482230353, 5591.860203494904, 5593.944060559404, 5437.537809286216, 5501.972490137524, 5502.614816962814, 5503.9174412383845, 5515.751791169407, 5473.890522189534, 5479.643823151522, 5484.561235101182, 5491.835244942618, 5523.392426833045, 4734.976325118352, 5435.972820135914, 5440.755166017539, 5478.890422191574, 5519.889602207973, 5109.080365534202, 5625.606207565472, 6172.074188871705, 6182.845428864314, 6184.690765461709, 6628.237752658458, 6640.535162538624, 6645.102911106987, 6653.234877989044, 6662.900056499157, 6722.092517510123, 6740.8314792130095, 6755.121834161577, 6775.491838112112, 6777.2545020047755, 6135.171751813537, 6238.313785483593, 6333.1766870306565, 6341.460975817061, 6380.553361264713, 5609.906068316721, 6819.454443644497, 6830.8633827324165, 6869.072675188885, 6874.690638921261, 6260.467860231931, 6359.046143078575, 6364.809055728336, 6380.968095159495, 6559.442447392025, 6542.443892269211, 6543.640099794557, 6744.393004629607, 6757.0, 6762.628055456898, 6600.669966501656, 6604.933950660432, 6613.0, 6620.569662971891, 6626.337366263335, 6368.012957991518, 6374.107624932513, 6446.484281257488, 6552.50856185788, 6609.140811694545, 5297.735113244323, 5343.839684809462, 5347.25138480613, 5353.892922141613, 5394.460553944574, 4731.0, 4742.288656701522, 4751.477337492873, 4752.881177970578, 4776.2119250324, 6211.9689401552705, 6287.056941458818, 6322.4942004639515, 6331.271903731038, 6351.174347334817, 6711.127553418024, 6742.157230346207, 6765.594064356154, 6785.728570857209, 6794.898076528856, 6331.96834015827, 6376.39424254695, 6384.872302554016, 6387.840303992437, 6397.744090236339, 4921.803127874845, 5763.250777398911, 5831.504322132666, 5855.502282305966, 5959.255093113361, 5714.942850571608, 6835.624040677711, 6882.724691012303, 6970.581765094111, 6980.301969802979, 5513.724313784214, 6734.898976515454, 6758.898616520658, 6766.289539598271, 6767.255601883888, 5700.5154561861045, 6912.101426814482, 6926.411255043176, 6987.266337034538, 6998.930010699828, 6373.8725225496155, 6453.096566480603, 6556.967215164084, 6601.768938087144, 6629.933700662931, 6753.3921947025, 6765.560238584476, 6801.557898736566, 6805.9659701701175, 6815.556988795713, 6237.313895471585, 6363.395477429637, 6476.222853257639, 6564.606123632598, 6601.504887133388, 5781.942180578309, 6395.808125756234, 6398.87202255943, 6462.450691691259, 6541.215054193337, 5579.972100139474, 6070.089486577049, 6388.968055159695, 6413.102165696713, 6419.2938776735455, 6520.641364724986, 6539.182602174728, 6552.541322107407, 6558.442532384801, 6587.835304117244, 5478.945210547843, 6159.476444502267, 6241.188645476059, 6329.5569310149685, 6333.58831675958], "value": 6037.92165288915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.5670819154411, 791.4499422901082, 805.7300804230581, 1014.9340292880962, 1242.1180961517323, 35558.75544355948, 36593.81703091484, 36660.26679466416, 36719.89840304788, 36744.0, 36923.892283231544, 37253.88238352847, 37292.0, 37292.62707372926, 37378.81310593443, 7177.85644287114, 7798.610069496531, 7924.722634707787, 8299.29455996241, 8407.285380742644, 8363.498190108583, 8407.70573029944, 8472.74581762548, 8473.279771219453, 8507.9587196082, 8388.916110838905, 8434.493930364199, 8479.872801907977, 8480.618372173236, 8491.15088491149, 8441.02928163263, 8470.407071504935, 8474.1949514796, 8482.36382271329, 8491.66033358668, 8196.42625016249, 8237.093919668832, 8256.83486330276, 8256.917430825675, 8278.130796266365, 35418.822905885565, 35444.0, 35456.46815297772, 35472.64527354745, 35601.93194204178, 3559.501669766209, 3560.572731272238, 3599.5500562429697, 3605.5312809334882, 3607.981960090183, 29470.85264573685, 29758.726540080574, 29982.400351993056, 30069.849650751825, 30078.699213007807, 3078.9076327710204, 3096.0, 3106.6272047354464, 3107.787962694551, 3117.7817552771317, 315448.0, 317460.0, 319472.40263798763, 325554.0, 327563.0, 47469.762651186524, 47520.76239618849, 47522.762386187846, 47613.28580071302, 47674.76162619165, 50461.0, 50556.747216263684, 53663.73168134213, 54348.91302173935, 54471.182932256044, 11220.719482012852, 13886.305684715724, 13967.720645587235, 13980.720385592434, 13982.0, 11031.779364412827, 11106.500207490682, 11137.721556961142, 11149.331040137618, 11153.442327883735, 13927.164370137823, 14084.0, 14133.505327313494, 14139.879018147154, 14147.0, 6089.934261504219, 6095.05526643371, 6123.387661233841, 6129.785457508966, 6132.344267047962, 946.9810603787886, 948.6158105967095, 959.9632397011351, 1003.4581326083833, 1045.1429827541342, 20117.597648046958, 21741.67387489189, 23496.882515587313, 23942.88028559881, 24135.63796543053, 976.6386437018349, 1100.834874768791, 1105.2484310668822, 1130.7908037013178, 1139.7861277739346, 8995.775105622412, 10982.395968221665, 12178.391080445943, 12191.207571507824, 12251.081168912368, 310853.0, 337776.24447511404, 343049.0, 345548.0, 346792.0, 51111.72220694438, 51278.230826537634, 51382.71543211375, 51445.742771285906, 51456.97086058258, 1447.7176950494552, 1456.9125852448888, 1492.1271056431892, 1499.8200215974152, 1521.5131158029324, 19284.807151928864, 23292.767072329738, 23354.299371018897, 23500.764992349857, 23667.0, 36715.81642091773, 36812.44781328336, 36984.0, 37083.814580926926, 37260.6273937268, 304392.0, 304927.0, 305031.0, 305413.0, 307304.0, 33300.0, 33501.66498334985, 33540.0, 33545.329093418484, 33548.49677254892, 41670.54153104627, 42464.938376540835, 42522.0, 42570.361444577735, 42600.57399425966, 29413.55879661764, 29442.411151776418, 29730.0, 30303.69696303009, 30466.390672186877, 23348.53302933966, 29739.553906690984, 30241.69758302477, 30367.0, 30427.087187384415, 34892.0, 34898.0, 35296.647033529334, 35334.46998295079, 35471.0, 29097.85451072731, 29369.706302937553, 30096.097117086523, 30329.848350758104, 30339.0, 21170.682439763725, 22678.773212268326, 24479.63280550829, 24480.387990300384, 24695.7652117397], "value": 17236.25610673779, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.7248633360986, 440.85011096227277, 441.41292081531554, 458.3537212530332, 463.8608417474759, 21092.0, 21541.353759387224, 21763.67354489682, 22339.6649050264, 22467.0, 22240.0, 22732.431689207777, 22839.42901427465, 23204.41988950277, 23364.0, 5959.761609535613, 6192.473639740628, 6208.2239720034995, 6209.099680546341, 6806.557573757715, 7099.716011359539, 7217.855642887139, 7225.927740722578, 7241.855162896765, 7253.854922901539, 6947.79156625302, 7083.327083927019, 7102.39629631482, 7158.6040722059215, 7204.459665525081, 5782.10377391505, 6109.938900610981, 7057.752978645748, 7103.0766000420135, 7115.78652640419, 6252.437280644718, 6281.3404592518045, 6282.811515654537, 6287.1198032275515, 6292.748290068392, 27704.86147569249, 28961.855190723913, 28972.42055158906, 29196.41607167866, 29339.85330073336, 2381.8570885746913, 2415.1788391946648, 2434.6469761884605, 2435.281591930385, 2438.573249681299, 19089.80910190894, 19330.0, 19708.80291197084, 19952.70070948937, 20044.69932951007, 2255.6052690779047, 2374.3470545599926, 2422.176460003607, 2441.8046556275453, 2443.144899285254, 164502.0, 165215.0, 167530.32469675268, 168059.0, 172113.0, 23818.880905595706, 24299.757002430102, 24950.12674556382, 24953.636822610482, 25169.62245566318, 41739.15651808749, 41782.582174178475, 41820.79089604593, 41968.0, 42124.57875421207, 7736.381089512825, 8041.597920103972, 8889.73330800077, 9291.953540232256, 9649.083337082966, 7115.466340024519, 8579.485230886043, 8623.827523449496, 8793.0, 8795.340349473816, 6767.0, 8107.959460202779, 8142.307903828241, 8142.51144931306, 8257.0, 2299.942501437444, 2300.194931773866, 2305.2853615379286, 2314.305708287507, 2488.5147396257917, 840.5545061117617, 976.2482888176065, 993.339429279521, 1014.497823577334, 1036.6371769880632, 21528.354149375544, 21987.34037978863, 22139.225127120473, 22200.444988875406, 22737.09051637949, 942.9292803039799, 1015.5277795824829, 1022.504085518523, 1049.6011515624014, 1059.6185373265619, 9800.264980126376, 10581.62964296246, 11367.147463940237, 11388.886111138783, 11398.658040258806, 574667.0, 581361.0, 587390.0, 589366.0, 590510.0, 128735.06897396546, 130130.34934825265, 132391.0, 141463.0, 144989.10021799715, 1060.7931453366673, 1112.6383925224334, 1224.9281878356437, 1267.6387229639508, 1272.4337669737063, 17261.65476690434, 22472.0, 22621.547569048857, 23035.539289214455, 23144.421389464726, 47088.76455617837, 51241.46275611738, 60539.0, 60815.39184608097, 61969.0, 84485.57757211174, 84861.0, 85289.0, 85706.57146714476, 87559.0, 7613.619319034137, 8877.822443550964, 9133.77165570866, 9142.954285228532, 9157.679481218125, 13612.319384030561, 13630.591082267549, 13845.51540696111, 14512.782308265174, 14882.479113230986, 11973.281603103842, 12075.879241207476, 12131.575394861138, 12210.633680989584, 12233.0, 11545.0, 11578.0, 11579.594714184963, 11596.304221746723, 11798.941005294919, 12254.87745122573, 12266.325352105363, 12398.504059837505, 12431.254124752544, 12618.116731828684, 8150.9184908150155, 8268.297194738274, 8280.0, 8328.958355208186, 8364.247217750431, 11411.885881141083, 11615.883841161818, 11661.825072623747, 11738.647840564796, 11750.529978801094], "value": 11402.075146506362, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.4906135668446, 1387.299413796033, 1388.2503448138011, 1456.089943785134, 1462.64896424858, 11575.553055868017, 11878.940605296983, 12053.975412089972, 12063.577774777885, 12076.81884771727, 11820.349880756556, 11977.700557486067, 11985.580504682337, 12015.999999999978, 12041.518339266418, 2555.6038813983864, 2581.586946088626, 2598.4803039392104, 2602.1412933731917, 2604.2317516332632, 2483.3295010347197, 2578.6003169508663, 2584.4443444659396, 2586.4439145583697, 2588.1847218126322, 2507.0, 2562.5771747661706, 2567.8972841086334, 2582.6384306197056, 2591.507613553428, 2519.987400063006, 2552.221572420411, 2562.167295628919, 2563.4104156044027, 2566.448213634059, 2130.137294395772, 2216.047099747108, 2524.116559204264, 2549.6614277504273, 2564.192279431973, 11630.883691163064, 11834.112441566916, 11951.163418560704, 11960.102992275528, 11978.401079945968, 6676.532642715012, 6896.862062758767, 6908.171019477695, 6925.757598484029, 6939.965300173517, 3644.599094099647, 4399.868003959887, 4430.689851710382, 4498.302763071729, 4508.204912953956, 1217.6103646833017, 1241.342088692985, 1254.943527541263, 1273.4651446392538, 1305.5169587252776, 16622.916885415616, 16751.413700520545, 16791.412300569544, 16793.496195114167, 16944.0, 5719.456651618089, 5867.207926929896, 5874.647521148745, 5987.940120598825, 6086.2087928569, 12489.18820276679, 12538.874611253954, 12542.24746515212, 12548.18436801605, 12560.685982850502, 5727.5131613812455, 6656.633885136364, 6783.525153239325, 6793.45652347811, 6799.490038247052, 6118.510519158456, 6132.908006379907, 6184.134221209034, 6257.655828929453, 6271.498280137669, 4334.43652325202, 4507.684462087688, 4513.616342610849, 4524.185646583581, 4611.608013318838, 1308.5289295853486, 1327.057788969823, 1333.4999375234288, 1347.6091933339417, 1352.7700290950563, 790.1584812175015, 799.0451410564436, 816.7998840284168, 824.826786374856, 835.5863847395578, 5087.796488140507, 5244.868878278074, 5698.971505142447, 6377.0868739378, 6555.541112122201, 510.4512648902445, 521.4472658981492, 599.796069336419, 612.1919066831739, 624.3444383397415, 3753.305638456894, 3855.749376290532, 3927.4501569780255, 3946.0134966258433, 4816.95183048165, 14601.561953141423, 15217.391304347924, 15484.07095574269, 15488.303026363841, 15504.689906201813, 14732.558023259106, 15194.924025379802, 15303.846961530466, 15315.61710957235, 15408.614784630474, 8532.8720069199, 8592.140785921483, 8726.301895848317, 8802.251808596213, 8910.465372077566, 5789.478946894799, 6994.195667498303, 7092.503524753218, 7142.714291428285, 7143.1428228612895, 10997.0, 13521.729565408834, 13813.654658633615, 13835.446582137005, 13839.169649821042, 14012.719745604827, 14137.222452765196, 14156.221407822668, 14324.355404006636, 14446.349914254093, 9657.613695452103, 9951.751206219902, 9963.452010139223, 9965.750856228653, 9990.200783937413, 10913.181511386836, 10960.0, 10983.39591322485, 10991.835122473329, 11031.172662050218, 9154.588043537924, 9155.26757859383, 9158.305713443035, 9376.249900007846, 9377.156055954996, 9057.0, 9135.0, 9194.95402522983, 9215.170634642915, 9313.25493960495, 8353.498790072616, 8395.790105247417, 8436.831263374821, 8489.405741598275, 8490.533020683675, 5201.7399130044105, 5782.710864456844, 5829.446202610745, 5959.195508606456, 6027.36712645166, 5436.864078398072, 5791.783725417709, 6236.438720515175, 6246.094316324198, 6275.435210831047], "value": 5387.570694659411, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.52703073888176, 405.48705887052876, 409.1857204163715, 410.54019498162063, 421.6837371971022, 5007.0, 5725.2843394575675, 5885.9411405885985, 6233.937660623398, 6245.437910588046, 5681.744321505532, 5849.532037437006, 6024.75900963962, 6034.306054803699, 6125.601835880665, 4158.97920510397, 4514.255147900592, 4536.455625324966, 4540.387047748544, 4566.086782643468, 3367.7979321240805, 4445.8659843275245, 4566.223741963874, 4579.427571553556, 4592.517785632511, 3486.3550243205086, 4298.441202643668, 4506.59440650343, 4536.27419612862, 4541.931871021938, 3908.8045597720284, 4002.1795531916177, 4475.462944446687, 4512.075024619945, 4512.774361281923, 3440.95051009442, 3754.6620804127488, 3912.1784425270725, 3912.784796836173, 3929.2337994091163, 5485.4788795064405, 5507.394186639466, 5917.852053698649, 6047.941610218239, 6055.90993621148, 4016.6585840203616, 4716.457607375161, 4895.828645997373, 4938.950610493885, 5438.401775804658, 6208.2239720034995, 6526.379993900572, 6568.474522038226, 6576.276609572991, 6597.373249541286, 3531.964680353215, 3673.2102597941303, 3753.7935413552245, 3785.6403641653997, 4307.719998200107, 5553.944460555424, 6361.713722882481, 6855.931440685529, 6936.237013928464, 7027.578345299298, 3861.903452413656, 4270.871873843789, 4343.500497442771, 4384.846530371422, 4487.88780280489, 3629.546306711661, 3998.2403343364667, 4560.521145279764, 4577.977110114494, 4581.289900065495, 5161.561267292247, 5343.973280133574, 5358.115910874662, 5368.8389348319615, 5370.8657283567445, 5392.757325920343, 6557.836054098686, 6574.769883054166, 6600.831600831628, 6633.834154146089, 1278.3224890807887, 1524.3216768537893, 1525.6719805241926, 1553.720330340527, 1560.508439841469, 837.8073043200098, 873.6156091319799, 879.3844308983737, 1023.764534157148, 1031.3966329697212, 5864.67744274069, 5966.836466888915, 6292.968535157295, 6295.527835412362, 6298.212723409574, 5443.42844001382, 5815.854603634943, 6798.082258894986, 6801.755420711253, 6816.965915170393, 5522.447755224526, 5955.225820643289, 6176.258848938156, 6378.234611846516, 6409.9679501602195, 3218.951715724266, 3564.0, 3567.785932843986, 3576.7675101118343, 3589.335972845032, 5951.0489510489515, 6771.661416929134, 6814.0, 7106.2183159852375, 7180.856382872314, 5356.8660783479945, 5425.755840987165, 6409.359064093646, 6923.134608173978, 7074.823129421806, 6777.475068109636, 7038.8944165838575, 7170.677319520634, 7183.245759195313, 7205.567665940061, 6257.78097766576, 6830.5218634697085, 6838.674850550837, 6854.862902742017, 6871.862562748817, 6526.24948130971, 6726.8654626908165, 6772.187337519529, 6776.6950487227205, 6777.89833152513, 6901.896471553031, 7035.753748618774, 7122.928770712227, 7145.427646047523, 7159.355657990805, 4246.089259833026, 4463.687541872037, 4463.776811159494, 4474.149911516802, 4514.164879497303, 6607.306232845482, 6686.448673513768, 6712.060311556484, 6715.597064176165, 6803.421709154777, 6532.530180709492, 6546.967265163644, 6553.574017688835, 6569.507286953402, 6589.374009469093, 5104.4129925057605, 5973.880522389615, 6287.591306565058, 6311.337309582428, 6560.507961902781, 6360.713767880549, 6426.775062872777, 6447.419732223935, 6450.967745161244, 6468.644224567505, 6556.114924485133, 6585.473162146921, 6587.505937054644, 6591.242007169237, 6596.538242322991, 6045.153678484928, 6213.813585592439, 6369.617822930639, 6383.585066970818, 6404.871902561829], "value": 4718.967646224308, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.4114637461026, 822.5434883639581, 839.9160083991601, 852.0882655558555, 863.7883718488969, 16074.437394691187, 16615.086170260616, 16657.666846663058, 18228.0, 18829.811701882976, 17426.651466970652, 17855.464336069905, 17960.0, 18126.3655772048, 18305.267789288446, 967.6709918627682, 986.3342243985317, 992.057545331934, 992.9156021738124, 995.422654860183, 966.1980556138424, 979.6767066867952, 985.8225519406504, 988.0712130597216, 991.6281394477071, 967.1295833749612, 1025.5795123999162, 1030.6289735695143, 1035.3891204189526, 1042.0413219837767, 1015.2740790334946, 1015.405987497315, 1028.686250693538, 1032.7521394865253, 1038.1383451735041, 732.3994324653786, 747.1706405889458, 752.9661165247577, 761.223551976986, 761.8285885675734, 16717.582060448465, 16829.747553786703, 16913.40803071899, 16917.3233070677, 16930.40743573969, 14475.638109047253, 16721.91639041797, 17006.744898826528, 17011.23449444778, 17316.653666926715, 13715.794263086062, 13760.243186624732, 14048.85951140496, 14052.437902483889, 14066.156030638092, 3407.5740532433447, 3464.116650254194, 3481.599616044162, 3487.389706801325, 3496.5454490916272, 128277.0, 128854.3557282217, 129825.0, 130321.0, 131799.0, 12811.359432028548, 12894.742105157844, 12945.805812912813, 13021.0, 13053.086283960032, 24271.393215169763, 24651.137210197558, 24684.382890427525, 24999.375015624755, 25222.873885630823, 7762.146163921964, 7905.683772649029, 7946.483478573874, 7948.085970113395, 7963.482373645695, 3853.325668008087, 3970.967548437427, 3996.440498330236, 4013.2776100302226, 4018.6584140347813, 4355.825766969286, 4392.165488557228, 4408.25059739845, 4445.977425192159, 4447.399601053817, 911.6535716427848, 914.5884352041608, 925.6251218256617, 928.9163975242261, 928.9674861379955, 641.666333506574, 651.9087327774115, 656.8620589676221, 657.0275991532559, 674.2919934069208, 10739.409332486788, 11226.607068752555, 11660.657391408615, 11965.700857478632, 12160.209586377034, 623.3454872383978, 638.8243233110932, 643.1799455693935, 662.7986922091537, 668.044696084594, 5287.07476191665, 5345.946540534623, 5386.757595908193, 5611.494965453047, 5634.943650563524, 94710.52644736732, 98853.10322071049, 99216.0, 102230.48884755677, 102467.0, 84423.0, 84666.15333846706, 84764.0, 86132.67872230805, 86565.26869462576, 72943.27056729364, 73577.63211184017, 73616.89574656384, 74050.0, 75444.62277688686, 12232.082593805679, 12413.317267550372, 12519.186252893533, 12521.812172817597, 12523.24860508336, 41106.9723256921, 41393.23977742598, 41671.58328416798, 41771.7911410441, 42138.57861421347, 52064.479355205964, 52100.47899520956, 52729.94540109253, 53207.20189197243, 53875.191872122734, 15997.920010399874, 16134.838651613334, 16375.263113160174, 16513.91743041277, 16522.0, 17894.642107158044, 17907.820921791135, 18158.5460363492, 18404.81595184031, 18505.0, 16091.0, 16346.058206847087, 16563.66872662564, 16604.75092873632, 16781.077040762877, 16652.667786577287, 16757.916210419357, 16760.497185084467, 16770.0, 16931.32274708998, 13709.314534273446, 16250.268737906586, 16415.589610259838, 16422.178891055162, 16576.0, 9642.903570964201, 11645.76708465843, 11694.824577631172, 12213.206141600767, 12387.256764594153, 12320.199187052813, 12925.935370323088, 12955.352232388532, 12988.480460781462, 13404.128731632412], "value": 8308.596854020392, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 171.0, 112.0, 111.0, 135.0, 114.0, 115.0, 115.0, 115.0, 115.0], "value": 121.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 129.0, 101.0, 178.0, 96.0, 130.0, 145.0, 147.0, 158.0, 108.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 200.0, 204.0, 214.0, 261.0, 239.0, 238.0, 201.0, 264.0, 246.0], "value": 226.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 83.0, 57.0, 57.0, 59.0, 58.0, 76.0, 58.0], "value": 64.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 82.0, 72.0, 71.0, 72.0, 87.0, 73.0, 84.0, 78.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 94.0, 90.0, 90.0, 89.0, 88.0, 104.0, 89.0, 89.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 95.0, 97.0, 97.0, 97.0, 138.0, 153.0, 118.0, 98.0, 98.0], "value": 109.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 91.0, 92.0, 89.0, 93.0, 91.0, 89.0, 94.0, 90.0, 114.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 49.0, 51.0, 52.0, 52.0, 52.0, 52.0, 50.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 62.0, 58.0, 57.0, 63.0, 62.0, 65.0, 79.0, 83.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 85.0, 107.0, 110.0, 105.0, 84.0, 84.0, 83.0, 85.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 126.0, 148.0, 163.0, 139.0, 139.0, 159.0, 199.0, 155.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 203.0, 217.0, 175.0, 216.0, 241.0, 187.0, 194.0, 242.0, 238.0], "value": 210.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 86.0, 98.0, 98.0, 98.0, 78.0, 69.0, 69.0, 67.0, 68.0], "value": 80.6, "unit": "score"}]}]} 11:02:48 INFO - Return code: 0 11:02:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:02:48 ERROR - # TBPL SUCCESS # 11:02:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:02:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:02:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:02:48 INFO - 2017-04-21 11:02:48.656 screenresolution[1659:10671] starting screenresolution argv=screenresolution get 11:02:48 INFO - 2017-04-21 11:02:48.660 screenresolution[1659:10671] Display 0: 1600x1200x32@60 11:02:48 INFO - 2017-04-21 11:02:48.666 screenresolution[1660:10674] starting screenresolution argv=screenresolution list 11:02:48 INFO - Available Modes on Display 0 11:02:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:02:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:02:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:02:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:02:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:02:48 INFO - Intel Iris: 11:02:48 INFO - Chipset Model: Intel Iris 11:02:48 INFO - Type: GPU 11:02:48 INFO - Bus: Built-In 11:02:48 INFO - VRAM (Dynamic, Max): 1536 MB 11:02:48 INFO - Vendor: Intel (0x8086) 11:02:48 INFO - Device ID: 0x0a2e 11:02:48 INFO - Revision ID: 0x0009 11:02:48 INFO - Displays: 11:02:48 INFO - Display: 11:02:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:02:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:02:48 INFO - Display Serial Number: 1600x1200 60 11:02:48 INFO - Main Display: Yes 11:02:48 INFO - Mirror: Off 11:02:48 INFO - Online: Yes 11:02:48 INFO - Rotation: Supported 11:02:48 INFO - Return code: 0 11:02:48 INFO - Running post-action listener: _resource_record_post_action 11:02:48 INFO - [mozharness: 2017-04-21 18:02:48.916420Z] Finished run-tests step (success) 11:02:48 INFO - Running post-run listener: _resource_record_post_run 11:02:48 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 39840256; Write bytes: 518824448; Read time: 259; Write time: 1629 11:02:48 INFO - TinderboxPrint: CPU usage
54.1% 11:02:48 INFO - TinderboxPrint: I/O read bytes / time
39,840,256 / 259 11:02:48 INFO - TinderboxPrint: I/O write bytes / time
518,824,448 / 1,629 11:02:48 INFO - TinderboxPrint: CPU idle
2,202.3 (45.9%) 11:02:48 INFO - TinderboxPrint: CPU system
964.0 (20.1%) 11:02:48 INFO - TinderboxPrint: CPU user
1,627.3 (33.9%) 11:02:48 INFO - TinderboxPrint: Swap in / out
246,734,848 / 0 11:02:48 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205539840; Write bytes: 205527040; Read time: 15534; Write time: 421 11:02:49 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37718528; Write bytes: 306215424; Read time: 237; Write time: 1179 11:02:49 INFO - Running post-run listener: _upload_blobber_files 11:02:49 INFO - Blob upload gear active. 11:02:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:02:49 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 11:02:49 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'] 11:02:49 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 11:02:49 INFO - (blobuploader) - INFO - Open directory for files ... 11:02:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:02:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:02:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:50 INFO - (blobuploader) - INFO - Done attempting. 11:02:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:02:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:02:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:51 INFO - (blobuploader) - INFO - Done attempting. 11:02:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:02:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:02:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:52 INFO - (blobuploader) - INFO - Done attempting. 11:02:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:02:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:02:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:02:55 INFO - (blobuploader) - INFO - Done attempting. 11:02:55 INFO - (blobuploader) - INFO - Iteration through files over. 11:02:55 INFO - Return code: 0 11:02:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:02:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:02:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed881ef605dd3b089b15337c8ae26653564b88c27fe364bd52430541fbd9e2e2400a0b743152c46bad1094fdf8a76f4a6e083fcbabc798ea22f76da2e73bd61", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07708804d64562365b7d38613f5045c484c1820f8a5ea564f3fb913316be2df2ee238d58a3ffd0c151331a187a195d0f3e3399e148219863d7eda5acb4c10071", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ba0fad31661d9a285be4d028d56816499ae7fb20c92b35cadb820c0d836c71dba54361e134c5022446aa42c1fec769c76cec00f1098d58d591287c50d27d363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83e55083809da05d96c602402557baa1fc930d0e54f33f5f098581da4c578426d55f75e04cce15ab1ea8b86b049f5b4dc6a87a7e14314dc8096bd1e64f7b2f7"} 11:02:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:02:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:02:55 INFO - Contents: 11:02:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed881ef605dd3b089b15337c8ae26653564b88c27fe364bd52430541fbd9e2e2400a0b743152c46bad1094fdf8a76f4a6e083fcbabc798ea22f76da2e73bd61", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07708804d64562365b7d38613f5045c484c1820f8a5ea564f3fb913316be2df2ee238d58a3ffd0c151331a187a195d0f3e3399e148219863d7eda5acb4c10071", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ba0fad31661d9a285be4d028d56816499ae7fb20c92b35cadb820c0d836c71dba54361e134c5022446aa42c1fec769c76cec00f1098d58d591287c50d27d363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83e55083809da05d96c602402557baa1fc930d0e54f33f5f098581da4c578426d55f75e04cce15ab1ea8b86b049f5b4dc6a87a7e14314dc8096bd1e64f7b2f7"} 11:02:55 INFO - Running post-run listener: copy_logs_to_upload_dir 11:02:55 INFO - Copying logs to upload dir... 11:02:55 INFO - mkdir: /builds/slave/test/build/upload/logs 11:02:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.448690 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-21 11:02:55.131652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 11:02:55.135323) ========= 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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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/fed881ef605dd3b089b15337c8ae26653564b88c27fe364bd52430541fbd9e2e2400a0b743152c46bad1094fdf8a76f4a6e083fcbabc798ea22f76da2e73bd61", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07708804d64562365b7d38613f5045c484c1820f8a5ea564f3fb913316be2df2ee238d58a3ffd0c151331a187a195d0f3e3399e148219863d7eda5acb4c10071", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ba0fad31661d9a285be4d028d56816499ae7fb20c92b35cadb820c0d836c71dba54361e134c5022446aa42c1fec769c76cec00f1098d58d591287c50d27d363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83e55083809da05d96c602402557baa1fc930d0e54f33f5f098581da4c578426d55f75e04cce15ab1ea8b86b049f5b4dc6a87a7e14314dc8096bd1e64f7b2f7"} build_url:https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010808 build_url: 'https://queue.taskcluster.net/v1/task/eFdPqaOLTM-F_iXHbgtT7A/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/fed881ef605dd3b089b15337c8ae26653564b88c27fe364bd52430541fbd9e2e2400a0b743152c46bad1094fdf8a76f4a6e083fcbabc798ea22f76da2e73bd61", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07708804d64562365b7d38613f5045c484c1820f8a5ea564f3fb913316be2df2ee238d58a3ffd0c151331a187a195d0f3e3399e148219863d7eda5acb4c10071", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ba0fad31661d9a285be4d028d56816499ae7fb20c92b35cadb820c0d836c71dba54361e134c5022446aa42c1fec769c76cec00f1098d58d591287c50d27d363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83e55083809da05d96c602402557baa1fc930d0e54f33f5f098581da4c578426d55f75e04cce15ab1ea8b86b049f5b4dc6a87a7e14314dc8096bd1e64f7b2f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 11:02:55.170562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 11:02:55.170886) ========= 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.RCKfX6D8f4/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.wS7hCvrxiA/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.005075 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 11:02:55.219757) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 11:02:55.220081) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 11:02:55.220424) ========= ========= Total master_lag: 0.18 =========