builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0217 starttime: 1467740186.35 results: success (0) buildid: 20160705080924 builduid: 63293650764c4d18860755eb5f87d551 revision: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:26.351608) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:26.352053) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:26.352341) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:26.377921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:26.378266) ========= 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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 --2016-07-05 10:36:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 56.8M=0s 2016-07-05 10:36:26 (56.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:26.513279) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:26.513589) ========= 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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.025750 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:26.561331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 10:36:26.561665) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 274a291aa2c85528ffeb988f0b1b0b61c12136b8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 274a291aa2c85528ffeb988f0b1b0b61c12136b8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.usUdU2zOlC/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.kM5R1MbmNQ/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 2016-07-05 10:36:26,642 truncating revision to first 12 chars 2016-07-05 10:36:26,643 Setting DEBUG logging. 2016-07-05 10:36:26,643 attempt 1/10 2016-07-05 10:36:26,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/274a291aa2c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 10:36:27,708 unpacking tar archive at: mozilla-beta-274a291aa2c8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 10:36:27.905474) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:27.905836) ========= script_repo_revision: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:27.906268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:27.906536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:36:27.924917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-05 10:36:27.925336) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.usUdU2zOlC/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.kM5R1MbmNQ/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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:36:28 INFO - MultiFileLogger online at 20160705 10:36:28 in /builds/slave/test 10:36:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:36:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:36:28 INFO - {'append_to_log': False, 10:36:28 INFO - 'base_work_dir': '/builds/slave/test', 10:36:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:36:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:36:28 INFO - 'branch': 'Mozilla-Beta', 10:36:28 INFO - 'buildbot_json_path': 'buildprops.json', 10:36:28 INFO - 'config_files': ('talos/mac_config.py',), 10:36:28 INFO - 'default_actions': ('clobber', 10:36:28 INFO - 'read-buildbot-config', 10:36:28 INFO - 'download-and-extract', 10:36:28 INFO - 'populate-webroot', 10:36:28 INFO - 'create-virtualenv', 10:36:28 INFO - 'install', 10:36:28 INFO - 'run-tests'), 10:36:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:36:28 INFO - 'download_minidump_stackwalk': True, 10:36:28 INFO - 'download_symbols': 'ondemand', 10:36:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:36:28 INFO - 'tooltool.py': '/tools/tooltool.py', 10:36:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:36:28 INFO - '/tools/misc-python/virtualenv.py')}, 10:36:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:36:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:36:28 INFO - 'installer_path': 'installer.exe', 10:36:28 INFO - 'log_level': 'info', 10:36:28 INFO - 'log_name': 'talos', 10:36:28 INFO - 'log_to_console': True, 10:36:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:36:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:36:28 INFO - 'opt_config_files': (), 10:36:28 INFO - 'pip_index': False, 10:36:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:36:28 INFO - 'cmd': ('bash', 10:36:28 INFO - '-c', 10:36:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:36:28 INFO - 'enabled': True, 10:36:28 INFO - 'halt_on_failure': False, 10:36:28 INFO - 'name': 'check_screen_resolution'},), 10:36:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:36:28 INFO - 'cmd': ('bash', 10:36:28 INFO - '-c', 10:36:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:36:28 INFO - 'enabled': True, 10:36:28 INFO - 'halt_on_failure': False, 10:36:28 INFO - 'name': 'check_screen_resolution'},), 10:36:28 INFO - 'run_cmd_checks_enabled': True, 10:36:28 INFO - 'sps_profile': False, 10:36:28 INFO - 'sps_profile_interval': 0, 10:36:28 INFO - 'suite': 'dromaeojs', 10:36:28 INFO - 'system_bits': '32', 10:36:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:36:28 INFO - 'title': 't-yosemite-r7-0217', 10:36:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:36:28 INFO - 'use_talos_json': True, 10:36:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:36:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:36:28 INFO - 'work_dir': 'build'} 10:36:28 INFO - ##### 10:36:28 INFO - ##### Running clobber step. 10:36:28 INFO - ##### 10:36:28 INFO - Running pre-action listener: _resource_record_pre_action 10:36:28 INFO - Running main action method: clobber 10:36:28 INFO - rmtree: /builds/slave/test/build 10:36:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:36:29 INFO - Running post-action listener: _resource_record_post_action 10:36:29 INFO - ##### 10:36:29 INFO - ##### Running read-buildbot-config step. 10:36:29 INFO - ##### 10:36:29 INFO - Running pre-action listener: _resource_record_pre_action 10:36:29 INFO - Running main action method: read_buildbot_config 10:36:29 INFO - Using buildbot properties: 10:36:29 INFO - { 10:36:29 INFO - "project": "", 10:36:29 INFO - "product": "firefox", 10:36:29 INFO - "script_repo_revision": "production", 10:36:29 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:36:29 INFO - "repository": "", 10:36:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:36:29 INFO - "buildid": "20160705080924", 10:36:29 INFO - "pgo_build": "False", 10:36:29 INFO - "basedir": "/builds/slave/test", 10:36:29 INFO - "buildnumber": 19, 10:36:29 INFO - "slavename": "t-yosemite-r7-0217", 10:36:29 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:36:29 INFO - "platform": "yosemite_r7", 10:36:29 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:36:29 INFO - "branch": "mozilla-beta", 10:36:29 INFO - "repo_path": "releases/mozilla-beta", 10:36:29 INFO - "revision": "274a291aa2c85528ffeb988f0b1b0b61c12136b8", 10:36:29 INFO - "stage_platform": "macosx64", 10:36:29 INFO - "builduid": "63293650764c4d18860755eb5f87d551", 10:36:29 INFO - "slavebuilddir": "test" 10:36:29 INFO - } 10:36:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 10:36:29 INFO - Running post-action listener: _resource_record_post_action 10:36:29 INFO - ##### 10:36:29 INFO - ##### Running download-and-extract step. 10:36:29 INFO - ##### 10:36:29 INFO - Running pre-action listener: _resource_record_pre_action 10:36:29 INFO - Running main action method: download_and_extract 10:36:29 INFO - mkdir: /builds/slave/test/build/tests 10:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:29 INFO - https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:36:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 10:36:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 10:36:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 10:36:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 10:36:32 INFO - Downloaded 1165 bytes. 10:36:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 10:36:32 INFO - Using the following test package requirements: 10:36:32 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 10:36:32 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:36:32 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 10:36:32 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:36:32 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 10:36:32 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:36:32 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:36:32 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 10:36:32 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 10:36:32 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:36:32 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 10:36:32 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:36:32 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 10:36:32 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:36:32 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 10:36:32 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:36:32 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 10:36:32 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 10:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:32 INFO - https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:36:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:36:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:36:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 10:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 10:36:33 INFO - Downloaded 18351432 bytes. 10:36:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:36:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:36:36 INFO - Return code: 0 10:36:36 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:36 INFO - https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:36:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:36:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:36:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 10:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 10:36:37 INFO - Downloaded 18351432 bytes. 10:36:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:36:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:36:40 INFO - Return code: 0 10:36:40 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:40 INFO - https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:36:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 10:36:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 10:36:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 10:36:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 10:36:41 INFO - Downloaded 10840145 bytes. 10:36:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:36:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:36:42 INFO - Return code: 0 10:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:42 INFO - https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:36:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:36:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:36:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 10:36:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 10:36:44 INFO - Downloaded 86190778 bytes. 10:36:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:36:44 INFO - mkdir: /builds/slave/test/properties 10:36:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:36:44 INFO - Writing to file /builds/slave/test/properties/build_url 10:36:44 INFO - Contents: 10:36:44 INFO - build_url:https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:36:45 INFO - Running post-action listener: _resource_record_post_action 10:36:45 INFO - Running post-action listener: set_extra_try_arguments 10:36:45 INFO - ##### 10:36:45 INFO - ##### Running populate-webroot step. 10:36:45 INFO - ##### 10:36:45 INFO - Running pre-action listener: _resource_record_pre_action 10:36:45 INFO - Running main action method: populate_webroot 10:36:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:36:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:36:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:36:45 INFO - '--tppagecycles', 10:36:45 INFO - '7'], 10:36:45 INFO - 'tests': ['tsvgm']}}, 10:36:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:36:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:36:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:36:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:36:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:36:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:36:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:45 INFO - 'talos_options': ['--disable-e10s'], 10:36:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:45 INFO - 'talos_options': ['--disable-e10s'], 10:36:45 INFO - 'tests': ['damp', 'tps']}, 10:36:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:45 INFO - 'tests': ['damp', 'tps']}, 10:36:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:36:45 INFO - 'tests': ['dromaeo_dom']}, 10:36:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:36:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:36:45 INFO - 'tests': ['a11yr', 10:36:45 INFO - 'ts_paint', 10:36:45 INFO - 'tpaint', 10:36:45 INFO - 'sessionrestore', 10:36:45 INFO - 'sessionrestore_no_auto_restore', 10:36:45 INFO - 'tabpaint']}, 10:36:45 INFO - 'other-e10s': {'tests': ['a11yr', 10:36:45 INFO - 'ts_paint', 10:36:45 INFO - 'tpaint', 10:36:45 INFO - 'sessionrestore', 10:36:45 INFO - 'sessionrestore_no_auto_restore', 10:36:45 INFO - 'tabpaint']}, 10:36:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:36:45 INFO - 'ts_paint', 10:36:45 INFO - 'tpaint', 10:36:45 INFO - 'sessionrestore', 10:36:45 INFO - 'sessionrestore_no_auto_restore', 10:36:45 INFO - 'tabpaint']}, 10:36:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:36:45 INFO - 'ts_paint', 10:36:45 INFO - 'tpaint', 10:36:45 INFO - 'sessionrestore', 10:36:45 INFO - 'sessionrestore_no_auto_restore', 10:36:45 INFO - 'tabpaint']}, 10:36:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:36:45 INFO - 'tests': ['a11yr', 10:36:45 INFO - 'ts_paint', 10:36:45 INFO - 'tpaint', 10:36:45 INFO - 'sessionrestore', 10:36:45 INFO - 'sessionrestore_no_auto_restore', 10:36:45 INFO - 'tabpaint']}, 10:36:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:36:45 INFO - 'tests': ['a11yr', 10:36:45 INFO - 'ts_paint', 10:36:45 INFO - 'tpaint', 10:36:45 INFO - 'sessionrestore', 10:36:45 INFO - 'sessionrestore_no_auto_restore', 10:36:45 INFO - 'tabpaint']}, 10:36:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:36:45 INFO - 'tests': ['tsvgx', 10:36:45 INFO - 'tsvgr_opacity', 10:36:45 INFO - 'tart', 10:36:45 INFO - 'tscrollx', 10:36:45 INFO - 'cart']}, 10:36:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:36:45 INFO - 'tsvgr_opacity', 10:36:45 INFO - 'tart', 10:36:45 INFO - 'tscrollx', 10:36:45 INFO - 'cart']}, 10:36:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:45 INFO - 'talos_options': ['--disable-e10s'], 10:36:45 INFO - 'tests': ['tp5o']}, 10:36:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:45 INFO - 'tests': ['tp5o']}, 10:36:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:45 INFO - 'talos_options': ['--disable-e10s', 10:36:45 INFO - '--xperf_path', 10:36:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:45 INFO - 'tests': ['tp5n']}, 10:36:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:45 INFO - 'talos_options': ['--xperf_path', 10:36:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:45 INFO - 'tests': ['tp5n']}}, 10:36:45 INFO - 'talos.zip': {'path': '', 10:36:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:36:45 INFO - Running post-action listener: _resource_record_post_action 10:36:45 INFO - ##### 10:36:45 INFO - ##### Running create-virtualenv step. 10:36:45 INFO - ##### 10:36:45 INFO - Running pre-action listener: _resource_record_pre_action 10:36:45 INFO - Running main action method: create_virtualenv 10:36:45 INFO - Creating virtualenv /builds/slave/test/build/venv 10:36:45 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:36:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:36:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:36:45 INFO - Using real prefix '/tools/python27' 10:36:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:36:46 INFO - Installing distribute.............................................................................................................................................................................................done. 10:36:49 INFO - Installing pip.................done. 10:36:49 INFO - Return code: 0 10:36:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b275a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b285420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94cad92c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b114e00>, '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 0x10af7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10fb20>, '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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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:36: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', 'pip>=1.5'] in /builds/slave/test/build 10:36: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 pip>=1.5 10:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.usUdU2zOlC/Render', 10:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:49 INFO - 'HOME': '/Users/cltbld', 10:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:49 INFO - 'LOGNAME': 'cltbld', 10:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:49 INFO - 'MOZ_NO_REMOTE': '1', 10:36:49 INFO - 'NO_EM_RESTART': '1', 10:36:49 INFO - 'PAGER': '/bin/cat', 10:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:49 INFO - 'PWD': '/builds/slave/test', 10:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:49 INFO - 'SHELL': '/bin/bash', 10:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kM5R1MbmNQ/Listeners', 10:36:49 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 10:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:49 INFO - 'USER': 'cltbld', 10:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:49 INFO - 'XPC_FLAGS': '0x0', 10:36:49 INFO - 'XPC_SERVICE_NAME': '0', 10:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:49 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:36:49 INFO - Cleaning up... 10:36:49 INFO - Return code: 0 10:36:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b275a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b285420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94cad92c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b114e00>, '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 0x10af7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10fb20>, '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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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:36: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', 'psutil>=0.7.1'] in /builds/slave/test/build 10:36: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 psutil>=0.7.1 10:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.usUdU2zOlC/Render', 10:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:49 INFO - 'HOME': '/Users/cltbld', 10:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:49 INFO - 'LOGNAME': 'cltbld', 10:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:49 INFO - 'MOZ_NO_REMOTE': '1', 10:36:49 INFO - 'NO_EM_RESTART': '1', 10:36:49 INFO - 'PAGER': '/bin/cat', 10:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:49 INFO - 'PWD': '/builds/slave/test', 10:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:49 INFO - 'SHELL': '/bin/bash', 10:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kM5R1MbmNQ/Listeners', 10:36:49 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 10:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:49 INFO - 'USER': 'cltbld', 10:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:49 INFO - 'XPC_FLAGS': '0x0', 10:36:49 INFO - 'XPC_SERVICE_NAME': '0', 10:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:49 INFO - Downloading/unpacking psutil>=0.7.1 10:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:36:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:52 INFO - Installing collected packages: psutil 10:36:52 INFO - Running setup.py install for psutil 10:36:52 INFO - building 'psutil._psutil_osx' extension 10:36:52 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:36:53 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:36:53 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:36:53 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:36:53 INFO - building 'psutil._psutil_posix' extension 10:36:53 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:36:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:36:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:36:53 INFO - ^ 10:36:53 INFO - 1 warning generated. 10:36:53 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:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:53 INFO - Successfully installed psutil 10:36:53 INFO - Cleaning up... 10:36:54 INFO - Return code: 0 10:36:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:54 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b275a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b285420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94cad92c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b114e00>, '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 0x10af7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10fb20>, '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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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:36:54 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.0.0'] in /builds/slave/test/build 10:36:54 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.0.0 10:36:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.usUdU2zOlC/Render', 10:36:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:54 INFO - 'HOME': '/Users/cltbld', 10:36:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:54 INFO - 'LOGNAME': 'cltbld', 10:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:54 INFO - 'MOZ_NO_REMOTE': '1', 10:36:54 INFO - 'NO_EM_RESTART': '1', 10:36:54 INFO - 'PAGER': '/bin/cat', 10:36:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:54 INFO - 'PWD': '/builds/slave/test', 10:36:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:54 INFO - 'SHELL': '/bin/bash', 10:36:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kM5R1MbmNQ/Listeners', 10:36:54 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 10:36:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:54 INFO - 'USER': 'cltbld', 10:36:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:54 INFO - 'XPC_FLAGS': '0x0', 10:36:54 INFO - 'XPC_SERVICE_NAME': '0', 10:36:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:36:54 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:36:54 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:36:54 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:36:54 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:36:54 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:36:54 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:36:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:36:56 INFO - Installing collected packages: mozsystemmonitor 10:36:56 INFO - Running setup.py install for mozsystemmonitor 10:36:56 INFO - Successfully installed mozsystemmonitor 10:36:56 INFO - Cleaning up... 10:36:56 INFO - Return code: 0 10:36:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:36:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:56 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 0x10b275a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b285420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94cad92c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b114e00>, '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 0x10af7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10fb20>, '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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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:36:56 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:36:56 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:36:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.usUdU2zOlC/Render', 10:36:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:56 INFO - 'HOME': '/Users/cltbld', 10:36:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:56 INFO - 'LOGNAME': 'cltbld', 10:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:56 INFO - 'MOZ_NO_REMOTE': '1', 10:36:56 INFO - 'NO_EM_RESTART': '1', 10:36:56 INFO - 'PAGER': '/bin/cat', 10:36:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:56 INFO - 'PWD': '/builds/slave/test', 10:36:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:56 INFO - 'SHELL': '/bin/bash', 10:36:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kM5R1MbmNQ/Listeners', 10:36:56 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 10:36:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:56 INFO - 'USER': 'cltbld', 10:36:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:56 INFO - 'XPC_FLAGS': '0x0', 10:36:56 INFO - 'XPC_SERVICE_NAME': '0', 10:36:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:59 INFO - Downloading blobuploader-1.2.4.tar.gz 10:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:36:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:36:59 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:36:59 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:36:59 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:36:59 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:36:59 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:36:59 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:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:37:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:37:00 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:37:00 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:37:00 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:37:00 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:37:00 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:37:00 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:37:00 INFO - Downloading docopt-0.6.1.tar.gz 10:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:37:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:37:01 INFO - Running setup.py install for blobuploader 10:37:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:37:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:37:01 INFO - Running setup.py install for requests 10:37:01 INFO - Running setup.py install for docopt 10:37:01 INFO - Successfully installed blobuploader requests docopt 10:37:01 INFO - Cleaning up... 10:37:01 INFO - Return code: 0 10:37:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:01 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 0x10b275a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b285420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94cad92c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b114e00>, '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 0x10af7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10fb20>, '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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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:37:01 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:37:01 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:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.usUdU2zOlC/Render', 10:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:01 INFO - 'HOME': '/Users/cltbld', 10:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:01 INFO - 'LOGNAME': 'cltbld', 10:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:01 INFO - 'MOZ_NO_REMOTE': '1', 10:37:01 INFO - 'NO_EM_RESTART': '1', 10:37:01 INFO - 'PAGER': '/bin/cat', 10:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:01 INFO - 'PWD': '/builds/slave/test', 10:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:01 INFO - 'SHELL': '/bin/bash', 10:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kM5R1MbmNQ/Listeners', 10:37:01 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 10:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:01 INFO - 'USER': 'cltbld', 10:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:01 INFO - 'XPC_FLAGS': '0x0', 10:37:01 INFO - 'XPC_SERVICE_NAME': '0', 10:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:37:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-DNdBtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:37:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-hIUroY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:37:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-94ZkS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:37:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-oKqowu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:37:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-r9C_EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:37:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-t8rN2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:37:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-bYWv2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:37:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-vqvO27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:37:02 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Oq2hXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:37:03 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-v3MJ1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:37:03 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-ssdgwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:37:03 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-plyEA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:37:03 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-YXD99O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:37:03 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-MdOaBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:03 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-oC0Nmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:37:03 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-sLqZs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:37:03 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-ORV3Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:37:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:37:03 INFO - Running setup.py install for manifestparser 10:37:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozcrash 10:37:04 INFO - Running setup.py install for mozdebug 10:37:04 INFO - Running setup.py install for mozdevice 10:37:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozfile 10:37:04 INFO - Running setup.py install for mozhttpd 10:37:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozinfo 10:37:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozInstall 10:37:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Running setup.py install for mozleak 10:37:05 INFO - Running setup.py install for mozlog 10:37:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Running setup.py install for moznetwork 10:37:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Running setup.py install for mozprocess 10:37:05 INFO - Running setup.py install for mozprofile 10:37:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Running setup.py install for mozrunner 10:37:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:37:06 INFO - Running setup.py install for mozscreenshot 10:37:06 INFO - Running setup.py install for moztest 10:37:06 INFO - Running setup.py install for mozversion 10:37:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:37:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:37:06 INFO - Cleaning up... 10:37:06 INFO - Return code: 0 10:37:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:06 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 0x10b275a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b285420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94cad92c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b114e00>, '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 0x10af7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10fb20>, '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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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:37:06 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:37:06 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:37:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.usUdU2zOlC/Render', 10:37:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:06 INFO - 'HOME': '/Users/cltbld', 10:37:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:06 INFO - 'LOGNAME': 'cltbld', 10:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:06 INFO - 'MOZ_NO_REMOTE': '1', 10:37:06 INFO - 'NO_EM_RESTART': '1', 10:37:06 INFO - 'PAGER': '/bin/cat', 10:37:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:06 INFO - 'PWD': '/builds/slave/test', 10:37:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:06 INFO - 'SHELL': '/bin/bash', 10:37:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kM5R1MbmNQ/Listeners', 10:37:06 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 10:37:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:06 INFO - 'USER': 'cltbld', 10:37:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:06 INFO - 'XPC_FLAGS': '0x0', 10:37:06 INFO - 'XPC_SERVICE_NAME': '0', 10:37:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:37:06 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-8xt2if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:37:06 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-toX6yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:37:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:37:06 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-jxgqfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:37:07 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-NKQyVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:37:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:37:07 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Foqu4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:37:07 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Rv5x7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:37:07 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Eo2aHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:37:07 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Z7JAPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:37:07 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Ld8ZDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:37:07 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Kl9JIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:37:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:37:07 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-yOUnyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:37:07 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-JQTk31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:37:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:37:08 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-ubt8LN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:37:08 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Ysuz04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:37:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:08 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-1GlGPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:37:08 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-BRinyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:37:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:37:08 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-wouzcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:37:08 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:37:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:37:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:37:08 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:37:08 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:37:08 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:37:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:10 INFO - Downloading blessings-1.6.tar.gz 10:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:37:11 INFO - Installing collected packages: blessings 10:37:11 INFO - Running setup.py install for blessings 10:37:11 INFO - Successfully installed blessings 10:37:11 INFO - Cleaning up... 10:37:11 INFO - Return code: 0 10:37:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:37:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:37:11 INFO - Reading from file tmpfile_stdout 10:37:11 INFO - Current package versions: 10:37:11 INFO - blessings == 1.6 10:37:11 INFO - blobuploader == 1.2.4 10:37:11 INFO - docopt == 0.6.1 10:37:11 INFO - manifestparser == 1.1 10:37:11 INFO - mozInstall == 1.12 10:37:11 INFO - mozcrash == 0.17 10:37:11 INFO - mozdebug == 0.1 10:37:11 INFO - mozdevice == 0.48 10:37:11 INFO - mozfile == 1.2 10:37:11 INFO - mozhttpd == 0.7 10:37:11 INFO - mozinfo == 0.9 10:37:11 INFO - mozleak == 0.1 10:37:11 INFO - mozlog == 3.1 10:37:11 INFO - moznetwork == 0.27 10:37:11 INFO - mozprocess == 0.22 10:37:11 INFO - mozprofile == 0.28 10:37:11 INFO - mozrunner == 6.11 10:37:11 INFO - mozscreenshot == 0.1 10:37:11 INFO - mozsystemmonitor == 0.0 10:37:11 INFO - moztest == 0.7 10:37:11 INFO - mozversion == 1.4 10:37:11 INFO - psutil == 3.1.1 10:37:11 INFO - requests == 1.2.3 10:37:11 INFO - wsgiref == 0.1.2 10:37:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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 0x10b275a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b285420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94cad92c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b114e00>, '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 0x10af7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10fb20>, '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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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:37:11 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:37:11 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:37:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.usUdU2zOlC/Render', 10:37:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:11 INFO - 'HOME': '/Users/cltbld', 10:37:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:11 INFO - 'LOGNAME': 'cltbld', 10:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:11 INFO - 'MOZ_NO_REMOTE': '1', 10:37:11 INFO - 'NO_EM_RESTART': '1', 10:37:11 INFO - 'PAGER': '/bin/cat', 10:37:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:11 INFO - 'PWD': '/builds/slave/test', 10:37:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:11 INFO - 'SHELL': '/bin/bash', 10:37:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kM5R1MbmNQ/Listeners', 10:37:11 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 10:37:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:11 INFO - 'USER': 'cltbld', 10:37:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:11 INFO - 'XPC_FLAGS': '0x0', 10:37:11 INFO - 'XPC_SERVICE_NAME': '0', 10:37:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:11 INFO - Cleaning up... 10:37:11 INFO - Return code: 0 10:37:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:37:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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 0x10b275a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b285420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94cad92c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b114e00>, '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 0x10af7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10fb20>, '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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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:37:11 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:37:11 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:37:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.usUdU2zOlC/Render', 10:37:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:11 INFO - 'HOME': '/Users/cltbld', 10:37:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:11 INFO - 'LOGNAME': 'cltbld', 10:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:11 INFO - 'MOZ_NO_REMOTE': '1', 10:37:11 INFO - 'NO_EM_RESTART': '1', 10:37:11 INFO - 'PAGER': '/bin/cat', 10:37:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:11 INFO - 'PWD': '/builds/slave/test', 10:37:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:11 INFO - 'SHELL': '/bin/bash', 10:37:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kM5R1MbmNQ/Listeners', 10:37:11 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 10:37:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:11 INFO - 'USER': 'cltbld', 10:37:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:11 INFO - 'XPC_FLAGS': '0x0', 10:37:11 INFO - 'XPC_SERVICE_NAME': '0', 10:37:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:12 INFO - Downloading/unpacking jsonschema 10:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:37:14 INFO - Downloading/unpacking functools32 (from jsonschema) 10:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:14 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:37:14 INFO - Downloading functools32-3.2.3-2.tar.gz 10:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:37:14 INFO - warning: no files found matching '*.txt' 10:37:14 INFO - no previously-included directories found matching 'build' 10:37:14 INFO - no previously-included directories found matching 'dist' 10:37:14 INFO - no previously-included directories found matching '.git*' 10:37:15 INFO - Installing collected packages: jsonschema, functools32 10:37:15 INFO - Running setup.py install for functools32 10:37:15 INFO - warning: no files found matching '*.txt' 10:37:15 INFO - no previously-included directories found matching 'build' 10:37:15 INFO - no previously-included directories found matching 'dist' 10:37:15 INFO - no previously-included directories found matching '.git*' 10:37:15 INFO - Successfully installed jsonschema functools32 10:37:15 INFO - Cleaning up... 10:37:15 INFO - Return code: 0 10:37:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b275a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b285420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94cad92c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b114e00>, '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 0x10af7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10fb20>, '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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.usUdU2zOlC/Render', 10:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:15 INFO - 'HOME': '/Users/cltbld', 10:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:15 INFO - 'LOGNAME': 'cltbld', 10:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:15 INFO - 'MOZ_NO_REMOTE': '1', 10:37:15 INFO - 'NO_EM_RESTART': '1', 10:37:15 INFO - 'PAGER': '/bin/cat', 10:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:15 INFO - 'PWD': '/builds/slave/test', 10:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:15 INFO - 'SHELL': '/bin/bash', 10:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kM5R1MbmNQ/Listeners', 10:37:15 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 10:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:15 INFO - 'USER': 'cltbld', 10:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:15 INFO - 'XPC_FLAGS': '0x0', 10:37:15 INFO - 'XPC_SERVICE_NAME': '0', 10:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:15 INFO - Downloading/unpacking flake8 10:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:37:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:37:17 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:37:17 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:37:17 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:37:17 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:37:17 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:37:17 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:37:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:37:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:37:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:37:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:37:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:37:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:37:19 INFO - no previously-included directories found matching 'docs/_build' 10:37:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:37:19 INFO - Running setup.py install for pep8 10:37:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:37:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:37:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:37:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:37:19 INFO - no previously-included directories found matching 'docs/_build' 10:37:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:37:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:37:19 INFO - Cleaning up... 10:37:19 INFO - Return code: 0 10:37:19 INFO - Running post-action listener: _resource_record_post_action 10:37:19 INFO - Running post-action listener: _start_resource_monitoring 10:37:19 INFO - Starting resource monitoring. 10:37:19 INFO - ##### 10:37:19 INFO - ##### Running install step. 10:37:19 INFO - ##### 10:37:19 INFO - Running pre-action listener: _resource_record_pre_action 10:37:19 INFO - Running main action method: install 10:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:37:19 INFO - Reading from file tmpfile_stdout 10:37:19 INFO - Detecting whether we're running mozinstall >=1.0... 10:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:37:19 INFO - Reading from file tmpfile_stdout 10:37:19 INFO - Output received: 10:37:19 INFO - Usage: mozinstall [options] installer 10:37:19 INFO - Options: 10:37:19 INFO - -h, --help show this help message and exit 10:37:19 INFO - -d DEST, --destination=DEST 10:37:19 INFO - Directory to install application into. [default: 10:37:19 INFO - "/builds/slave/test"] 10:37:19 INFO - --app=APP Application being installed. [default: firefox] 10:37:19 INFO - mkdir: /builds/slave/test/build/application 10:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:37:41 INFO - Reading from file tmpfile_stdout 10:37:41 INFO - Output received: 10:37:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:37:41 INFO - Running post-action listener: _resource_record_post_action 10:37:41 INFO - ##### 10:37:41 INFO - ##### Running run-tests step. 10:37:41 INFO - ##### 10:37:41 INFO - Running pre-action listener: _resource_record_pre_action 10:37:41 INFO - Running main action method: run_tests 10:37:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:37:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:37:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:37:41 INFO - 2016-07-05 10:37:41.905 screenresolution[1639:7517] starting screenresolution argv=screenresolution get 10:37:41 INFO - 2016-07-05 10:37:41.908 screenresolution[1639:7517] Display 0: 1600x1200x32@60 10:37:41 INFO - 2016-07-05 10:37:41.913 screenresolution[1640:7519] starting screenresolution argv=screenresolution list 10:37:41 INFO - Available Modes on Display 0 10:37:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:37:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:37:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:37:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:37:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:37:42 INFO - Intel Iris: 10:37:42 INFO - Chipset Model: Intel Iris 10:37:42 INFO - Type: GPU 10:37:42 INFO - Bus: Built-In 10:37:42 INFO - VRAM (Dynamic, Max): 1536 MB 10:37:42 INFO - Vendor: Intel (0x8086) 10:37:42 INFO - Device ID: 0x0a2e 10:37:42 INFO - Revision ID: 0x0009 10:37:42 INFO - Displays: 10:37:42 INFO - Display: 10:37:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:37:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:37:42 INFO - Display Serial Number: 1600x1200 60 10:37:42 INFO - Main Display: Yes 10:37:42 INFO - Mirror: Off 10:37:42 INFO - Online: Yes 10:37:42 INFO - Rotation: Supported 10:37:42 INFO - Return code: 0 10:37:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:37:42 INFO - Python 2.7.3 10:37:42 INFO - Return code: 0 10:37:42 INFO - grabbing minidump binary from tooltool 10:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:42 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b114e00>, '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 0x10af7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:37:42 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:37:42 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:37:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:37:42 INFO - Return code: 0 10:37:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:37:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:37:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:37:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:37:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:37:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:37:43 INFO - Return code: 0 10:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0217 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:37:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.usUdU2zOlC/Render', 10:37:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:43 INFO - 'HOME': '/Users/cltbld', 10:37:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:43 INFO - 'LOGNAME': 'cltbld', 10:37:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:37:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:43 INFO - 'MOZ_NO_REMOTE': '1', 10:37:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:37:43 INFO - 'NO_EM_RESTART': '1', 10:37:43 INFO - 'PAGER': '/bin/cat', 10:37:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:43 INFO - 'PWD': '/builds/slave/test', 10:37:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:37:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:43 INFO - 'SHELL': '/bin/bash', 10:37:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kM5R1MbmNQ/Listeners', 10:37:43 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 10:37:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:43 INFO - 'USER': 'cltbld', 10:37:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:43 INFO - 'XPC_FLAGS': '0x0', 10:37:43 INFO - 'XPC_SERVICE_NAME': '0', 10:37:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:37:43 INFO - mozversion application_buildid: 20160705080924 10:37:43 INFO - mozversion application_changeset: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 10:37:43 INFO - mozversion application_display_name: Firefox 10:37:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:37:43 INFO - mozversion application_name: Firefox 10:37:43 INFO - mozversion application_remotingname: firefox 10:37:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:37:43 INFO - mozversion application_vendor: Mozilla 10:37:43 INFO - mozversion application_version: 48.0 10:37:43 INFO - mozversion platform_buildid: 20160705080924 10:37:43 INFO - mozversion platform_changeset: 274a291aa2c85528ffeb988f0b1b0b61c12136b8 10:37:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:37:43 INFO - mozversion platform_version: 48.0 10:37:43 INFO - using testdate: 1467740263 10:37:43 INFO - actual date: 1467740263 10:37:43 INFO - starting webserver on 'localhost:49278' 10:37:43 INFO - SUITE-START | Running 2 tests 10:37:43 INFO - TEST-START | dromaeo_css 10:37:43 INFO - operating with platform_type : mac_ 10:37:43 INFO - Initialising browser for dromaeo_css test... 10:37:43 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpO0sBcy/profile http://localhost:49278/getInfo.html) 10:37:46 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 10:37:46 INFO - PROCESS | 1658 | colorDepth:24 10:37:46 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 10:37:46 INFO - PROCESS | 1658 | __metrics 10:37:46 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:37:46 ERROR - PROCESS | 1658 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:37:46 INFO - TEST-INFO | 1658: exit 0 10:37:46 INFO - Browser initialized. 10:37:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:37:46 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpO0sBcy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:37:58 INFO - PROCESS | 1664 | RSS: Main: 161730560 10:37:58 INFO - PROCESS | 1664 | 10:38:50 INFO - PROCESS | 1664 | 1467740330090 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:41:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 10:41:01 INFO - PROCESS | 1664 | RSS: Main: 298766336 10:41:01 INFO - PROCESS | 1664 | 10:44:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 10:44:04 INFO - PROCESS | 1664 | RSS: Main: 310382592 10:44:04 INFO - PROCESS | 1664 | 10:47:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 10:47:07 INFO - PROCESS | 1664 | RSS: Main: 312582144 10:47:07 INFO - PROCESS | 1664 | 10:50:09 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 10:50:09 INFO - PROCESS | 1664 | RSS: Main: 306995200 10:50:09 INFO - PROCESS | 1664 | 10:53:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 10:53:13 INFO - PROCESS | 1664 | RSS: Main: 273235968 10:53:13 INFO - PROCESS | 1664 | 10:56:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 10:56:16 INFO - PROCESS | 1664 | RSS: Main: 315236352 10:56:16 INFO - PROCESS | 1664 | 10:56:16 INFO - PROCESS | 1664 | __start_tp_report 10:56:16 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 10:56:16 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 10:56:16 INFO - PROCESS | 1664 | |i|pagename|runs| 10:56:16 INFO - PROCESS | 1664 | |0;dojo.html;3269.7384209263255;3603.549556305462;3608.65717756813;3609.3322735293973;3695.5750088739787;5926.703664816763;5956.851078723023;5967.9738040092625;5969.7313620887;6025.126356678279;5892.880352732977;5956.225690660208;5959.225300710901;5965.313988891279;5970.134330522083;4414.381986521889;5241.292425522543;5286.735663216843;5362.544183744387;5414.539764120054;5322.308099947001;5367.275417818603;5368.194770784394;5377.220303056055;5383.596230282725;5328.254044433782;5368.979893820181;5380.973095134519;5396.163594642837;5398.4871437213405;5382.165764306539;5410.48600382963;5412.323459567554;5431.076716958087;5462.754176062087;5158.716270605115;5200.843974680728;5312.946870531323;5339.385970613391;5368.543673787733;5741.511971482429;5750.424957504216;5768.990426675315;5772.220750198711;5776.075827867521;6252.559454249428;6267.341929097424;6267.905981410283;6270.247570291549;6298.842528936768;6212.347703491114;6249;6254.781082662085;6277.937220627827;6304.842378940517;5981.491573216282;5994.580379373402;6014.3985601439945;6023.668698221596;6054.939450605526;5495.681036551199;6399.8080057598345;6408.423241908251;6414.807555773335;6416.518761092843;6163.229596300463;6230.190075290183;6348.904766428507;6350.491960643138;6352.301246862841;6269.059641053878;6290.654014029181;6300.495960323163;6301.117843501914;6310.274318453345;6230.56386052981;6275.623462592259;6288.654124023131;6294.874102517924;6303.558750887394;6209.441150296495;6234.407731265523;6298.653574053379;6320.873582528324;6327.145835312266;4985.626078044089;5028.974855125774;5066.417362003343;5067.366579177603;5082.898342033139;4557.817687292471;4560.270356742905;4564.1556312082375;4572.4055872737;4616.422947131608;5007.3240112584335;5907.1434641976675;6033.095035744585;6042.6978651067275;6055.091736239511;6173.938260617426;6199.752009919643;6260;6262.53031022666;6266;6107.603005804697;6110.511159107261;6118.938810611926;6131.877362452815;6133.1413602095745;5513.58648101394;5569.888602227933;5579.637323574036;5586.413426590231;5587.161925711094;6371.681415929185;6390.265119511129;6484.902726459012;6502.349765023459;6522.510811689142;6255.155554000152;6287.685615719287;6292.748290068529;6310.1796766420075;6313.747450101944;6488.059231411513;6495.870082598416;6508.837279068061;6516.087747715418;6527.184101987252;6181.660008699565;6215;6262.624242545462;6281.52888533371;6330.050492426173;6276.529260305404;6281.560290779602;6286.119943208046;6290;6300.842478938063;6092.512598992159;6278.780242691484;6317.9052314214405;6319.526035547445;6327.557071004985;6120.447133218705;6151.446369826737;6291.339409361951;6330.082138090043;6334.6832658365975;6140.938590614037;6148.907766383597;6185.597936134137;6190.628562286097;6193.938060619336;6150.077488376779;6252.280987686292;6311.96844015777;6317.084022816574;6350.206224221973;6112.65546444155;6241.438270555672;6245.843853903689;6254.749810007549;6270.341614130451 10:56:16 INFO - PROCESS | 1664 | |1;ext.html;534.2840593604569;544.771196097639;554.7891801115577;580.2311936683894;605.3946053946054;31508.842455787748;32390.67609323906;38451.80774096129;39311.80344098275;39391.015224619325;43779.3433098503;44085.11829763403;44087.33868991968;44104.117917641626;44187.337189942176;9626.566804493814;9816.70549883501;9824.1649459796;9837;9918.05778451046;9173.44959302444;9402.247820174369;9477.620895164186;11832;12077.15459917806;11786.17496775226;11849;11855.288682679024;11856.822147667792;11881.34652594107;11740.060795136369;11814.350210738407;11818.704532386673;11819.645410637695;11827.408629568487;11310.773784524346;11424.485898134604;11508.712282192928;11526.94236528812;11532.077433805276;38471;38880.833574992794;41361.37957930633;41469.58530414718;41492.37761433581;3348.7990720556845;3421.0250078727445;3484.6341134181052;3513.929721405583;3993.880183594497;28086.438271234667;29015.564766528307;29027.419451611062;29257;29455.558166627517;2779.207925741174;2798.0626490125833;2850.458412901542;2937.985310073457;2954.571587119877;500959;504692;505471;505658;506824;38511;39208.019799505244;73279;74552.62723686347;74764.62617686877;38421.03947401282;38545.421818672745;38685;38727;38813.805930970164;14253.928730356489;16104.677906441806;16203.108829014518;16383.508494745176;16413.343466261216;12896.80654790179;13576.117552359065;13732.519361822287;13763.587092387244;13763.931180344234;8193.59032048407;8694.217520423066;8767.780805479913;8816.779580510538;8835.425697329652;3616.8191590420374;3671.210689701727;3679.1354031802507;3699.463577781207;3736.1406876418578;959.7312752429331;979.7893452907659;1004.2116938203475;1039.927205095636;1091.4379094766202;28639.053254437953;28690.85654571714;29224.415511689647;29229.415411691647;29340.559891601642;1121.394446998628;1167.1888037813808;1173.2139466557428;1180.4982882274999;1249.656619134434;14903.329350179269;14991.700165996619;14993.475228366955;15281.541553753405;15481.458148964957;638623;644444;645073;646962;647430;63570.6821465899;65836.34163658398;65896.34103658902;65923;66165.6691716548;1440.9351579178963;1452.375478544215;1574.999875079356;1632.183908045977;1653.3551914753257;29138.7086129136;29728.85135574308;29831;30639;30666.846665766527;54741.45258547523;55442.72278638581;55444.44555554393;55527.444725552225;55603.443965559825;519754;523079;523985;525263;654567;28748;29216.561751573317;29483.55774663339;29498.55752163762;29516.557251641672;42795.358069629605;44111.33832992572;44279;45711;45949;30624.62189201536;33313.666863331055;34821;35954.10114747048;36256.63743362533;31534;34424;36275.63724362723;37850;38502.80748596239;37698.43452348272;38228.6177138225;38770.4184437228;38902.610973889896;38915;27014.459710806066;33067.8346608275;33917.49123763195;34017;34109.82945085259;21154.15383384709;25067.122650707137;25376.238712838644;25525.851336690266;26227.606585900845 10:56:16 INFO - PROCESS | 1664 | |2;jquery.html;405.3312035142013;406.6299667302753;408.5607971430713;410.9280875846726;417.3660120627741;19528.21887124513;20241.291554795585;20882.060307286152;20919.790802091975;21038.474038149056;20520;20546.76719396837;21557.245496407628;22103.115875365005;22118.668219976713;5251.369835619731;5981.1028345748055;5989.1016347548;6070.301915279755;6139.7851075212375;6073.665948372838;6100.23747031621;6109.297430795449;6130.141780150782;6137.447629713325;5933.584649074566;6035.849103772397;6078.20983272174;6123.387661233885;6134.9079763803575;6074.119252708355;6091.299500557426;6096.39036096389;6133.049377346519;6145.108959200936;5291.100512912775;5374.871277031828;5380.435054319319;5384.623076384615;5393.2449457076045;23390.76609233903;26754.732452675613;26895.462090758076;27476;27980.860095699594;2195.3852921182092;2289.702338695959;2348.213348528245;2624.2914413108547;2674.0368977180997;15508.689826203412;15662.295196716175;15798.289076991563;16049.518514444586;16438.83561164385;1785.2501949181376;1785.419738584965;1822.3844764984879;1845.6401001804654;1848.574827789616;106843;107187;110719;112388;113922;11476.655700329004;11709.941450292694;11787.646370608896;11811.88188118125;11976.341301228342;14802.185879776716;14935.850641493445;14961;14970.850291496945;14985.175815330262;9098.727038188865;9103.180713735796;9137.588808503633;9141.080373121586;9241.02969188239;9202.677906273382;9258.90741092594;9262.44425334482;9323.813523729623;9338.859917101248;5794.21778059965;6971;6982.022516847645;7050.365467107985;7112.50212485121;1813.8548916086945;1901.5341241395947;1911.4934542346289;1953.5311525234126;1976.1700085963641;935.5462600638684;975.8048390321964;988.5502096546054;997.5710444508786;1046.581367453025;21438;22287.442813929458;22402.327930162122;22410;22449.88775056114;991.494337887668;1015.8527013582989;1065.8454524093963;1070.9732256693644;1095.0746619106842;11763;11937.462814173383;11957.52169913211;11992.700182495508;12012.339321337411;448377;462679;462812;463355;463472;128997.71002290044;135498;140246;141308.2934585341;146358;929.8558723397884;1049.5486940615608;1086.4241951765578;1099.571167244775;1103.8840921703265;16890.493285201464;17102.230399632295;18181.54671550666;18512;19011.33460328882;51515.74242128765;53741.46258537521;54239.45760542344;54361.45638543564;55354.446455534926;74841.62579187287;78589;79260.41479170269;80428.19571804442;83339;6844.4182244509775;8299.543525106177;8462.661493540189;8548.700795472128;8561.57192140403;12695.36523173856;12761;12771.042171836963;12978.415971281127;13022.348882556023;10843.24097313212;11251.549938002388;11464.713382165179;11502.48238829238;11595.710107247387;11101.222914396238;11197.048250898764;11234;11328.60349887783;11472.65582032507;11347;11556.248843825124;11809.468573914366;11860.703482412664;11990.340531270864;8196.54918979462;8207.630656620586;8285.337173026264;8493.830123397374;8495.702650407206;8617.870731938901;10847.45762711877;11300.94349528247;11574.594889178838;11754.941225293818 10:56:16 INFO - PROCESS | 1664 | |3;mootools.html;1445.4218312674934;1618.2636900210405;1655.5033489953012;1909.7994710555392;2028.6551286281322;8269.25576698097;8907.554622268884;9035.412698174614;9040.954795226024;9044.77388065297;8854.247388971946;8880.955595222014;9002.549872506364;9012.188902998729;9012.233960113399;2521.9369515762114;2547.439563296072;2547.9935425506915;2553.080890879282;2553.0808908792915;2494.3514686181634;2562.6668533090674;2563.8205325627214;2568.614707793827;2571.2671888511777;2516.534441128388;2546.637548911333;2560.667113275281;2563.051670881767;2565.8973641054336;2509.77412032917;2537.581299085658;2552.5660637691544;2556.974430255711;2557.8465292082533;2502.036715864387;2522.167684664075;2539.149384956042;2540.911068112607;2551.094361501677;8736;9051.637934482613;9088.545572721338;9106.908930910673;9127.178553930178;5602.495775380195;5758;5763.5101016413655;5768.077107662796;5780.7687692492245;3113.3306339137193;3643.28955853606;3739.7943113128767;3763.078045878777;3779.338615742234;932.4172392254841;1056.7727938493183;1073.8281874900056;1084.6312253833735;1090.8527348807968;12404.503819847196;12542.435590398454;12670.55653052148;12690.682732931658;12698.682532936658;4849.369581954324;4853.247746599212;4857.757112144379;4866.8783280417565;4912.238603016538;9767.316287859923;9795.461249631338;9797.118259356692;9797.657082002095;9809.313348065567;5639.0977443609645;5644;5647.068233741386;5651.57613179005;5657.405972372924;4675.462321832964;4789.640776941744;5029.396472423259;5129.615278854101;5250.868728281824;3987.6610488108836;4027.657649099801;4064.4106604542176;4112.691548133902;4130.545639979599;1244.7821631214683;1251.355551890777;1261.1550261324935;1275.5854347337151;1280.9743805123846;929.8791157149662;943.5706753427174;957.8563215517589;965.2567523007245;1003.1874181912674;5995.280566332068;6067.696615169312;6189.669221117481;6193.783217587363;6229.3770622937345;485.73041961710885;487.1256095308858;492.0970020013244;1044.9895501045044;1045.7072019834459;3963;4002;4025.5571887092397;4043.5754245804355;4132.752034877857;10536.10443112344;10901.781964360827;11021.338719676845;11035;11043.282186657842;10864.891351086388;10872.67381978542;10873.565057397775;10891.183161262938;10946.616868409568;8447.155284471504;8543.273821725223;8766.99179594342;8845;8846.77883052916;5879.559033072451;5990.251218597676;6025.758969641341;6042.577019608585;6054.606450580698;8567.4002819802;10197.592096316064;10209.795804084026;10225.233107517115;10226.437545935045;9689.224862011164;10039.29724919278;10193.43936083493;10199.694009179737;10382.688519344432;7118.750843720445;7352.77941661751;7629.465937384552;7802.843943120993;7941.682332706627;8547.57262136903;8573.828523429622;8622.439541429787;8633.352498562508;8638.308935285037;7507.399408047452;7533.1336896257635;7607.505512141693;7737.92262077372;7745.651445684845;7379.2251813558805;7463.104427468521;7463.962680186564;7585.582792946441;7626.923730762622;7173.46199035064;7260.056192694916;7287.635618218962;7290.198078211286;7303.233160518069;4869.805207791649;4963.181075122564;5062.493750624908;5114.923276150935;5161.200013997836;4914.287428322945;5075.771590278372;5094.337736094284;5105.6426050177615;5363.383210930793 10:56:16 INFO - PROCESS | 1664 | |4;prototype.html;324.12809542331127;339.32135728542914;343.92180514088335;350.93156834417283;352.3868468864177;5686.402927692595;6612.875811112111;6827.965860170699;6841.144856892888;6864.386869085767;6645.202575690924;6721.126253587039;6775.457963362932;6788;6791.62646054468;4796.5443282888245;4870.415550133989;4883.1698611236;4957.107720610306;5037.420696619881;4924.729139897304;5002.974985125069;5026.924596131061;5037.546620804127;5042.47054059324;4394.857337092347;4684.3910291662205;4955.45489996102;4982.601391888658;4993.201087825949;4761.880952976168;4881.707097574157;4881.975590122044;4886.389201349832;4887.29134275528;3735.402335626287;4159;4257.957420425818;4264.573542645741;4285.228658841407;5141.794328226866;6491.480681545512;6523.902141467835;6538.1827271591055;6540;5908.231929849092;5945.583809133363;5948.256467941507;5951.404859514014;5969.224000879858;6881.65591720412;7172.784816455514;7193.784186474414;7203.819904502377;7207.315305046012;4646.210144275481;4649.976750116228;4655.627549796008;4677.438707355105;4687.859364219079;6286.968565157145;6616.172978377703;7447.88828167578;7551.622418879034;7556.65995030225;4676.649251306166;4698.318743782201;4705.976470117627;4709;4726.810927562928;4763.285507173951;4772.809087636456;4776.832810851603;4780.378550788375;4793.544613261734;5681.352407801691;5688.146777983336;5705.4009329019855;5710.885782284414;5713.228714123623;6950.687219075053;7212.223294031835;7244.203137654854;7269.745558905519;7274.345308922222;1632.991835040841;1679.8404151605578;1683.7137686593308;1685.292177285543;1688.0631249656558;891.4829398948594;1042.3849928542197;1043.5095505112586;1068.8129577323937;1071.566015763617;6695.397414232742;6816.284290149562;6932.989433064355;6939.514234003571;6952.721891124298;7507.1742108368035;7528.284812942762;7535.434842386843;7539.359154471822;7558.848823023509;6927.618980956096;6931.514793964475;6934.306569343025;6935.514513983972;6960.129983752031;3945.033466800652;4000.739951903117;4003.7988603418858;4004.939925901114;4013.6387725104883;6382.787270418606;7659.9234007660325;7895.881561776578;7929.603519823986;7982.201779821971;7724.459287849909;7765.689372425153;7771.650275737606;7793.532388056735;7815.374770018385;5933.406659334119;7908.881366779618;7917.931079304335;7921.722739704082;7925.960370198228;7287.599182045038;7538.472306938462;7547.698092076255;7551.962240188984;7552.318926781133;7398.408127349691;7402.777916662509;7407.296306850841;7408.296211859864;7413.1104267488245;7854.842903142019;7911.28798408146;7915.05019397676;7957.045154581488;7962.960185199037;4779.593734532604;4785.521447855187;4791.712497250176;4794.065157294433;4799.832005879777;7183;7549.433792465477;7550.924490755022;7553.433492488195;7572.7728168155045;7219.2780721929485;7263.0921134858145;7269.382102521134;7302.415806735342;7323.597202153933;6143.262808463013;7035.452200515879;7253.274672532704;7261.3101755333155;7271.054762880792;7073.469489788184;7105.893411598727;7106.218315985134;7110.608916509642;7115.6086415247655;7014.859702805813;7262.527935684375;7262.891056634049;7279.708811647687;7279.927200727925;6901.068355772108;6993.370596646123;7057.294270572902;7078.009078729085;7101.11236095488 10:56:16 INFO - PROCESS | 1664 | |5;yui.html;699.64325121349;703.7677566403086;710.4210068793933;736.2306389822635;780.6292011294636;15554.066755994649;15721.37114515418;15728.370865165394;15736.29186686599;15751.921240393796;14428.20644864532;14518.854811451882;15692.607684807885;16261.430849920254;16283.185840707976;960.3469640644377;967.3132076225888;981.9607215711399;982.9557669904872;984.3454103021483;794.1304271822345;798.56079156464;965.3001573858967;988.6193815381095;988.7874107066979;1036.9222308326905;1037.9896201038007;1038.4081073787943;1040.1990467340142;1043.3270540501371;824.431142511671;1028.88682244953;1029.44924465411;1032.1536340201037;1032.8863824979246;750.3134631811886;774.6165648004218;775.0583041604422;777.0830420104274;779.3609240422855;15564.221788910509;15595.220238988119;15596.376144954189;15614.921925390414;15634;12870.262514560509;13014.34928253593;13281.867181328256;13326.466941322335;13346.599602011955;10420.635277765317;10500.842487362695;10502.212334074899;10665.733356666067;10796.406197659126;3586.103474131467;3605.339477970693;3609.9458508122398;3729.925401491982;3876.321643712339;77417.61291193508;79771.6011419945;79984;80011;80448.99999999942;7999.800004999922;9835.508224588742;9932.503374831229;10130.594776208869;10267.691969240936;23116.65325020126;23150.1897433589;23183.53632927366;23190.3042908713;23264;6753.662316884136;7557.206493318123;7612.733554325572;7630.198829122974;7652.579108148994;4130;4242.745435273893;4260.893477663021;4267.637250833652;4521.547845215518;3763.6048214937036;3831.1954489556947;3836.194399176204;3838.558565764917;3842.9231415372096;679.7213142611506;685.0683071023404;686.0463955102412;694.6144889586227;695.9547629404174;574.9712514374348;610.7312782375741;616.479075181471;617.4998251416367;651.04621729167;6590.47276217911;8328.417600655855;8378.53918034514;8448.57757112142;8612.784680382916;523.9502493943975;527.9868003299948;595.8994544231532;598.2372475094203;615.8552740106161;3906.648401643866;3951.130751234781;3980.920381592352;3990.900227494336;4028.2144981728284;89651;89898;90345.54827225822;90472;91579.08420915839;56797.71601141968;75985.6200719004;77433;78201;78834.6058269705;67526.85165304373;67562;67873;67875.32124678789;70040.6497967517;7765.611719413893;7834.590945194508;7992.120866704541;8083.757487275391;8256.215659512336;33265.168370790925;43599.78200109106;44139;44537.10925781531;45061.77469112633;58148;59491.702541487015;62280;63208.05187922277;63388.68305658442;9762.219022478042;9787.902120978699;9997.100260976547;10124.797504049731;10703.983121603434;10855.945720271347;11035.503402346752;11109.277896936674;11340.886591133984;12142.271463712206;9989.800203995734;10557.947210264207;10961;11425.571803524559;11543.538258469904;11381.260218085798;11488.655340339803;11656.794183489415;11843.46704398287;11883.58407455735;11389.772204556028;11394.886051139383;11501.82747258775;11622.70943226426;12117.394130293274;9682.806343873224;9754.31719779637;9840.852387214054;9973.501324933579;10055.597776088875;8945.865812012955;9417.576209070472;9801.607935682492;9847.95076024644;9865.210783137189 10:56:16 INFO - PROCESS | 1664 | __end_tp_report 10:56:16 INFO - PROCESS | 1664 | __start_cc_report 10:56:16 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1184 10:56:16 INFO - PROCESS | 1664 | __end_cc_report 10:56:16 INFO - PROCESS | 1664 | __startTimestamp1467741376558__endTimestamp 10:56:16 INFO - PROCESS | 1664 | 10:56:16 INFO - PROCESS | 1664 | ------- Summary: start ------- 10:56:16 INFO - PROCESS | 1664 | Number of tests: 6 10:56:16 INFO - PROCESS | 1664 | 10:56:16 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5880.54 Median:6151.45 stddev:634.28 (10.3%) stddev-sans-first:602.25 10:56:16 INFO - PROCESS | 1664 | Values: 3269.7 3603.5 3608.7 3609.3 3695.6 5926.7 5956.9 5968.0 5969.7 6025.1 5892.9 5956.2 5959.2 5965.3 5970.1 4414.4 5241.3 5286.7 5362.5 5414.5 5322.3 5367.3 5368.2 5377.2 5383.6 5328.3 5369.0 5381.0 5396.2 5398.5 5382.2 5410.5 5412.3 5431.1 5462.8 5158.7 5200.8 5312.9 5339.4 5368.5 5741.5 5750.4 5769.0 5772.2 5776.1 6252.6 6267.3 6267.9 6270.2 6298.8 6212.3 6249.0 6254.8 6277.9 6304.8 5981.5 5994.6 6014.4 6023.7 6054.9 5495.7 6399.8 6408.4 6414.8 6416.5 6163.2 6230.2 6348.9 6350.5 6352.3 6269.1 6290.7 6300.5 6301.1 6310.3 6230.6 6275.6 6288.7 6294.9 6303.6 6209.4 6234.4 6298.7 6320.9 6327.1 4985.6 5029.0 5066.4 5067.4 5082.9 4557.8 4560.3 4564.2 4572.4 4616.4 5007.3 5907.1 6033.1 6042.7 6055.1 6173.9 6199.8 6260.0 6262.5 6266.0 6107.6 6110.5 6118.9 6131.9 6133.1 5513.6 5569.9 5579.6 5586.4 5587.2 6371.7 6390.3 6484.9 6502.3 6522.5 6255.2 6287.7 6292.7 6310.2 6313.7 6488.1 6495.9 6508.8 6516.1 6527.2 6181.7 6215.0 6262.6 6281.5 6330.1 6276.5 6281.6 6286.1 6290.0 6300.8 6092.5 6278.8 6317.9 6319.5 6327.6 6120.4 6151.4 6291.3 6330.1 6334.7 6140.9 6148.9 6185.6 6190.6 6193.9 6150.1 6252.3 6312.0 6317.1 6350.2 6112.7 6241.4 6245.8 6254.7 6270.3 10:56:16 INFO - PROCESS | 1664 | 10:56:16 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:69138.10 Median:19734.02 stddev:152509.46 (772.8%) stddev-sans-first:152850.30 10:56:16 INFO - PROCESS | 1664 | Values: 534.3 544.8 554.8 580.2 605.4 31508.8 32390.7 38451.8 39311.8 39391.0 43779.3 44085.1 44087.3 44104.1 44187.3 9626.6 9816.7 9824.2 9837.0 9918.1 9173.4 9402.2 9477.6 11832.0 12077.2 11786.2 11849.0 11855.3 11856.8 11881.3 11740.1 11814.4 11818.7 11819.6 11827.4 11310.8 11424.5 11508.7 11526.9 11532.1 38471.0 38880.8 41361.4 41469.6 41492.4 3348.8 3421.0 3484.6 3513.9 3993.9 28086.4 29015.6 29027.4 29257.0 29455.6 2779.2 2798.1 2850.5 2938.0 2954.6 500959.0 504692.0 505471.0 505658.0 506824.0 38511.0 39208.0 73279.0 74552.6 74764.6 38421.0 38545.4 38685.0 38727.0 38813.8 14253.9 16104.7 16203.1 16383.5 16413.3 12896.8 13576.1 13732.5 13763.6 13763.9 8193.6 8694.2 8767.8 8816.8 8835.4 3616.8 3671.2 3679.1 3699.5 3736.1 959.7 979.8 1004.2 1039.9 1091.4 28639.1 28690.9 29224.4 29229.4 29340.6 1121.4 1167.2 1173.2 1180.5 1249.7 14903.3 14991.7 14993.5 15281.5 15481.5 638623.0 644444.0 645073.0 646962.0 647430.0 63570.7 65836.3 65896.3 65923.0 66165.7 1440.9 1452.4 1575.0 1632.2 1653.4 29138.7 29728.9 29831.0 30639.0 30666.8 54741.5 55442.7 55444.4 55527.4 55603.4 519754.0 523079.0 523985.0 525263.0 654567.0 28748.0 29216.6 29483.6 29498.6 29516.6 42795.4 44111.3 44279.0 45711.0 45949.0 30624.6 33313.7 34821.0 35954.1 36256.6 31534.0 34424.0 36275.6 37850.0 38502.8 37698.4 38228.6 38770.4 38902.6 38915.0 27014.5 33067.8 33917.5 34017.0 34109.8 21154.2 25067.1 25376.2 25525.9 26227.6 10:56:16 INFO - PROCESS | 1664 | 10:56:16 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:31773.51 Median:22344.89 stddev:78454.76 (351.1%) stddev-sans-first:78639.50 10:56:16 INFO - PROCESS | 1664 | Values: 405.3 406.6 408.6 410.9 417.4 19528.2 20241.3 20882.1 20919.8 21038.5 20520.0 20546.8 21557.2 22103.1 22118.7 5251.4 5981.1 5989.1 6070.3 6139.8 6073.7 6100.2 6109.3 6130.1 6137.4 5933.6 6035.8 6078.2 6123.4 6134.9 6074.1 6091.3 6096.4 6133.0 6145.1 5291.1 5374.9 5380.4 5384.6 5393.2 23390.8 26754.7 26895.5 27476.0 27980.9 2195.4 2289.7 2348.2 2624.3 2674.0 15508.7 15662.3 15798.3 16049.5 16438.8 1785.3 1785.4 1822.4 1845.6 1848.6 106843.0 107187.0 110719.0 112388.0 113922.0 11476.7 11709.9 11787.6 11811.9 11976.3 14802.2 14935.9 14961.0 14970.9 14985.2 9098.7 9103.2 9137.6 9141.1 9241.0 9202.7 9258.9 9262.4 9323.8 9338.9 5794.2 6971.0 6982.0 7050.4 7112.5 1813.9 1901.5 1911.5 1953.5 1976.2 935.5 975.8 988.6 997.6 1046.6 21438.0 22287.4 22402.3 22410.0 22449.9 991.5 1015.9 1065.8 1071.0 1095.1 11763.0 11937.5 11957.5 11992.7 12012.3 448377.0 462679.0 462812.0 463355.0 463472.0 128997.7 135498.0 140246.0 141308.3 146358.0 929.9 1049.5 1086.4 1099.6 1103.9 16890.5 17102.2 18181.5 18512.0 19011.3 51515.7 53741.5 54239.5 54361.5 55354.4 74841.6 78589.0 79260.4 80428.2 83339.0 6844.4 8299.5 8462.7 8548.7 8561.6 12695.4 12761.0 12771.0 12978.4 13022.3 10843.2 11251.5 11464.7 11502.5 11595.7 11101.2 11197.0 11234.0 11328.6 11472.7 11347.0 11556.2 11809.5 11860.7 11990.3 8196.5 8207.6 8285.3 8493.8 8495.7 8617.9 10847.5 11300.9 11574.6 11754.9 10:56:16 INFO - PROCESS | 1664 | 10:56:16 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5886.43 Median:2703.19 stddev:3272.40 (121.1%) stddev-sans-first:3264.56 10:56:16 INFO - PROCESS | 1664 | Values: 1445.4 1618.3 1655.5 1909.8 2028.7 8269.3 8907.6 9035.4 9041.0 9044.8 8854.2 8881.0 9002.5 9012.2 9012.2 2521.9 2547.4 2548.0 2553.1 2553.1 2494.4 2562.7 2563.8 2568.6 2571.3 2516.5 2546.6 2560.7 2563.1 2565.9 2509.8 2537.6 2552.6 2557.0 2557.8 2502.0 2522.2 2539.1 2540.9 2551.1 8736.0 9051.6 9088.5 9106.9 9127.2 5602.5 5758.0 5763.5 5768.1 5780.8 3113.3 3643.3 3739.8 3763.1 3779.3 932.4 1056.8 1073.8 1084.6 1090.9 12404.5 12542.4 12670.6 12690.7 12698.7 4849.4 4853.2 4857.8 4866.9 4912.2 9767.3 9795.5 9797.1 9797.7 9809.3 5639.1 5644.0 5647.1 5651.6 5657.4 4675.5 4789.6 5029.4 5129.6 5250.9 3987.7 4027.7 4064.4 4112.7 4130.5 1244.8 1251.4 1261.2 1275.6 1281.0 929.9 943.6 957.9 965.3 1003.2 5995.3 6067.7 6189.7 6193.8 6229.4 485.7 487.1 492.1 1045.0 1045.7 3963.0 4002.0 4025.6 4043.6 4132.8 10536.1 10901.8 11021.3 11035.0 11043.3 10864.9 10872.7 10873.6 10891.2 10946.6 8447.2 8543.3 8767.0 8845.0 8846.8 5879.6 5990.3 6025.8 6042.6 6054.6 8567.4 10197.6 10209.8 10225.2 10226.4 9689.2 10039.3 10193.4 10199.7 10382.7 7118.8 7352.8 7629.5 7802.8 7941.7 8547.6 8573.8 8622.4 8633.4 8638.3 7507.4 7533.1 7607.5 7737.9 7745.7 7379.2 7463.1 7464.0 7585.6 7626.9 7173.5 7260.1 7287.6 7290.2 7303.2 4869.8 4963.2 5062.5 5114.9 5161.2 4914.3 5075.8 5094.3 5105.6 5363.4 10:56:16 INFO - PROCESS | 1664 | 10:56:16 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5900.77 Median:6789.81 stddev:1901.52 (28.0%) stddev-sans-first:1860.21 10:56:16 INFO - PROCESS | 1664 | Values: 324.1 339.3 343.9 350.9 352.4 5686.4 6612.9 6828.0 6841.1 6864.4 6645.2 6721.1 6775.5 6788.0 6791.6 4796.5 4870.4 4883.2 4957.1 5037.4 4924.7 5003.0 5026.9 5037.5 5042.5 4394.9 4684.4 4955.5 4982.6 4993.2 4761.9 4881.7 4882.0 4886.4 4887.3 3735.4 4159.0 4258.0 4264.6 4285.2 5141.8 6491.5 6523.9 6538.2 6540.0 5908.2 5945.6 5948.3 5951.4 5969.2 6881.7 7172.8 7193.8 7203.8 7207.3 4646.2 4650.0 4655.6 4677.4 4687.9 6287.0 6616.2 7447.9 7551.6 7556.7 4676.6 4698.3 4706.0 4709.0 4726.8 4763.3 4772.8 4776.8 4780.4 4793.5 5681.4 5688.1 5705.4 5710.9 5713.2 6950.7 7212.2 7244.2 7269.7 7274.3 1633.0 1679.8 1683.7 1685.3 1688.1 891.5 1042.4 1043.5 1068.8 1071.6 6695.4 6816.3 6933.0 6939.5 6952.7 7507.2 7528.3 7535.4 7539.4 7558.8 6927.6 6931.5 6934.3 6935.5 6960.1 3945.0 4000.7 4003.8 4004.9 4013.6 6382.8 7659.9 7895.9 7929.6 7982.2 7724.5 7765.7 7771.7 7793.5 7815.4 5933.4 7908.9 7917.9 7921.7 7926.0 7287.6 7538.5 7547.7 7552.0 7552.3 7398.4 7402.8 7407.3 7408.3 7413.1 7854.8 7911.3 7915.1 7957.0 7963.0 4779.6 4785.5 4791.7 4794.1 4799.8 7183.0 7549.4 7550.9 7553.4 7572.8 7219.3 7263.1 7269.4 7302.4 7323.6 6143.3 7035.5 7253.3 7261.3 7271.1 7073.5 7105.9 7106.2 7110.6 7115.6 7014.9 7262.5 7262.9 7279.7 7279.9 6901.1 6993.4 7057.3 7078.0 7101.1 10:56:16 INFO - PROCESS | 1664 | 10:56:16 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:17771.25 Median:28686.34 stddev:24508.54 (85.4%) stddev-sans-first:24543.77 10:56:16 INFO - PROCESS | 1664 | Values: 699.6 703.8 710.4 736.2 780.6 15554.1 15721.4 15728.4 15736.3 15751.9 14428.2 14518.9 15692.6 16261.4 16283.2 960.3 967.3 982.0 983.0 984.3 794.1 798.6 965.3 988.6 988.8 1036.9 1038.0 1038.4 1040.2 1043.3 824.4 1028.9 1029.4 1032.2 1032.9 750.3 774.6 775.1 777.1 779.4 15564.2 15595.2 15596.4 15614.9 15634.0 12870.3 13014.3 13281.9 13326.5 13346.6 10420.6 10500.8 10502.2 10665.7 10796.4 3586.1 3605.3 3609.9 3729.9 3876.3 77417.6 79771.6 79984.0 80011.0 80449.0 7999.8 9835.5 9932.5 10130.6 10267.7 23116.7 23150.2 23183.5 23190.3 23264.0 6753.7 7557.2 7612.7 7630.2 7652.6 4130.0 4242.7 4260.9 4267.6 4521.5 3763.6 3831.2 3836.2 3838.6 3842.9 679.7 685.1 686.0 694.6 696.0 575.0 610.7 616.5 617.5 651.0 6590.5 8328.4 8378.5 8448.6 8612.8 524.0 528.0 595.9 598.2 615.9 3906.6 3951.1 3980.9 3990.9 4028.2 89651.0 89898.0 90345.5 90472.0 91579.1 56797.7 75985.6 77433.0 78201.0 78834.6 67526.9 67562.0 67873.0 67875.3 70040.6 7765.6 7834.6 7992.1 8083.8 8256.2 33265.2 43599.8 44139.0 44537.1 45061.8 58148.0 59491.7 62280.0 63208.1 63388.7 9762.2 9787.9 9997.1 10124.8 10704.0 10855.9 11035.5 11109.3 11340.9 12142.3 9989.8 10557.9 10961.0 11425.6 11543.5 11381.3 11488.7 11656.8 11843.5 11883.6 11389.8 11394.9 11501.8 11622.7 12117.4 9682.8 9754.3 9840.9 9973.5 10055.6 8945.9 9417.6 9801.6 9848.0 9865.2 10:56:16 INFO - PROCESS | 1664 | -------- Summary: end -------- 10:56:16 INFO - PROCESS | 1664 | 10:56:17 INFO - TEST-INFO | 1664: exit 0 10:56:17 INFO - TEST-OK | dromaeo_css | took 1113527ms 10:56:17 INFO - TEST-START | kraken 10:56:17 INFO - operating with platform_type : mac_ 10:56:17 INFO - Initialising browser for kraken test... 10:56:17 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpur3Pxb/profile http://localhost:49278/getInfo.html) 10:56:19 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 10:56:19 INFO - PROCESS | 1671 | colorDepth:24 10:56:19 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 10:56:19 INFO - PROCESS | 1671 | __metrics 10:56:19 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:56:19 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:56:19 INFO - TEST-INFO | 1671: exit 0 10:56:19 INFO - Browser initialized. 10:56:19 INFO - Running cycle 1/1 for kraken test... 10:56:19 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpur3Pxb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:56:31 INFO - PROCESS | 1674 | RSS: Main: 161636352 10:56:31 INFO - PROCESS | 1674 | 10:56:34 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 10:56:35 INFO - PROCESS | 1674 | RSS: Main: 223887360 10:56:35 INFO - PROCESS | 1674 | 10:56:37 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 10:56:38 INFO - PROCESS | 1674 | RSS: Main: 239734784 10:56:38 INFO - PROCESS | 1674 | 10:56:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 10:56:42 INFO - PROCESS | 1674 | RSS: Main: 323850240 10:56:42 INFO - PROCESS | 1674 | 10:56:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 10:56:45 INFO - PROCESS | 1674 | RSS: Main: 231624704 10:56:45 INFO - PROCESS | 1674 | 10:56:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:56:47 INFO - PROCESS | 1674 | RSS: Main: 231997440 10:56:47 INFO - PROCESS | 1674 | 10:56:50 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 10:56:51 INFO - PROCESS | 1674 | RSS: Main: 269991936 10:56:51 INFO - PROCESS | 1674 | 10:56:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 10:56:54 INFO - PROCESS | 1674 | RSS: Main: 270495744 10:56:54 INFO - PROCESS | 1674 | 10:56:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 10:56:58 INFO - PROCESS | 1674 | RSS: Main: 268677120 10:56:58 INFO - PROCESS | 1674 | 10:56:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:57:00 INFO - PROCESS | 1674 | RSS: Main: 260669440 10:57:00 INFO - PROCESS | 1674 | 10:57:02 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:57:02 INFO - PROCESS | 1674 | RSS: Main: 268152832 10:57:02 INFO - PROCESS | 1674 | 10:57:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:57:05 INFO - PROCESS | 1674 | RSS: Main: 271032320 10:57:05 INFO - PROCESS | 1674 | 10:57:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:57:09 INFO - PROCESS | 1674 | RSS: Main: 278228992 10:57:09 INFO - PROCESS | 1674 | 10:57:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:57:12 INFO - PROCESS | 1674 | RSS: Main: 275099648 10:57:12 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 10:57:14 INFO - PROCESS | 1674 | RSS: Main: 336441344 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | __start_tp_report 10:57:14 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 10:57:14 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 10:57:14 INFO - PROCESS | 1674 | |i|pagename|runs| 10:57:14 INFO - PROCESS | 1674 | |0;ai-astar;113;113;122;113;116;159;166;113;112;134 10:57:14 INFO - PROCESS | 1674 | |1;audio-beat-detection;155;119;142;162;118;165;134;117;164;117 10:57:14 INFO - PROCESS | 1674 | |2;audio-dft;184;185;184;184;185;191;263;205;186;183 10:57:14 INFO - PROCESS | 1674 | |3;audio-fft;69;82;74;150;56;56;57;64;135;55 10:57:14 INFO - PROCESS | 1674 | |4;audio-oscillator;90;89;147;79;78;79;126;78;79;125 10:57:14 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;88;85;87;86;88;85;89;86;88;85 10:57:14 INFO - PROCESS | 1674 | |6;imaging-darkroom;137;119;93;105;149;117;93;92;93;91 10:57:14 INFO - PROCESS | 1674 | |7;imaging-desaturate;87;84;85;84;86;85;84;85;85;86 10:57:14 INFO - PROCESS | 1674 | |8;json-parse-financial;57;62;62;61;61;62;62;77;59;55 10:57:14 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;61;63;65;75;79;103;94;93;77;67 10:57:14 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;83;80;79;80;81;77;79;79;80;84 10:57:14 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;127;127;127;144;138;128;126;138;169;166 10:57:14 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;164;163;159;161;162;165;159;159;161;161 10:57:14 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;65;66;66;68;65 10:57:14 INFO - PROCESS | 1674 | __end_tp_report 10:57:14 INFO - PROCESS | 1674 | __start_cc_report 10:57:14 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1971 10:57:14 INFO - PROCESS | 1674 | __end_cc_report 10:57:14 INFO - PROCESS | 1674 | __startTimestamp1467741434405__endTimestamp 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | ------- Summary: start ------- 10:57:14 INFO - PROCESS | 1674 | Number of tests: 14 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:126.10 Median:119.00 stddev:20.39 (17.1%) stddev-sans-first:21.07 10:57:14 INFO - PROCESS | 1674 | Values: 113.0 113.0 122.0 113.0 116.0 159.0 166.0 113.0 112.0 134.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:148.50 stddev:20.89 (14.1%) stddev-sans-first:21.37 10:57:14 INFO - PROCESS | 1674 | Values: 155.0 119.0 142.0 162.0 118.0 165.0 134.0 117.0 164.0 117.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:195.00 Median:185.50 stddev:24.78 (13.4%) stddev-sans-first:25.97 10:57:14 INFO - PROCESS | 1674 | Values: 184.0 185.0 184.0 184.0 185.0 191.0 263.0 205.0 186.0 183.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:79.80 Median:60.50 stddev:34.40 (56.9%) stddev-sans-first:36.26 10:57:14 INFO - PROCESS | 1674 | Values: 69.0 82.0 74.0 150.0 56.0 56.0 57.0 64.0 135.0 55.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:79.00 stddev:25.67 (32.5%) stddev-sans-first:27.11 10:57:14 INFO - PROCESS | 1674 | Values: 90.0 89.0 147.0 79.0 78.0 79.0 126.0 78.0 79.0 125.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:87.50 stddev:1.49 (1.7%) stddev-sans-first:1.51 10:57:14 INFO - PROCESS | 1674 | Values: 88.0 85.0 87.0 86.0 88.0 85.0 89.0 86.0 88.0 85.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:108.90 Median:91.50 stddev:20.94 (22.9%) stddev-sans-first:19.58 10:57:14 INFO - PROCESS | 1674 | Values: 137.0 119.0 93.0 105.0 149.0 117.0 93.0 92.0 93.0 91.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.99 (1.2%) stddev-sans-first:0.78 10:57:14 INFO - PROCESS | 1674 | Values: 87.0 84.0 85.0 84.0 86.0 85.0 84.0 85.0 85.0 86.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:5.87 (9.5%) stddev-sans-first:5.96 10:57:14 INFO - PROCESS | 1674 | Values: 57.0 62.0 62.0 61.0 61.0 62.0 62.0 77.0 59.0 55.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:76.00 stddev:14.61 (19.2%) stddev-sans-first:14.19 10:57:14 INFO - PROCESS | 1674 | Values: 61.0 63.0 65.0 75.0 79.0 103.0 94.0 93.0 77.0 67.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:2.04 (2.6%) stddev-sans-first:1.90 10:57:14 INFO - PROCESS | 1674 | Values: 83.0 80.0 79.0 80.0 81.0 77.0 79.0 79.0 80.0 84.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:138.00 stddev:16.25 (11.8%) stddev-sans-first:16.65 10:57:14 INFO - PROCESS | 1674 | Values: 127.0 127.0 127.0 144.0 138.0 128.0 126.0 138.0 169.0 166.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.50 stddev:2.12 (1.3%) stddev-sans-first:2.03 10:57:14 INFO - PROCESS | 1674 | Values: 164.0 163.0 159.0 161.0 162.0 165.0 159.0 159.0 161.0 161.0 10:57:14 INFO - PROCESS | 1674 | 10:57:14 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 10:57:14 INFO - PROCESS | 1674 | Values: 67.0 67.0 67.0 67.0 67.0 65.0 66.0 66.0 68.0 65.0 10:57:14 INFO - PROCESS | 1674 | -------- Summary: end -------- 10:57:14 INFO - PROCESS | 1674 | 10:57:15 INFO - TEST-INFO | 1674: exit 0 10:57:15 INFO - TEST-OK | kraken | took 58044ms 10:57:15 INFO - SUITE-END | took 1171s 10:57:15 INFO - Completed test suite (00:19:31) 10:57:15 INFO - javascript benchmark 10:57:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3269.7384209263255, 3603.549556305462, 3608.65717756813, 3609.3322735293973, 3695.5750088739787, 5926.703664816763, 5956.851078723023, 5967.9738040092625, 5969.7313620887, 6025.126356678279, 5892.880352732977, 5956.225690660208, 5959.225300710901, 5965.313988891279, 5970.134330522083, 4414.381986521889, 5241.292425522543, 5286.735663216843, 5362.544183744387, 5414.539764120054, 5322.308099947001, 5367.275417818603, 5368.194770784394, 5377.220303056055, 5383.596230282725, 5328.254044433782, 5368.979893820181, 5380.973095134519, 5396.163594642837, 5398.4871437213405, 5382.165764306539, 5410.48600382963, 5412.323459567554, 5431.076716958087, 5462.754176062087, 5158.716270605115, 5200.843974680728, 5312.946870531323, 5339.385970613391, 5368.543673787733, 5741.511971482429, 5750.424957504216, 5768.990426675315, 5772.220750198711, 5776.075827867521, 6252.559454249428, 6267.341929097424, 6267.905981410283, 6270.247570291549, 6298.842528936768, 6212.347703491114, 6249.0, 6254.781082662085, 6277.937220627827, 6304.842378940517, 5981.491573216282, 5994.580379373402, 6014.3985601439945, 6023.668698221596, 6054.939450605526, 5495.681036551199, 6399.8080057598345, 6408.423241908251, 6414.807555773335, 6416.518761092843, 6163.229596300463, 6230.190075290183, 6348.904766428507, 6350.491960643138, 6352.301246862841, 6269.059641053878, 6290.654014029181, 6300.495960323163, 6301.117843501914, 6310.274318453345, 6230.56386052981, 6275.623462592259, 6288.654124023131, 6294.874102517924, 6303.558750887394, 6209.441150296495, 6234.407731265523, 6298.653574053379, 6320.873582528324, 6327.145835312266, 4985.626078044089, 5028.974855125774, 5066.417362003343, 5067.366579177603, 5082.898342033139, 4557.817687292471, 4560.270356742905, 4564.1556312082375, 4572.4055872737, 4616.422947131608, 5007.3240112584335, 5907.1434641976675, 6033.095035744585, 6042.6978651067275, 6055.091736239511, 6173.938260617426, 6199.752009919643, 6260.0, 6262.53031022666, 6266.0, 6107.603005804697, 6110.511159107261, 6118.938810611926, 6131.877362452815, 6133.1413602095745, 5513.58648101394, 5569.888602227933, 5579.637323574036, 5586.413426590231, 5587.161925711094, 6371.681415929185, 6390.265119511129, 6484.902726459012, 6502.349765023459, 6522.510811689142, 6255.155554000152, 6287.685615719287, 6292.748290068529, 6310.1796766420075, 6313.747450101944, 6488.059231411513, 6495.870082598416, 6508.837279068061, 6516.087747715418, 6527.184101987252, 6181.660008699565, 6215.0, 6262.624242545462, 6281.52888533371, 6330.050492426173, 6276.529260305404, 6281.560290779602, 6286.119943208046, 6290.0, 6300.842478938063, 6092.512598992159, 6278.780242691484, 6317.9052314214405, 6319.526035547445, 6327.557071004985, 6120.447133218705, 6151.446369826737, 6291.339409361951, 6330.082138090043, 6334.6832658365975, 6140.938590614037, 6148.907766383597, 6185.597936134137, 6190.628562286097, 6193.938060619336, 6150.077488376779, 6252.280987686292, 6311.96844015777, 6317.084022816574, 6350.206224221973, 6112.65546444155, 6241.438270555672, 6245.843853903689, 6254.749810007549, 6270.341614130451], "value": 5841.81573321157, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.2840593604569, 544.771196097639, 554.7891801115577, 580.2311936683894, 605.3946053946054, 31508.842455787748, 32390.67609323906, 38451.80774096129, 39311.80344098275, 39391.015224619325, 43779.3433098503, 44085.11829763403, 44087.33868991968, 44104.117917641626, 44187.337189942176, 9626.566804493814, 9816.70549883501, 9824.1649459796, 9837.0, 9918.05778451046, 9173.44959302444, 9402.247820174369, 9477.620895164186, 11832.0, 12077.15459917806, 11786.17496775226, 11849.0, 11855.288682679024, 11856.822147667792, 11881.34652594107, 11740.060795136369, 11814.350210738407, 11818.704532386673, 11819.645410637695, 11827.408629568487, 11310.773784524346, 11424.485898134604, 11508.712282192928, 11526.94236528812, 11532.077433805276, 38471.0, 38880.833574992794, 41361.37957930633, 41469.58530414718, 41492.37761433581, 3348.7990720556845, 3421.0250078727445, 3484.6341134181052, 3513.929721405583, 3993.880183594497, 28086.438271234667, 29015.564766528307, 29027.419451611062, 29257.0, 29455.558166627517, 2779.207925741174, 2798.0626490125833, 2850.458412901542, 2937.985310073457, 2954.571587119877, 500959.0, 504692.0, 505471.0, 505658.0, 506824.0, 38511.0, 39208.019799505244, 73279.0, 74552.62723686347, 74764.62617686877, 38421.03947401282, 38545.421818672745, 38685.0, 38727.0, 38813.805930970164, 14253.928730356489, 16104.677906441806, 16203.108829014518, 16383.508494745176, 16413.343466261216, 12896.80654790179, 13576.117552359065, 13732.519361822287, 13763.587092387244, 13763.931180344234, 8193.59032048407, 8694.217520423066, 8767.780805479913, 8816.779580510538, 8835.425697329652, 3616.8191590420374, 3671.210689701727, 3679.1354031802507, 3699.463577781207, 3736.1406876418578, 959.7312752429331, 979.7893452907659, 1004.2116938203475, 1039.927205095636, 1091.4379094766202, 28639.053254437953, 28690.85654571714, 29224.415511689647, 29229.415411691647, 29340.559891601642, 1121.394446998628, 1167.1888037813808, 1173.2139466557428, 1180.4982882274999, 1249.656619134434, 14903.329350179269, 14991.700165996619, 14993.475228366955, 15281.541553753405, 15481.458148964957, 638623.0, 644444.0, 645073.0, 646962.0, 647430.0, 63570.6821465899, 65836.34163658398, 65896.34103658902, 65923.0, 66165.6691716548, 1440.9351579178963, 1452.375478544215, 1574.999875079356, 1632.183908045977, 1653.3551914753257, 29138.7086129136, 29728.85135574308, 29831.0, 30639.0, 30666.846665766527, 54741.45258547523, 55442.72278638581, 55444.44555554393, 55527.444725552225, 55603.443965559825, 519754.0, 523079.0, 523985.0, 525263.0, 654567.0, 28748.0, 29216.561751573317, 29483.55774663339, 29498.55752163762, 29516.557251641672, 42795.358069629605, 44111.33832992572, 44279.0, 45711.0, 45949.0, 30624.62189201536, 33313.666863331055, 34821.0, 35954.10114747048, 36256.63743362533, 31534.0, 34424.0, 36275.63724362723, 37850.0, 38502.80748596239, 37698.43452348272, 38228.6177138225, 38770.4184437228, 38902.610973889896, 38915.0, 27014.459710806066, 33067.8346608275, 33917.49123763195, 34017.0, 34109.82945085259, 21154.15383384709, 25067.122650707137, 25376.238712838644, 25525.851336690266, 26227.606585900845], "value": 19369.382730653935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.3312035142013, 406.6299667302753, 408.5607971430713, 410.9280875846726, 417.3660120627741, 19528.21887124513, 20241.291554795585, 20882.060307286152, 20919.790802091975, 21038.474038149056, 20520.0, 20546.76719396837, 21557.245496407628, 22103.115875365005, 22118.668219976713, 5251.369835619731, 5981.1028345748055, 5989.1016347548, 6070.301915279755, 6139.7851075212375, 6073.665948372838, 6100.23747031621, 6109.297430795449, 6130.141780150782, 6137.447629713325, 5933.584649074566, 6035.849103772397, 6078.20983272174, 6123.387661233885, 6134.9079763803575, 6074.119252708355, 6091.299500557426, 6096.39036096389, 6133.049377346519, 6145.108959200936, 5291.100512912775, 5374.871277031828, 5380.435054319319, 5384.623076384615, 5393.2449457076045, 23390.76609233903, 26754.732452675613, 26895.462090758076, 27476.0, 27980.860095699594, 2195.3852921182092, 2289.702338695959, 2348.213348528245, 2624.2914413108547, 2674.0368977180997, 15508.689826203412, 15662.295196716175, 15798.289076991563, 16049.518514444586, 16438.83561164385, 1785.2501949181376, 1785.419738584965, 1822.3844764984879, 1845.6401001804654, 1848.574827789616, 106843.0, 107187.0, 110719.0, 112388.0, 113922.0, 11476.655700329004, 11709.941450292694, 11787.646370608896, 11811.88188118125, 11976.341301228342, 14802.185879776716, 14935.850641493445, 14961.0, 14970.850291496945, 14985.175815330262, 9098.727038188865, 9103.180713735796, 9137.588808503633, 9141.080373121586, 9241.02969188239, 9202.677906273382, 9258.90741092594, 9262.44425334482, 9323.813523729623, 9338.859917101248, 5794.21778059965, 6971.0, 6982.022516847645, 7050.365467107985, 7112.50212485121, 1813.8548916086945, 1901.5341241395947, 1911.4934542346289, 1953.5311525234126, 1976.1700085963641, 935.5462600638684, 975.8048390321964, 988.5502096546054, 997.5710444508786, 1046.581367453025, 21438.0, 22287.442813929458, 22402.327930162122, 22410.0, 22449.88775056114, 991.494337887668, 1015.8527013582989, 1065.8454524093963, 1070.9732256693644, 1095.0746619106842, 11763.0, 11937.462814173383, 11957.52169913211, 11992.700182495508, 12012.339321337411, 448377.0, 462679.0, 462812.0, 463355.0, 463472.0, 128997.71002290044, 135498.0, 140246.0, 141308.2934585341, 146358.0, 929.8558723397884, 1049.5486940615608, 1086.4241951765578, 1099.571167244775, 1103.8840921703265, 16890.493285201464, 17102.230399632295, 18181.54671550666, 18512.0, 19011.33460328882, 51515.74242128765, 53741.46258537521, 54239.45760542344, 54361.45638543564, 55354.446455534926, 74841.62579187287, 78589.0, 79260.41479170269, 80428.19571804442, 83339.0, 6844.4182244509775, 8299.543525106177, 8462.661493540189, 8548.700795472128, 8561.57192140403, 12695.36523173856, 12761.0, 12771.042171836963, 12978.415971281127, 13022.348882556023, 10843.24097313212, 11251.549938002388, 11464.713382165179, 11502.48238829238, 11595.710107247387, 11101.222914396238, 11197.048250898764, 11234.0, 11328.60349887783, 11472.65582032507, 11347.0, 11556.248843825124, 11809.468573914366, 11860.703482412664, 11990.340531270864, 8196.54918979462, 8207.630656620586, 8285.337173026264, 8493.830123397374, 8495.702650407206, 8617.870731938901, 10847.45762711877, 11300.94349528247, 11574.594889178838, 11754.941225293818], "value": 10004.212912112856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.4218312674934, 1618.2636900210405, 1655.5033489953012, 1909.7994710555392, 2028.6551286281322, 8269.25576698097, 8907.554622268884, 9035.412698174614, 9040.954795226024, 9044.77388065297, 8854.247388971946, 8880.955595222014, 9002.549872506364, 9012.188902998729, 9012.233960113399, 2521.9369515762114, 2547.439563296072, 2547.9935425506915, 2553.080890879282, 2553.0808908792915, 2494.3514686181634, 2562.6668533090674, 2563.8205325627214, 2568.614707793827, 2571.2671888511777, 2516.534441128388, 2546.637548911333, 2560.667113275281, 2563.051670881767, 2565.8973641054336, 2509.77412032917, 2537.581299085658, 2552.5660637691544, 2556.974430255711, 2557.8465292082533, 2502.036715864387, 2522.167684664075, 2539.149384956042, 2540.911068112607, 2551.094361501677, 8736.0, 9051.637934482613, 9088.545572721338, 9106.908930910673, 9127.178553930178, 5602.495775380195, 5758.0, 5763.5101016413655, 5768.077107662796, 5780.7687692492245, 3113.3306339137193, 3643.28955853606, 3739.7943113128767, 3763.078045878777, 3779.338615742234, 932.4172392254841, 1056.7727938493183, 1073.8281874900056, 1084.6312253833735, 1090.8527348807968, 12404.503819847196, 12542.435590398454, 12670.55653052148, 12690.682732931658, 12698.682532936658, 4849.369581954324, 4853.247746599212, 4857.757112144379, 4866.8783280417565, 4912.238603016538, 9767.316287859923, 9795.461249631338, 9797.118259356692, 9797.657082002095, 9809.313348065567, 5639.0977443609645, 5644.0, 5647.068233741386, 5651.57613179005, 5657.405972372924, 4675.462321832964, 4789.640776941744, 5029.396472423259, 5129.615278854101, 5250.868728281824, 3987.6610488108836, 4027.657649099801, 4064.4106604542176, 4112.691548133902, 4130.545639979599, 1244.7821631214683, 1251.355551890777, 1261.1550261324935, 1275.5854347337151, 1280.9743805123846, 929.8791157149662, 943.5706753427174, 957.8563215517589, 965.2567523007245, 1003.1874181912674, 5995.280566332068, 6067.696615169312, 6189.669221117481, 6193.783217587363, 6229.3770622937345, 485.73041961710885, 487.1256095308858, 492.0970020013244, 1044.9895501045044, 1045.7072019834459, 3963.0, 4002.0, 4025.5571887092397, 4043.5754245804355, 4132.752034877857, 10536.10443112344, 10901.781964360827, 11021.338719676845, 11035.0, 11043.282186657842, 10864.891351086388, 10872.67381978542, 10873.565057397775, 10891.183161262938, 10946.616868409568, 8447.155284471504, 8543.273821725223, 8766.99179594342, 8845.0, 8846.77883052916, 5879.559033072451, 5990.251218597676, 6025.758969641341, 6042.577019608585, 6054.606450580698, 8567.4002819802, 10197.592096316064, 10209.795804084026, 10225.233107517115, 10226.437545935045, 9689.224862011164, 10039.29724919278, 10193.43936083493, 10199.694009179737, 10382.688519344432, 7118.750843720445, 7352.77941661751, 7629.465937384552, 7802.843943120993, 7941.682332706627, 8547.57262136903, 8573.828523429622, 8622.439541429787, 8633.352498562508, 8638.308935285037, 7507.399408047452, 7533.1336896257635, 7607.505512141693, 7737.92262077372, 7745.651445684845, 7379.2251813558805, 7463.104427468521, 7463.962680186564, 7585.582792946441, 7626.923730762622, 7173.46199035064, 7260.056192694916, 7287.635618218962, 7290.198078211286, 7303.233160518069, 4869.805207791649, 4963.181075122564, 5062.493750624908, 5114.923276150935, 5161.200013997836, 4914.287428322945, 5075.771590278372, 5094.337736094284, 5105.6426050177615, 5363.383210930793], "value": 4718.691017882657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.12809542331127, 339.32135728542914, 343.92180514088335, 350.93156834417283, 352.3868468864177, 5686.402927692595, 6612.875811112111, 6827.965860170699, 6841.144856892888, 6864.386869085767, 6645.202575690924, 6721.126253587039, 6775.457963362932, 6788.0, 6791.62646054468, 4796.5443282888245, 4870.415550133989, 4883.1698611236, 4957.107720610306, 5037.420696619881, 4924.729139897304, 5002.974985125069, 5026.924596131061, 5037.546620804127, 5042.47054059324, 4394.857337092347, 4684.3910291662205, 4955.45489996102, 4982.601391888658, 4993.201087825949, 4761.880952976168, 4881.707097574157, 4881.975590122044, 4886.389201349832, 4887.29134275528, 3735.402335626287, 4159.0, 4257.957420425818, 4264.573542645741, 4285.228658841407, 5141.794328226866, 6491.480681545512, 6523.902141467835, 6538.1827271591055, 6540.0, 5908.231929849092, 5945.583809133363, 5948.256467941507, 5951.404859514014, 5969.224000879858, 6881.65591720412, 7172.784816455514, 7193.784186474414, 7203.819904502377, 7207.315305046012, 4646.210144275481, 4649.976750116228, 4655.627549796008, 4677.438707355105, 4687.859364219079, 6286.968565157145, 6616.172978377703, 7447.88828167578, 7551.622418879034, 7556.65995030225, 4676.649251306166, 4698.318743782201, 4705.976470117627, 4709.0, 4726.810927562928, 4763.285507173951, 4772.809087636456, 4776.832810851603, 4780.378550788375, 4793.544613261734, 5681.352407801691, 5688.146777983336, 5705.4009329019855, 5710.885782284414, 5713.228714123623, 6950.687219075053, 7212.223294031835, 7244.203137654854, 7269.745558905519, 7274.345308922222, 1632.991835040841, 1679.8404151605578, 1683.7137686593308, 1685.292177285543, 1688.0631249656558, 891.4829398948594, 1042.3849928542197, 1043.5095505112586, 1068.8129577323937, 1071.566015763617, 6695.397414232742, 6816.284290149562, 6932.989433064355, 6939.514234003571, 6952.721891124298, 7507.1742108368035, 7528.284812942762, 7535.434842386843, 7539.359154471822, 7558.848823023509, 6927.618980956096, 6931.514793964475, 6934.306569343025, 6935.514513983972, 6960.129983752031, 3945.033466800652, 4000.739951903117, 4003.7988603418858, 4004.939925901114, 4013.6387725104883, 6382.787270418606, 7659.9234007660325, 7895.881561776578, 7929.603519823986, 7982.201779821971, 7724.459287849909, 7765.689372425153, 7771.650275737606, 7793.532388056735, 7815.374770018385, 5933.406659334119, 7908.881366779618, 7917.931079304335, 7921.722739704082, 7925.960370198228, 7287.599182045038, 7538.472306938462, 7547.698092076255, 7551.962240188984, 7552.318926781133, 7398.408127349691, 7402.777916662509, 7407.296306850841, 7408.296211859864, 7413.1104267488245, 7854.842903142019, 7911.28798408146, 7915.05019397676, 7957.045154581488, 7962.960185199037, 4779.593734532604, 4785.521447855187, 4791.712497250176, 4794.065157294433, 4799.832005879777, 7183.0, 7549.433792465477, 7550.924490755022, 7553.433492488195, 7572.7728168155045, 7219.2780721929485, 7263.0921134858145, 7269.382102521134, 7302.415806735342, 7323.597202153933, 6143.262808463013, 7035.452200515879, 7253.274672532704, 7261.3101755333155, 7271.054762880792, 7073.469489788184, 7105.893411598727, 7106.218315985134, 7110.608916509642, 7115.6086415247655, 7014.859702805813, 7262.527935684375, 7262.891056634049, 7279.708811647687, 7279.927200727925, 6901.068355772108, 6993.370596646123, 7057.294270572902, 7078.009078729085, 7101.11236095488], "value": 5261.895152682959, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.64325121349, 703.7677566403086, 710.4210068793933, 736.2306389822635, 780.6292011294636, 15554.066755994649, 15721.37114515418, 15728.370865165394, 15736.29186686599, 15751.921240393796, 14428.20644864532, 14518.854811451882, 15692.607684807885, 16261.430849920254, 16283.185840707976, 960.3469640644377, 967.3132076225888, 981.9607215711399, 982.9557669904872, 984.3454103021483, 794.1304271822345, 798.56079156464, 965.3001573858967, 988.6193815381095, 988.7874107066979, 1036.9222308326905, 1037.9896201038007, 1038.4081073787943, 1040.1990467340142, 1043.3270540501371, 824.431142511671, 1028.88682244953, 1029.44924465411, 1032.1536340201037, 1032.8863824979246, 750.3134631811886, 774.6165648004218, 775.0583041604422, 777.0830420104274, 779.3609240422855, 15564.221788910509, 15595.220238988119, 15596.376144954189, 15614.921925390414, 15634.0, 12870.262514560509, 13014.34928253593, 13281.867181328256, 13326.466941322335, 13346.599602011955, 10420.635277765317, 10500.842487362695, 10502.212334074899, 10665.733356666067, 10796.406197659126, 3586.103474131467, 3605.339477970693, 3609.9458508122398, 3729.925401491982, 3876.321643712339, 77417.61291193508, 79771.6011419945, 79984.0, 80011.0, 80448.99999999942, 7999.800004999922, 9835.508224588742, 9932.503374831229, 10130.594776208869, 10267.691969240936, 23116.65325020126, 23150.1897433589, 23183.53632927366, 23190.3042908713, 23264.0, 6753.662316884136, 7557.206493318123, 7612.733554325572, 7630.198829122974, 7652.579108148994, 4130.0, 4242.745435273893, 4260.893477663021, 4267.637250833652, 4521.547845215518, 3763.6048214937036, 3831.1954489556947, 3836.194399176204, 3838.558565764917, 3842.9231415372096, 679.7213142611506, 685.0683071023404, 686.0463955102412, 694.6144889586227, 695.9547629404174, 574.9712514374348, 610.7312782375741, 616.479075181471, 617.4998251416367, 651.04621729167, 6590.47276217911, 8328.417600655855, 8378.53918034514, 8448.57757112142, 8612.784680382916, 523.9502493943975, 527.9868003299948, 595.8994544231532, 598.2372475094203, 615.8552740106161, 3906.648401643866, 3951.130751234781, 3980.920381592352, 3990.900227494336, 4028.2144981728284, 89651.0, 89898.0, 90345.54827225822, 90472.0, 91579.08420915839, 56797.71601141968, 75985.6200719004, 77433.0, 78201.0, 78834.6058269705, 67526.85165304373, 67562.0, 67873.0, 67875.32124678789, 70040.6497967517, 7765.611719413893, 7834.590945194508, 7992.120866704541, 8083.757487275391, 8256.215659512336, 33265.168370790925, 43599.78200109106, 44139.0, 44537.10925781531, 45061.77469112633, 58148.0, 59491.702541487015, 62280.0, 63208.05187922277, 63388.68305658442, 9762.219022478042, 9787.902120978699, 9997.100260976547, 10124.797504049731, 10703.983121603434, 10855.945720271347, 11035.503402346752, 11109.277896936674, 11340.886591133984, 12142.271463712206, 9989.800203995734, 10557.947210264207, 10961.0, 11425.571803524559, 11543.538258469904, 11381.260218085798, 11488.655340339803, 11656.794183489415, 11843.46704398287, 11883.58407455735, 11389.772204556028, 11394.886051139383, 11501.82747258775, 11622.70943226426, 12117.394130293274, 9682.806343873224, 9754.31719779637, 9840.852387214054, 9973.501324933579, 10055.597776088875, 8945.865812012955, 9417.576209070472, 9801.607935682492, 9847.95076024644, 9865.210783137189], "value": 6986.488144619564, "unit": "score"}], "name": "dromaeo_css", "value": 7624.020508579114, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 122.0, 113.0, 116.0, 159.0, 166.0, 113.0, 112.0, 134.0], "value": 126.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 119.0, 142.0, 162.0, 118.0, 165.0, 134.0, 117.0, 164.0, 117.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 184.0, 185.0, 191.0, 263.0, 205.0, 186.0, 183.0], "value": 195.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 74.0, 150.0, 56.0, 56.0, 57.0, 64.0, 135.0, 55.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 147.0, 79.0, 78.0, 79.0, 126.0, 78.0, 79.0, 125.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 86.0, 88.0, 85.0, 89.0, 86.0, 88.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 119.0, 93.0, 105.0, 149.0, 117.0, 93.0, 92.0, 93.0, 91.0], "value": 108.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 84.0, 86.0, 85.0, 84.0, 85.0, 85.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 77.0, 59.0, 55.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 65.0, 75.0, 79.0, 103.0, 94.0, 93.0, 77.0, 67.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 79.0, 80.0, 81.0, 77.0, 79.0, 79.0, 80.0, 84.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 144.0, 138.0, 128.0, 126.0, 138.0, 169.0, 166.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 159.0, 161.0, 162.0, 165.0, 159.0, 159.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 65.0, 66.0, 66.0, 68.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1504.5, "alertThreshold": 2.0}]} 10:57:15 INFO - Return code: 0 10:57:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:57:15 ERROR - # TBPL SUCCESS # 10:57:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:57:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:57:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:57:15 INFO - 2016-07-05 10:57:15.694 screenresolution[1678:9802] starting screenresolution argv=screenresolution get 10:57:15 INFO - 2016-07-05 10:57:15.696 screenresolution[1678:9802] Display 0: 1600x1200x32@60 10:57:15 INFO - 2016-07-05 10:57:15.702 screenresolution[1679:9805] starting screenresolution argv=screenresolution list 10:57:15 INFO - Available Modes on Display 0 10:57:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:57:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:57:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:57:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:57:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:57:15 INFO - Intel Iris: 10:57:15 INFO - Chipset Model: Intel Iris 10:57:15 INFO - Type: GPU 10:57:15 INFO - Bus: Built-In 10:57:15 INFO - VRAM (Dynamic, Max): 1536 MB 10:57:15 INFO - Vendor: Intel (0x8086) 10:57:15 INFO - Device ID: 0x0a2e 10:57:15 INFO - Revision ID: 0x0009 10:57:15 INFO - Displays: 10:57:15 INFO - Display: 10:57:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:57:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:57:15 INFO - Display Serial Number: 1600x1200 60 10:57:15 INFO - Main Display: Yes 10:57:15 INFO - Mirror: Off 10:57:15 INFO - Online: Yes 10:57:15 INFO - Rotation: Supported 10:57:15 INFO - Return code: 0 10:57:15 INFO - Running post-action listener: _resource_record_post_action 10:57:15 INFO - Running post-run listener: _resource_record_post_run 10:57:16 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 36779520; Write bytes: 494946816; Read time: 243; Write time: 1553 10:57:16 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191382016; Write bytes: 187066368; Read time: 17499; Write time: 425 10:57:17 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 34948608; Write bytes: 297087488; Read time: 226; Write time: 1098 10:57:17 INFO - Running post-run listener: _upload_blobber_files 10:57:17 INFO - Blob upload gear active. 10:57:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:57:17 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 10:57:17 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:57:17 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:57:17 INFO - (blobuploader) - INFO - Open directory for files ... 10:57:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:57:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:57:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:18 INFO - (blobuploader) - INFO - Done attempting. 10:57:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:57:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:57:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:19 INFO - (blobuploader) - INFO - Done attempting. 10:57:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:57:19 INFO - Return code: 0 10:57:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:57:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:57:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26030ed7b0f398c495a94e8fea37474b2e64c3cb0386533d82b9c7255dad0ae42f0d7607b3f68f5bc180985307ce75273c78ba49fd83990406af3733dd416bce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51da54cbf95356b4ec505b2137d3cb8995b4c78f32c9a07b13253f2fc02a4d94d37b469430ea39ab5e3cf4bc59fa59d261bea322f2164b957dfa6c1d8cc5aaba"} 10:57:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:57:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:57:19 INFO - Contents: 10:57:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26030ed7b0f398c495a94e8fea37474b2e64c3cb0386533d82b9c7255dad0ae42f0d7607b3f68f5bc180985307ce75273c78ba49fd83990406af3733dd416bce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51da54cbf95356b4ec505b2137d3cb8995b4c78f32c9a07b13253f2fc02a4d94d37b469430ea39ab5e3cf4bc59fa59d261bea322f2164b957dfa6c1d8cc5aaba"} 10:57:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:57:19 INFO - Copying logs to upload dir... 10:57:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:57:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.646457 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-05 10:57:19.616986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:19.620311) ========= 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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26030ed7b0f398c495a94e8fea37474b2e64c3cb0386533d82b9c7255dad0ae42f0d7607b3f68f5bc180985307ce75273c78ba49fd83990406af3733dd416bce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51da54cbf95356b4ec505b2137d3cb8995b4c78f32c9a07b13253f2fc02a4d94d37b469430ea39ab5e3cf4bc59fa59d261bea322f2164b957dfa6c1d8cc5aaba"} build_url:https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/AhB73YPzTUm8PAS2wnndbA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26030ed7b0f398c495a94e8fea37474b2e64c3cb0386533d82b9c7255dad0ae42f0d7607b3f68f5bc180985307ce75273c78ba49fd83990406af3733dd416bce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/51da54cbf95356b4ec505b2137d3cb8995b4c78f32c9a07b13253f2fc02a4d94d37b469430ea39ab5e3cf4bc59fa59d261bea322f2164b957dfa6c1d8cc5aaba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:19.654279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:19.654670) ========= 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.usUdU2zOlC/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.kM5R1MbmNQ/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.005189 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:57:19.704396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:57:19.704784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:57:19.705171) ========= ========= Total master_lag: 0.18 =========