builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0340 starttime: 1470390478.94 results: success (0) buildid: 20160805001722 builduid: 89ee8aee582644f29f9c8f14d44b12c3 revision: a32b3e3c6b34d28e5e1d4f484f0fa6ef74a458cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 02:47:58.937417) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 02:47:58.937901) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 02:47:58.938180) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 02:47:59.122075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:47:59.122326) ========= 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.bBrV56WvhS/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.z4N4EGIpqw/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-08-05 02:47:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.31M=0.001s 2016-08-05 02:47:59 (8.31 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.464076 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:47:59.642940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:47:59.643273) ========= 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.bBrV56WvhS/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.z4N4EGIpqw/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.020388 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:47:59.720410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 02:47:59.720725) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a32b3e3c6b34d28e5e1d4f484f0fa6ef74a458cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a32b3e3c6b34d28e5e1d4f484f0fa6ef74a458cd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bBrV56WvhS/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.z4N4EGIpqw/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-08-05 02:47:59,805 truncating revision to first 12 chars 2016-08-05 02:47:59,805 Setting DEBUG logging. 2016-08-05 02:47:59,805 attempt 1/10 2016-08-05 02:47:59,805 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a32b3e3c6b34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 02:48:00,980 unpacking tar archive at: fx-team-a32b3e3c6b34/testing/mozharness/ program finished with exit code 0 elapsedTime=1.431619 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 02:48:01.174426) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 02:48:01.174695) ========= script_repo_revision: a32b3e3c6b34d28e5e1d4f484f0fa6ef74a458cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 02:48:01.175102) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 02:48:01.175365) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 02:48:01.193082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-08-05 02:48:01.193389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bBrV56WvhS/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.z4N4EGIpqw/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:01 INFO - MultiFileLogger online at 20160805 02:48:01 in /builds/slave/test 02:48:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:48:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:01 INFO - {'append_to_log': False, 02:48:01 INFO - 'base_work_dir': '/builds/slave/test', 02:48:01 INFO - 'blob_upload_branch': 'Fx-Team', 02:48:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:01 INFO - 'branch': 'Fx-Team', 02:48:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:01 INFO - 'config_files': ('talos/mac_config.py',), 02:48:01 INFO - 'default_actions': ('clobber', 02:48:01 INFO - 'read-buildbot-config', 02:48:01 INFO - 'download-and-extract', 02:48:01 INFO - 'populate-webroot', 02:48:01 INFO - 'create-virtualenv', 02:48:01 INFO - 'install', 02:48:01 INFO - 'run-tests'), 02:48:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:01 INFO - 'download_minidump_stackwalk': True, 02:48:01 INFO - 'download_symbols': 'ondemand', 02:48:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:01 INFO - 'installer_path': 'installer.exe', 02:48:01 INFO - 'log_level': 'info', 02:48:01 INFO - 'log_name': 'talos', 02:48:01 INFO - 'log_to_console': True, 02:48:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:48:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:48:01 INFO - 'opt_config_files': (), 02:48:01 INFO - 'pip_index': False, 02:48:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:01 INFO - 'cmd': ('bash', 02:48:01 INFO - '-c', 02:48:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:01 INFO - 'enabled': True, 02:48:01 INFO - 'halt_on_failure': False, 02:48:01 INFO - 'name': 'check_screen_resolution'},), 02:48:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:01 INFO - 'cmd': ('bash', 02:48:01 INFO - '-c', 02:48:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:01 INFO - 'enabled': True, 02:48:01 INFO - 'halt_on_failure': False, 02:48:01 INFO - 'name': 'check_screen_resolution'},), 02:48:01 INFO - 'run_cmd_checks_enabled': True, 02:48:01 INFO - 'sps_profile': False, 02:48:01 INFO - 'sps_profile_interval': 0, 02:48:01 INFO - 'suite': 'dromaeojs-e10s', 02:48:01 INFO - 'system_bits': '32', 02:48:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:01 INFO - 'title': 't-yosemite-r7-0340', 02:48:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:01 INFO - 'use_talos_json': True, 02:48:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:01 INFO - 'work_dir': 'build'} 02:48:01 INFO - [mozharness: 2016-08-05 09:48:01.387411Z] Running clobber step. 02:48:01 INFO - Running pre-action listener: _resource_record_pre_action 02:48:01 INFO - Running main action method: clobber 02:48:01 INFO - rmtree: /builds/slave/test/build 02:48:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:02 INFO - Running post-action listener: _resource_record_post_action 02:48:02 INFO - [mozharness: 2016-08-05 09:48:02.839896Z] Finished clobber step (success) 02:48:02 INFO - [mozharness: 2016-08-05 09:48:02.840063Z] Running read-buildbot-config step. 02:48:02 INFO - Running pre-action listener: _resource_record_pre_action 02:48:02 INFO - Running main action method: read_buildbot_config 02:48:02 INFO - Using buildbot properties: 02:48:02 INFO - { 02:48:02 INFO - "project": "", 02:48:02 INFO - "product": "firefox", 02:48:02 INFO - "script_repo_revision": "production", 02:48:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 02:48:02 INFO - "repository": "", 02:48:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 02:48:02 INFO - "buildid": "20160805001722", 02:48:02 INFO - "pgo_build": "False", 02:48:02 INFO - "basedir": "/builds/slave/test", 02:48:02 INFO - "buildnumber": 758, 02:48:02 INFO - "slavename": "t-yosemite-r7-0340", 02:48:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:48:02 INFO - "platform": "yosemite_r7", 02:48:02 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 02:48:02 INFO - "branch": "fx-team", 02:48:02 INFO - "repo_path": "integration/fx-team", 02:48:02 INFO - "revision": "a32b3e3c6b34d28e5e1d4f484f0fa6ef74a458cd", 02:48:02 INFO - "stage_platform": "macosx64", 02:48:02 INFO - "builduid": "89ee8aee582644f29f9c8f14d44b12c3", 02:48:02 INFO - "slavebuilddir": "test" 02:48:02 INFO - } 02:48:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 02:48:02 INFO - Running post-action listener: _resource_record_post_action 02:48:02 INFO - [mozharness: 2016-08-05 09:48:02.843457Z] Finished read-buildbot-config step (success) 02:48:02 INFO - [mozharness: 2016-08-05 09:48:02.843582Z] Running download-and-extract step. 02:48:02 INFO - Running pre-action listener: _resource_record_pre_action 02:48:02 INFO - Running main action method: download_and_extract 02:48:02 INFO - mkdir: /builds/slave/test/build/tests 02:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:02 INFO - trying https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 02:48:02 INFO - Downloading https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 02:48:04 INFO - Downloaded 1199 bytes. 02:48:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:48:04 INFO - Using the following test package requirements: 02:48:04 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:48:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 02:48:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 02:48:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:48:04 INFO - u'jsshell-mac.zip'], 02:48:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 02:48:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:48:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 02:48:04 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 02:48:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 02:48:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 02:48:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:04 INFO - trying https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:48:04 INFO - Downloading https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:48:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:48:05 INFO - Downloaded 16315679 bytes. 02:48:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:48:08 INFO - Return code: 0 02:48:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:08 INFO - trying https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:48:08 INFO - Downloading https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:48:09 INFO - Downloaded 16315679 bytes. 02:48:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:48:12 INFO - Return code: 0 02:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:12 INFO - trying https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 02:48:12 INFO - Downloading https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 02:48:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:48:13 INFO - Downloaded 14413723 bytes. 02:48:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:48:13 INFO - Return code: 0 02:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:13 INFO - trying https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:48:13 INFO - Downloading https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 02:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 02:48:21 INFO - Downloaded 111174543 bytes. 02:48:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:48:21 INFO - mkdir: /builds/slave/test/properties 02:48:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:21 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:21 INFO - Contents: 02:48:21 INFO - build_url:https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:48:22 INFO - Running post-action listener: _resource_record_post_action 02:48:22 INFO - Running post-action listener: set_extra_try_arguments 02:48:22 INFO - [mozharness: 2016-08-05 09:48:22.520800Z] Finished download-and-extract step (success) 02:48:22 INFO - [mozharness: 2016-08-05 09:48:22.520951Z] Running populate-webroot step. 02:48:22 INFO - Running pre-action listener: _resource_record_pre_action 02:48:22 INFO - Running main action method: populate_webroot 02:48:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:22 INFO - '--tppagecycles', 02:48:22 INFO - '7'], 02:48:22 INFO - 'tests': ['tsvgm']}}, 02:48:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:48:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:48:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:22 INFO - 'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:22 INFO - 'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['damp', 'tps']}, 02:48:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:22 INFO - 'tests': ['damp', 'tps']}, 02:48:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['dromaeo_dom']}, 02:48:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['basic_compositor_video']}, 02:48:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:48:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'other-e10s': {'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['tsvgx', 02:48:22 INFO - 'tsvgr_opacity', 02:48:22 INFO - 'tart', 02:48:22 INFO - 'tscrollx', 02:48:22 INFO - 'cart']}, 02:48:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:48:22 INFO - 'tsvgr_opacity', 02:48:22 INFO - 'tart', 02:48:22 INFO - 'tscrollx', 02:48:22 INFO - 'cart']}, 02:48:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:22 INFO - 'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['tp5o']}, 02:48:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:22 INFO - 'tests': ['tp5o']}, 02:48:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:22 INFO - 'talos_options': ['--disable-e10s', 02:48:22 INFO - '--xperf_path', 02:48:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:22 INFO - 'tests': ['tp5n']}, 02:48:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:22 INFO - 'talos_options': ['--xperf_path', 02:48:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:22 INFO - 'tests': ['tp5n']}}, 02:48:22 INFO - 'talos.zip': {'path': '', 02:48:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:22 INFO - Running post-action listener: _resource_record_post_action 02:48:22 INFO - [mozharness: 2016-08-05 09:48:22.540137Z] Finished populate-webroot step (success) 02:48:22 INFO - [mozharness: 2016-08-05 09:48:22.540219Z] Running create-virtualenv step. 02:48:22 INFO - Running pre-action listener: _resource_record_pre_action 02:48:22 INFO - Running main action method: create_virtualenv 02:48:22 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:48:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:22 INFO - Using real prefix '/tools/python27' 02:48:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:23 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:26 INFO - Installing pip.................done. 02:48:26 INFO - Return code: 0 02:48:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10914d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8761d5f510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, '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.bBrV56WvhS/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.z4N4EGIpqw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:26 INFO - 'HOME': '/Users/cltbld', 02:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:26 INFO - 'LOGNAME': 'cltbld', 02:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:26 INFO - 'MOZ_NO_REMOTE': '1', 02:48:26 INFO - 'NO_EM_RESTART': '1', 02:48:26 INFO - 'PAGER': '/bin/cat', 02:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:26 INFO - 'PWD': '/builds/slave/test', 02:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:26 INFO - 'SHELL': '/bin/bash', 02:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:48:26 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:26 INFO - 'USER': 'cltbld', 02:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:26 INFO - 'XPC_FLAGS': '0x0', 02:48:26 INFO - 'XPC_SERVICE_NAME': '0', 02:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:26 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 02:48:26 INFO - Cleaning up... 02:48:26 INFO - Return code: 0 02:48:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10914d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8761d5f510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, '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.bBrV56WvhS/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.z4N4EGIpqw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:26 INFO - 'HOME': '/Users/cltbld', 02:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:26 INFO - 'LOGNAME': 'cltbld', 02:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:26 INFO - 'MOZ_NO_REMOTE': '1', 02:48:26 INFO - 'NO_EM_RESTART': '1', 02:48:26 INFO - 'PAGER': '/bin/cat', 02:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:26 INFO - 'PWD': '/builds/slave/test', 02:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:26 INFO - 'SHELL': '/bin/bash', 02:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:48:26 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:26 INFO - 'USER': 'cltbld', 02:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:26 INFO - 'XPC_FLAGS': '0x0', 02:48:26 INFO - 'XPC_SERVICE_NAME': '0', 02:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:26 INFO - Downloading/unpacking psutil>=3.1.1 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:30 INFO - Installing collected packages: psutil 02:48:30 INFO - Running setup.py install for psutil 02:48:30 INFO - building 'psutil._psutil_osx' extension 02:48:30 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 02:48:30 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 02:48:30 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 02:48:30 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 02:48:30 INFO - building 'psutil._psutil_posix' extension 02:48:30 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 02:48:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:30 INFO - ^ 02:48:30 INFO - 1 warning generated. 02:48:30 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 02:48:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:30 INFO - Successfully installed psutil 02:48:30 INFO - Cleaning up... 02:48:31 INFO - Return code: 0 02:48:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10914d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8761d5f510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, '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.bBrV56WvhS/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.z4N4EGIpqw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:48:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:48:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:31 INFO - 'HOME': '/Users/cltbld', 02:48:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:31 INFO - 'LOGNAME': 'cltbld', 02:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:31 INFO - 'MOZ_NO_REMOTE': '1', 02:48:31 INFO - 'NO_EM_RESTART': '1', 02:48:31 INFO - 'PAGER': '/bin/cat', 02:48:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:31 INFO - 'PWD': '/builds/slave/test', 02:48:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:31 INFO - 'SHELL': '/bin/bash', 02:48:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:48:31 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:48:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:31 INFO - 'USER': 'cltbld', 02:48:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:31 INFO - 'XPC_FLAGS': '0x0', 02:48:31 INFO - 'XPC_SERVICE_NAME': '0', 02:48:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:48:33 INFO - Installing collected packages: mozsystemmonitor 02:48:33 INFO - Running setup.py install for mozsystemmonitor 02:48:34 INFO - Successfully installed mozsystemmonitor 02:48:34 INFO - Cleaning up... 02:48:34 INFO - Return code: 0 02:48:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10914d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8761d5f510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, '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.bBrV56WvhS/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.z4N4EGIpqw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:34 INFO - 'HOME': '/Users/cltbld', 02:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:34 INFO - 'LOGNAME': 'cltbld', 02:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:34 INFO - 'MOZ_NO_REMOTE': '1', 02:48:34 INFO - 'NO_EM_RESTART': '1', 02:48:34 INFO - 'PAGER': '/bin/cat', 02:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:34 INFO - 'PWD': '/builds/slave/test', 02:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:34 INFO - 'SHELL': '/bin/bash', 02:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:48:34 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:34 INFO - 'USER': 'cltbld', 02:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:34 INFO - 'XPC_FLAGS': '0x0', 02:48:34 INFO - 'XPC_SERVICE_NAME': '0', 02:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:34 INFO - Downloading/unpacking jsonschema==2.5.1 02:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:37 INFO - warning: no files found matching '*.txt' 02:48:37 INFO - no previously-included directories found matching 'build' 02:48:37 INFO - no previously-included directories found matching 'dist' 02:48:37 INFO - no previously-included directories found matching '.git*' 02:48:37 INFO - Installing collected packages: jsonschema, functools32 02:48:37 INFO - Running setup.py install for functools32 02:48:37 INFO - warning: no files found matching '*.txt' 02:48:37 INFO - no previously-included directories found matching 'build' 02:48:37 INFO - no previously-included directories found matching 'dist' 02:48:37 INFO - no previously-included directories found matching '.git*' 02:48:37 INFO - Successfully installed jsonschema functools32 02:48:37 INFO - Cleaning up... 02:48:37 INFO - Return code: 0 02:48:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10914d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8761d5f510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, '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.bBrV56WvhS/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.z4N4EGIpqw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:48:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:48:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:37 INFO - 'HOME': '/Users/cltbld', 02:48:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:37 INFO - 'LOGNAME': 'cltbld', 02:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:37 INFO - 'MOZ_NO_REMOTE': '1', 02:48:37 INFO - 'NO_EM_RESTART': '1', 02:48:37 INFO - 'PAGER': '/bin/cat', 02:48:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:37 INFO - 'PWD': '/builds/slave/test', 02:48:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:37 INFO - 'SHELL': '/bin/bash', 02:48:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:48:37 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:48:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:37 INFO - 'USER': 'cltbld', 02:48:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:37 INFO - 'XPC_FLAGS': '0x0', 02:48:37 INFO - 'XPC_SERVICE_NAME': '0', 02:48:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:48:37 INFO - Cleaning up... 02:48:37 INFO - Return code: 0 02:48:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:37 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 0x1090b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10914d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8761d5f510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, '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.bBrV56WvhS/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.z4N4EGIpqw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:37 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 02:48:37 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 02:48:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:48:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:37 INFO - 'HOME': '/Users/cltbld', 02:48:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:37 INFO - 'LOGNAME': 'cltbld', 02:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:37 INFO - 'MOZ_NO_REMOTE': '1', 02:48:37 INFO - 'NO_EM_RESTART': '1', 02:48:37 INFO - 'PAGER': '/bin/cat', 02:48:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:37 INFO - 'PWD': '/builds/slave/test', 02:48:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:37 INFO - 'SHELL': '/bin/bash', 02:48:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:48:37 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:48:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:37 INFO - 'USER': 'cltbld', 02:48:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:37 INFO - 'XPC_FLAGS': '0x0', 02:48:37 INFO - 'XPC_SERVICE_NAME': '0', 02:48:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:38 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:40 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:41 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 02:48:41 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 02:48:41 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 02:48:41 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 02:48:41 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 02:48:41 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 02:48:41 INFO - Downloading docopt-0.6.1.tar.gz 02:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:41 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:41 INFO - Running setup.py install for blobuploader 02:48:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:41 INFO - Running setup.py install for requests 02:48:42 INFO - Running setup.py install for docopt 02:48:42 INFO - Successfully installed blobuploader requests docopt 02:48:42 INFO - Cleaning up... 02:48:42 INFO - Return code: 0 02:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:42 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 0x1090b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10914d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8761d5f510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, '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.bBrV56WvhS/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.z4N4EGIpqw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:42 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 02:48:42 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 02:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:42 INFO - 'HOME': '/Users/cltbld', 02:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:42 INFO - 'LOGNAME': 'cltbld', 02:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:42 INFO - 'MOZ_NO_REMOTE': '1', 02:48:42 INFO - 'NO_EM_RESTART': '1', 02:48:42 INFO - 'PAGER': '/bin/cat', 02:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:42 INFO - 'PWD': '/builds/slave/test', 02:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:42 INFO - 'SHELL': '/bin/bash', 02:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:48:42 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:42 INFO - 'USER': 'cltbld', 02:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:42 INFO - 'XPC_FLAGS': '0x0', 02:48:42 INFO - 'XPC_SERVICE_NAME': '0', 02:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ccAA4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-hVaMaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-uBpGGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-eyZjge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ibFpfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-hRYSaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-76SM2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ePJPUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-4Js7r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-gcyRxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-xeKATs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:44 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-t_KoxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:44 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-5aeP3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:44 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-0uMWfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:44 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-TvPYxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:44 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-X2IPPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:44 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-TBoBc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:44 INFO - Running setup.py install for manifestparser 02:48:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:44 INFO - Running setup.py install for mozcrash 02:48:44 INFO - Running setup.py install for mozdebug 02:48:45 INFO - Running setup.py install for mozdevice 02:48:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:45 INFO - Running setup.py install for mozfile 02:48:45 INFO - Running setup.py install for mozhttpd 02:48:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:45 INFO - Running setup.py install for mozinfo 02:48:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:45 INFO - Running setup.py install for mozInstall 02:48:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:45 INFO - Running setup.py install for mozleak 02:48:46 INFO - Running setup.py install for mozlog 02:48:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:46 INFO - Running setup.py install for moznetwork 02:48:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:46 INFO - Running setup.py install for mozprocess 02:48:46 INFO - Running setup.py install for mozprofile 02:48:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:46 INFO - Running setup.py install for mozrunner 02:48:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:46 INFO - Running setup.py install for mozscreenshot 02:48:46 INFO - Running setup.py install for moztest 02:48:47 INFO - Running setup.py install for mozversion 02:48:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:47 INFO - Cleaning up... 02:48:47 INFO - Return code: 0 02:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:47 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 0x1090b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10914d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8761d5f510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, '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.bBrV56WvhS/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.z4N4EGIpqw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:47 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 02:48:47 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 02:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:47 INFO - 'HOME': '/Users/cltbld', 02:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:47 INFO - 'LOGNAME': 'cltbld', 02:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:47 INFO - 'MOZ_NO_REMOTE': '1', 02:48:47 INFO - 'NO_EM_RESTART': '1', 02:48:47 INFO - 'PAGER': '/bin/cat', 02:48:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:47 INFO - 'PWD': '/builds/slave/test', 02:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:47 INFO - 'SHELL': '/bin/bash', 02:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:48:47 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:47 INFO - 'USER': 'cltbld', 02:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:47 INFO - 'XPC_FLAGS': '0x0', 02:48:47 INFO - 'XPC_SERVICE_NAME': '0', 02:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-9w53ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:47 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)) 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-CoEHV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:47 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)) 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-emws1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:47 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)) 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-7bdJQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:47 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)) 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:48 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Y8Lohq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:48 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)) 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:48 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ovQEbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:48 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)) 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:48 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-6hxvY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:48 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)) 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:48 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-xucwCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:48 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)) 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:48 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-uxJueJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:48 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)) 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:48 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-n5ErXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:48 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-BY_ISx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:48 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)) 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:48 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-57sXIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:48 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-umvhKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:48 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)) 02:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:48 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-8Z8fPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:49 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-J16nlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:49 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:49 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Yk3fay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:49 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:49 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-WYTK4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48:51 INFO - Downloading blessings-1.6.tar.gz 02:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:51 INFO - Installing collected packages: blessings 02:48:51 INFO - Running setup.py install for blessings 02:48:52 INFO - Successfully installed blessings 02:48:52 INFO - Cleaning up... 02:48:52 INFO - Return code: 0 02:48:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:52 INFO - Reading from file tmpfile_stdout 02:48:52 INFO - Current package versions: 02:48:52 INFO - blessings == 1.6 02:48:52 INFO - blobuploader == 1.2.4 02:48:52 INFO - docopt == 0.6.1 02:48:52 INFO - functools32 == 3.2.3-2 02:48:52 INFO - jsonschema == 2.5.1 02:48:52 INFO - manifestparser == 1.1 02:48:52 INFO - mozInstall == 1.12 02:48:52 INFO - mozcrash == 0.17 02:48:52 INFO - mozdebug == 0.1 02:48:52 INFO - mozdevice == 0.48 02:48:52 INFO - mozfile == 1.2 02:48:52 INFO - mozhttpd == 0.7 02:48:52 INFO - mozinfo == 0.9 02:48:52 INFO - mozleak == 0.1 02:48:52 INFO - mozlog == 3.3 02:48:52 INFO - moznetwork == 0.27 02:48:52 INFO - mozprocess == 0.23 02:48:52 INFO - mozprofile == 0.28 02:48:52 INFO - mozrunner == 6.12 02:48:52 INFO - mozscreenshot == 0.1 02:48:52 INFO - mozsystemmonitor == 0.3 02:48:52 INFO - moztest == 0.7 02:48:52 INFO - mozversion == 1.4 02:48:52 INFO - psutil == 3.1.1 02:48:52 INFO - requests == 1.2.3 02:48:52 INFO - wsgiref == 0.1.2 02:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:52 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 0x1090b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10914d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8761d5f510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, '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.bBrV56WvhS/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.z4N4EGIpqw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:52 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 02:48:52 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 02:48:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:48:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:52 INFO - 'HOME': '/Users/cltbld', 02:48:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:52 INFO - 'LOGNAME': 'cltbld', 02:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:52 INFO - 'MOZ_NO_REMOTE': '1', 02:48:52 INFO - 'NO_EM_RESTART': '1', 02:48:52 INFO - 'PAGER': '/bin/cat', 02:48:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:52 INFO - 'PWD': '/builds/slave/test', 02:48:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:52 INFO - 'SHELL': '/bin/bash', 02:48:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:48:52 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:48:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:52 INFO - 'USER': 'cltbld', 02:48:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:52 INFO - 'XPC_FLAGS': '0x0', 02:48:52 INFO - 'XPC_SERVICE_NAME': '0', 02:48:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:52 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)) 02:48:52 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)) 02:48:52 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)) 02:48:52 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)) 02:48:52 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)) 02:48:52 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)) 02:48:52 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)) 02:48:52 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)) 02:48:52 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)) 02:48:52 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)) 02:48:52 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)) 02:48:52 INFO - Cleaning up... 02:48:52 INFO - Return code: 0 02:48:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:52 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 0x1090b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10914d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8761d5f510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, '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.bBrV56WvhS/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.z4N4EGIpqw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:48:52 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 02:48:52 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 02:48:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:48:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:52 INFO - 'HOME': '/Users/cltbld', 02:48:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:52 INFO - 'LOGNAME': 'cltbld', 02:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:52 INFO - 'MOZ_NO_REMOTE': '1', 02:48:52 INFO - 'NO_EM_RESTART': '1', 02:48:52 INFO - 'PAGER': '/bin/cat', 02:48:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:52 INFO - 'PWD': '/builds/slave/test', 02:48:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:52 INFO - 'SHELL': '/bin/bash', 02:48:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:48:52 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:48:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:52 INFO - 'USER': 'cltbld', 02:48:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:52 INFO - 'XPC_FLAGS': '0x0', 02:48:52 INFO - 'XPC_SERVICE_NAME': '0', 02:48:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:48:52 INFO - Cleaning up... 02:48:52 INFO - Return code: 0 02:48:52 INFO - Running post-action listener: _resource_record_post_action 02:48:52 INFO - Running post-action listener: _start_resource_monitoring 02:48:52 INFO - Starting resource monitoring. 02:48:52 INFO - [mozharness: 2016-08-05 09:48:52.965987Z] Finished create-virtualenv step (success) 02:48:52 INFO - [mozharness: 2016-08-05 09:48:52.966934Z] Running install step. 02:48:52 INFO - Running pre-action listener: _resource_record_pre_action 02:48:52 INFO - Running main action method: install 02:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:53 INFO - Reading from file tmpfile_stdout 02:48:53 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:53 INFO - Reading from file tmpfile_stdout 02:48:53 INFO - Output received: 02:48:53 INFO - Usage: mozinstall [options] installer 02:48:53 INFO - Options: 02:48:53 INFO - -h, --help show this help message and exit 02:48:53 INFO - -d DEST, --destination=DEST 02:48:53 INFO - Directory to install application into. [default: 02:48:53 INFO - "/builds/slave/test"] 02:48:53 INFO - --app=APP Application being installed. [default: firefox] 02:48:53 INFO - mkdir: /builds/slave/test/build/application 02:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:49:27 INFO - Reading from file tmpfile_stdout 02:49:27 INFO - Output received: 02:49:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:49:27 INFO - Running post-action listener: _resource_record_post_action 02:49:27 INFO - [mozharness: 2016-08-05 09:49:27.439221Z] Finished install step (success) 02:49:27 INFO - [mozharness: 2016-08-05 09:49:27.439389Z] Running run-tests step. 02:49:27 INFO - Running pre-action listener: _resource_record_pre_action 02:49:27 INFO - Running main action method: run_tests 02:49:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:27 INFO - 2016-08-05 02:49:27.454 screenresolution[1944:12558] starting screenresolution argv=screenresolution get 02:49:27 INFO - 2016-08-05 02:49:27.457 screenresolution[1944:12558] Display 0: 1600x1200x32@60 02:49:27 INFO - 2016-08-05 02:49:27.463 screenresolution[1945:12563] starting screenresolution argv=screenresolution list 02:49:27 INFO - Available Modes on Display 0 02:49:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:27 INFO - Intel Iris: 02:49:27 INFO - Chipset Model: Intel Iris 02:49:27 INFO - Type: GPU 02:49:27 INFO - Bus: Built-In 02:49:27 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:27 INFO - Vendor: Intel (0x8086) 02:49:27 INFO - Device ID: 0x0a2e 02:49:27 INFO - Revision ID: 0x0009 02:49:27 INFO - Displays: 02:49:27 INFO - Display: 02:49:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:27 INFO - Display Serial Number: 1600x1200 60 02:49:27 INFO - Main Display: Yes 02:49:27 INFO - Mirror: Off 02:49:27 INFO - Online: Yes 02:49:27 INFO - Rotation: Supported 02:49:27 INFO - Return code: 0 02:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:27 INFO - Python 2.7.3 02:49:27 INFO - Return code: 0 02:49:27 INFO - grabbing minidump binary from tooltool 02:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10901cd30>, '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 0x108d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109014b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:49:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:49:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:49:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:27 INFO - Return code: 0 02:49:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0340 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:49:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBrV56WvhS/Render', 02:49:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:27 INFO - 'HOME': '/Users/cltbld', 02:49:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:27 INFO - 'LOGNAME': 'cltbld', 02:49:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:27 INFO - 'MOZ_NO_REMOTE': '1', 02:49:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:27 INFO - 'NO_EM_RESTART': '1', 02:49:27 INFO - 'PAGER': '/bin/cat', 02:49:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:27 INFO - 'PWD': '/builds/slave/test', 02:49:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:27 INFO - 'SHELL': '/bin/bash', 02:49:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z4N4EGIpqw/Listeners', 02:49:27 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:49:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:27 INFO - 'USER': 'cltbld', 02:49:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:27 INFO - 'XPC_FLAGS': '0x0', 02:49:27 INFO - 'XPC_SERVICE_NAME': '0', 02:49:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:49:28 INFO - mozversion application_buildid: 20160805001722 02:49:28 INFO - mozversion application_changeset: a32b3e3c6b34d28e5e1d4f484f0fa6ef74a458cd 02:49:28 INFO - mozversion application_display_name: Nightly 02:49:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:28 INFO - mozversion application_name: Firefox 02:49:28 INFO - mozversion application_remotingname: firefox 02:49:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:49:28 INFO - mozversion application_vendor: Mozilla 02:49:28 INFO - mozversion application_version: 51.0a1 02:49:28 INFO - mozversion platform_buildid: 20160805001722 02:49:28 INFO - mozversion platform_changeset: a32b3e3c6b34d28e5e1d4f484f0fa6ef74a458cd 02:49:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:49:28 INFO - mozversion platform_version: 51.0a1 02:49:28 INFO - using testdate: 1470390568 02:49:28 INFO - actual date: 1470390568 02:49:28 INFO - starting webserver on 'localhost:50334' 02:49:28 INFO - SUITE-START | Running 2 tests 02:49:28 INFO - TEST-START | dromaeo_css 02:49:28 INFO - operating with platform_type : mac_ 02:49:28 INFO - Initialising browser for dromaeo_css test... 02:49:28 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpdCfAi5/profile http://localhost:50334/getInfo.html) 02:49:30 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 02:49:30 INFO - PROCESS | 1955 | colorDepth:24 02:49:30 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 02:49:30 INFO - PROCESS | 1955 | __metrics 02:49:30 ERROR - PROCESS | 1955 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:49:31 INFO - TEST-INFO | 1955: exit 0 02:49:31 INFO - Browser initialized. 02:49:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:31 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpdCfAi5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:43 INFO - PROCESS | 1958 | RSS: Main: 254148608 02:49:43 INFO - PROCESS | 1958 | 02:50:33 INFO - PROCESS | 1958 | 1470390633350 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] 02:52:44 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50334/tests/dromaeo/cssquery-ext.html) 02:52:46 INFO - PROCESS | 1958 | RSS: Main: 269279232 02:52:46 INFO - PROCESS | 1958 | 02:55:48 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-ext.html (next: http://localhost:50334/tests/dromaeo/cssquery-jquery.html) 02:55:48 INFO - PROCESS | 1958 | RSS: Main: 281591808 02:55:48 INFO - PROCESS | 1958 | 02:58:51 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50334/tests/dromaeo/cssquery-mootools.html) 02:58:51 INFO - PROCESS | 1958 | RSS: Main: 287186944 02:58:51 INFO - PROCESS | 1958 | 03:01:53 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50334/tests/dromaeo/cssquery-prototype.html) 03:01:54 INFO - PROCESS | 1958 | RSS: Main: 287457280 03:01:54 INFO - PROCESS | 1958 | 03:04:56 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50334/tests/dromaeo/cssquery-yui.html) 03:04:57 INFO - PROCESS | 1958 | RSS: Main: 291885056 03:04:57 INFO - PROCESS | 1958 | 03:08:00 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-yui.html (next: http://localhost:50334/tests/dromaeo/cssquery-dojo.html) 03:08:00 INFO - PROCESS | 1958 | RSS: Main: 292155392 03:08:00 INFO - PROCESS | 1958 | 03:08:00 INFO - PROCESS | 1958 | __start_tp_report 03:08:00 INFO - PROCESS | 1958 | _x_x_mozilla_page_load 03:08:00 INFO - PROCESS | 1958 | _x_x_mozilla_page_load_details 03:08:00 INFO - PROCESS | 1958 | |i|pagename|runs| 03:08:00 INFO - PROCESS | 1958 | |0;dojo.html;2833.773298136149;2845.0753505110833;3191.5372271020715;3294.9505757413644;3407.2163402417436;4978.676386034915;5482.80810171644;5659.066254068074;5830.621009634371;5853.004989151844;5759.337676167242;5797.884042319151;5804.506616937555;5878.823635290937;5890.911636325459;5160.767765450545;5259.184826351921;5273.077211487975;5328.760205790749;5356.54469370102;5351.491608297206;5370.301860758096;5375.784968601251;5384.461553844604;5416.837494875141;4915.557599816016;5187.688738675692;5248.842534723926;5344.5724342052545;5348.572114230852;5273.31446911899;5299.072662284085;5303.178007408857;5315.44187860273;5322.680639161624;5158.613104017214;5221.708270196972;5258.605604579634;5282.10204265272;5293.6294459387855;4465.68740188187;5503.3395992481155;5696.202531645573;5803.303603567557;5897.675627840467;6205.027938505515;6213.316535181127;6260.966940454819;6278.937210627881;6291.1192433059405;6150.077488376779;6248.50011999039;6263.060540918898;6269.561130720851;6277.435030847246;5808.506276966463;5898;5921.111833225008;5944.048952167633;5989.520838332923;6296.028159872164;6328.303886572473;6336.398042185985;6342.112104305401;6364;6114.38856114385;6153.569250152446;6225.128482012522;6240.157578726905;6261.530385221126;6143.696113957266;6177.135201071854;6193.876122477525;6196.690165491707;6233.812985610439;6199.318075011745;6271.717772700148;6277.18396608438;6289.213848268966;6294.8111556653375;5853.560982926298;6242.875142497124;6265.96867015662;6306.148669929593;6316.62100273985;4096.897577560525;4914.311996320518;5015.949840501621;5032.144535428986;5049.974750126225;4463.486699029589;4545.477270113979;4555.63554915606;4567.383403240587;4575.405197324327;5127.256547800548;5749.9937510935415;5840.620359676607;5902.144189092557;5941.168236446901;6172.938270617326;6192.59748116371;6201.937980620226;6204.286507051746;6250.843728906813;5879.823605291848;5889.646621202742;5905.320888097838;5921.407859214044;5966.791162309299;5520.1167813149705;5528.55771538276;5533.114701647717;5551.444855514497;5562;6200.503959683215;6264.968675156595;6276.843078923063;6330.873382532415;6424.71088801005;6245.68771561411;6249.218847644044;6250.874982500415;6267.96866015667;6268.874622507433;6347.174867267226;6377.7130029147875;6391.552591318563;6416.165898433361;6425.068365086942;4752.500987396274;4835.419749630067;6102.943731970988;6150.985087460519;6249.96875015622;5231.869203269796;6255.343188965093;6268.905966410599;6270.811875643738;6272.5922815016875;4776.474587795409;6199.690015499297;6212.72042758086;6232.626042437469;6241.157443745036;6107.297660768891;6122.337166850181;6151.66165860864;6152.169457123231;6233.532485063548;5535.225068490334;5653.925754106706;5730.455606717355;5975.25309336333;6122.234720659918;5243.737813109406;6177.567570270217;6180.969095154495;6251.374862513894;6267;5943.702814859326;6016.42843929826;6059.909101363395;6101.237345331833;6164.722587483484 03:08:00 INFO - PROCESS | 1958 | |1;ext.html;465.6740281802738;497.2714972565191;520.4691214960737;530.5039787798411;536.6833568194766;35945.28109437809;41509.58490415095;41553;41590.58409415905;41737.58262417379;42088.73733787991;42896.57103428973;42913.35629965553;42925.78537107318;42931.78534107325;9683.273754468408;9862.556184971694;9897.059779320953;9899.208063354914;9904.00959904011;9728.270379721514;9820.852687209697;9822.557984890696;9829.4102353859;9854.211663066973;9825.65610203643;9835.360701554411;9841.26190535709;9858.802823943517;9882.901170988305;9761.707148785548;9768.169705575;9808.901910980905;9809.852852207223;9871.062249086326;8431.114732953074;9630.711078667651;9662.17871480925;9711.951440242754;9718.514074296258;40051;40165.39751903724;40535;40598.79700601478;40643.390349144785;3050.2526880914097;3333.866645334184;3381.340638575479;3444.639367449868;3455.1707590178175;30868.845655771576;31016.689833101605;31376.744930202763;31377.686223137705;31431.685683143103;3124.5000799872137;3135.608048993876;3150.4329220740256;3167.825769582672;3223.2908760072746;437236;439433;440527;442113.789431054;442474;32178;32294.83852580769;32368.514472282935;32398.676013240038;32413.675863241067;34598;35005.64994350024;35268.11829704227;35619;35826.46260306097;13600.591982240549;15963.760543591856;16113.597160070858;16126.193690315436;16142.273597688132;10744.516496757664;11680.948714615726;12305.692357691129;12333.075019373582;12439.191452555555;19291.4212573623;19417.708734368713;19504.70742938857;19511.024448777505;19551.413457596296;7776.7278145264645;7867.881981770278;7927.423587334024;7938.087119981161;7950.204979502119;875.772299202212;895.6596493332491;996.7259003773875;1011.2466212671607;1110.7722916802036;25184.740762962145;29619.555706664418;30617.261744161893;30660.38679226403;31385.37229255448;1017.0388982411698;1048.4862417415563;1053.1048608682559;1065.3661071662348;1105.7567335186245;15430;15551.455699050479;15584.298706558233;15637.218139093;15664.494078371985;711678;734085;734659;735177;736265;58549.414505855246;58672.706636466544;58847;59077.70461147667;59124;1348.366267854107;1363.1889026029496;1397.6086695725214;1400.698849747289;1402.3759427054863;27335.04327348533;29291.68187431528;29340.413191735617;29556.852215738785;30106.69893301039;51113;51375;51990.74004629953;51992;52054.479455204964;661435;665637;667201.663991677;668404.657976707;671120;24559.38601534976;25387.61918571186;25797.3550661235;25863.482730345662;25878.87060564685;46921.53078469171;47643.523564763906;48107.75946120247;48419.757901210265;48927.26609100795;34265.972020839414;34755.13112172216;39926;40170.59829401786;41063.794681026404;34823.47764783581;38682.22635547217;38809.641662541675;39320.60679393284;40220.39669404903;31698.524522131724;35731.46402804012;37887.43168852414;38419;38672.80663596664;27067.052653157047;33257;33262.5010624836;33418.665813341555;33650.99047028593;25470.490590188463;25534.48931021332;25847.095351662603;25867.741322587288;26183.214503564162 03:08:00 INFO - PROCESS | 1958 | |2;jquery.html;372.46923134533284;378.61759622780994;387.7344019346747;400.643427349659;406.5487309086913;17874.731879021823;18423.35518256861;20732.689009664868;20842.166313347447;21050.578988420242;19285.517862053457;19338.226470941147;19392.321268755597;19749.60500789987;20365.389038328838;5317.41508434072;5606.6636001840025;5905.734241959122;5981.9700901495435;6020.307664618581;4113.814878330468;6288.968555157217;6556.770513032045;6603.570767900095;6686.197656281253;6479.83800404989;6516.446102081329;6524.967375163117;6603.966980165116;6630.933690663104;6333.20834895638;6455.322191169954;6498.317676643932;6577.046328282396;6605.471562275006;5385.623006389555;5546.833594992157;5582.609217354787;5601.271834661508;5608.411116832755;24856.87571562149;25060.749392506023;25358.746412535824;25553.616695749577;25958.87020564885;2216.0803266644325;2235.2065016918923;2236.1167338901205;2277.9544409111727;2305.5158416732506;15358;15537.30082146306;15643.061416315057;15784.921075394665;16067.196640167946;1830.2404502131599;1943.1935746665117;1944.202876820511;1951.248769223859;1958.8139126782933;113322.30016549758;114497.42751286273;115333;115741.52775416752;116077;10291.279610427198;10533.683989480327;10893.618723344645;10903.018728314331;11068;13050.934745326213;13175.802362964563;13257.138286011379;13271.66820829487;13285.93357033228;8116.35069194463;8228.62971166299;8331.33349332052;8459.196376344238;8476.703315384055;8274.338052955749;8288.958555207306;8323.66705331792;8394.958025209835;8442.831143377098;5763.308402991668;6325.114483972247;6484.092227088211;6579.703913323912;6634.966825165843;1679.3366620184959;1737.1314342828587;1839.2363777815256;1870.8690391672453;1871.1766822598013;937.4750139921666;957.1479187771545;992.2161492421051;998.4807899892161;1039.870016247969;21068.699253690724;21853.23197694658;21893.523518491587;21933.08364793359;21938.882403998647;950.6530116507425;971.2763990826879;1015.223354134088;1064.38213914849;1067.428925524856;11381.317120972768;11554.826677599844;11718.003969662504;11835.526578936746;12158;623129;628149;635096;639578;646305;68670.65664671645;94774.52612736892;108572;109107.45446272718;111112.44443777729;1003.5283416794096;1003.8193125237382;1016.4409574733867;1018.994905025485;1022.4989755019986;18543;18700.438986830417;18764.93585705544;18885.339013134475;19059.42821715351;39871.00322491961;47576.42365573318;48842.77893052702;49849.750751246014;50641;66766.66616666886;69608;70001.64999174971;70651.64674176596;72319.63840180765;7886.526808391515;7945.920540794749;8102.392320576098;8153;8307.709230176915;12976.935115324362;13146.474141034252;13307.06850520493;13439.328033598476;13655.522056727967;10991.016909638294;11298.887011129784;11447.942760286145;11690.006349460391;11750.58872939443;8546.316294696533;11213.439328033728;11461.656150315504;11503.884961150281;11566.65300041;11462.484188211383;11476.368799716096;11574.942125289319;11856.525738970344;11983.161178717406;6672.797976667785;6831.180258369028;7356.558606483414;8021.63902624395;8281.95859020701;10564.524596393027;11253.943730281297;11412.885871141183;11552.133589980616;11564.768704625692 03:08:00 INFO - PROCESS | 1958 | |3;mootools.html;1467.6771110355721;1487.122597667376;1641.4419097506845;1765.4880084775416;1779.528424967383;7921.326687231593;8406.159384061599;8537.786555336119;8949.597268122941;9005;7076.752313669022;8598.527081010541;8806.735797926056;8807.471551706902;8818.250448711868;2323.616603260464;2350.1539445799585;2362.574736547421;2373.9762602373926;2374.9168779092734;2042.5404284036047;2299.574578702937;2324.721033475985;2364.3025307534317;2374.76252374762;2337.5091230841545;2343.5430091132234;2352.5882970480184;2364.798992085666;2375.2517956843626;2317.29322556621;2327.080803082773;2333.2067097186955;2347.3427440316655;2354.6703461515403;2342.2504798464497;2345.8006069484113;2347.0963678983544;2351.5061837014246;2367.993602718838;8711.695090671796;8831.955840220822;8878.200961913395;8907.331950103768;8938.10618938101;5134.1528647773075;5153.433122356538;5244.318238628954;5316.813911513079;5325.121354976424;3116.9869792317586;3415.316936612687;3541.1501239702284;3580.6777390034763;3640.453931910208;1035.2057096097917;1072.8873468285797;1073.420353009374;1075.93006454581;1088.6516314779274;9917.404955702608;11370.886291137065;11471.369074700804;11475;11619.825702614384;4244.448221731217;4497.64018878489;4728.503507131771;4744.240921452551;4779.904401911942;9765.853512197322;9883.061109194616;9895.65365212214;9910.20718342531;9915.950420247853;4509.751963642031;5212.244224587489;5280.419153893069;5282.630215884851;5289.867753306198;4369.628581570539;4718.9292160617615;4841.903161936812;4866.343043689128;4875.414950205998;3913.804309784556;3985.123272879962;4001.139754952699;4048.817803198863;4083.9387409188885;1245.9314737689333;1247.3015111537568;1253.6113804720567;1254.9811752823714;1257.7798885195054;827.2596026556319;921.9078092190728;925.9305552083621;938.4088024544493;967.6226271754022;5958.493528050078;6075.75696972125;6094.756209751649;6149.13912052313;6153.538484613672;374.11148522259634;414.06834622100274;423.1705856521253;423.45585922089964;429.0239704671834;4038.5153781545814;4076.103257283393;4091.8772436826944;4151.4395556599475;4165.812538435777;8125.553094579855;9846.60613575449;9964.153046990941;9972.252081093948;9976.15202707778;9921.305508614472;9927.007299270159;9965.80068398628;9969.900300996896;9990.650327238513;7430;7439.888401673979;7628.466007379541;7696.576688282086;7701.3068823806125;5588.888222235614;5598.748056337556;5666.603337766317;5747.655140691572;5749.1663708762835;9083.18251357381;9145;9211;9239.584218710308;9342;8168.918310816815;9133.041030691682;9285.814283714422;9398;9470.715878523655;6952.374286314256;7159.8926016110845;7218.27817218274;7331.890021649786;7505.437092217996;8432.45189062709;8505.404621676671;8505.489670619783;8525.829483410422;8545.2309292164;7199.676014579251;7385.409167266714;7545.6981720730555;7614.847703046019;7627.771166865003;7238.746643867439;7370.815729606803;7427.851442971002;7516.173220945801;7528.849423011399;6889.207741109836;6916.515843890879;6985.860282794214;6987.825304367431;6991.335823096798;4984.850454486371;4999.575036121971;5077.162268225701;5155.690658560348;5195.870103247449;5100.770465328995;5139.100657385017;5175.637705360588;5193.11717008102;5205.687658740488 03:08:00 INFO - PROCESS | 1958 | |4;prototype.html;252.31622303557359;303.6280556318509;307.0940724861659;317.9030395729304;318.04110606521334;4714.9528504714945;5320.866978325539;5500.5874559408;5720.856978575533;5767.5962682612235;5498.477644623765;5577.274954255951;5593.440655934404;5640.5487560995125;5672.602917795756;3574.481700153476;3783.905402364949;4336.913261734763;4365.301551751721;4387.407699960512;4191.7694526801015;4282.379055037018;4296.162248361571;4333.891652708676;4390.538993405694;4240.194363071022;4249.596288352602;4258.190943720683;4285.678574106939;4294.291441912081;3831.5861007565336;4004.919901601966;4284.807183676727;4318.042141133303;4345.1961387143165;3544.2379888324135;3547.840347184383;3728.496652951871;3756.211195648917;3760.736748427611;4523.525029871882;4552.567506086916;4793.716304331544;5426.538744206747;5465.262189604392;4361.323994780814;4543.363929049936;4728.723244723905;4778.0205057963385;4948.758563141148;5482.479164479368;5938.782549577326;5955.166276721263;6001.66990815505;6011.699415029275;3935.681546681865;3964.32606456903;3975.363941769332;3978.124812541236;3982.18365235129;4870.439899411542;5595.664260144364;6150.446459818638;6242.250929888397;6245.344238854946;3357.4460214064407;3835.712321575893;4005.379166229239;4019.7789121598007;4043.1509383029893;3788.2802267569623;3995.62041606047;4056.7363121397016;4076.899237205997;4078.6737061035637;4793.352897358812;4808.609929999412;4811.49479304675;4815.6147508199965;4828.46886842447;5358.132844535227;5412.864678383072;5982.055831854665;5990.232881300027;6106.374259068554;1159.478234794346;1340.4102195034154;1348.501054609781;1390.9026368154334;1392.2064423278634;808.1675873849944;828.3745771942146;848.9787755306044;850.6767428377177;854.833307505043;4568.451785785661;4627.629789616823;4665.2768820832825;4671.789769460383;4672.369230153886;4792.939036214461;4856.465788763233;4945.67853089548;4983.700977941335;5027.994401119718;4222.282212023963;4298.677599180074;4419.204543182258;4496.6177874881005;4546.249693867885;2619.816612837083;2639.178966513138;2947.8820847166303;3193.6486986431473;3242.8702851886133;6143.385661433821;6286.685665716695;6349.269833969152;6404.48764098871;6463.741450342028;5740.339860916049;5811.2227052416265;5813.302403711497;6208.255009398901;6340.365963403715;5982.102684597346;6188.845278867974;6271.498280137578;6298.307186209513;6341.90487142684;5832.334132693743;5921.259842519685;6066.696665166813;6081.27024757032;6090.665013424305;5575.438877114414;5926.377730338425;6018.6689732063405;6021.698915054318;6069.514438844793;6350.428461438492;6351;6383.425491705583;6421.325760795049;6425.947674854594;3710.7959062251834;3981.581933896899;3993.281209382223;4012.317905956053;4044.090079732037;5958.679957031118;6076.210092687922;6111.633302001894;6167.414095660905;6227.225240806349;5261.947380526299;5265.842024739264;5327.280817089798;5527.806526771544;5972.731227094878;5278.181881808326;5364.597655175799;5667.603267771216;5759.39526349744;6012.759489620366;5776.306843178845;5778.364379918122;5789.9710501447225;5821.679807610622;5832.883342333044;4922.981577553186;5270.472952704852;5403.972980135074;5605.200640139962;5950.434708702666;5068.974655126848;5729.054705973468;5771.5671324649975;5777.768889244383;5791.420857914175 03:08:00 INFO - PROCESS | 1958 | |5;yui.html;621.7083118837365;720.4488566246822;732.868083744926;733.4645708632698;774.2347447818968;15190.468333608325;15857.841421585781;15940.282687279072;16025.35898564056;16168.757468637965;13895;14420.423183072664;14626.780598291034;14698.853011469882;14727.410903563845;866.319938848006;892.2505095719595;895.6820328783253;897.3808072430035;901.3555307954811;712.4763298975249;858.0947100808644;889.6574818694817;894.369469523984;902.1700035966926;876.4565969099167;917.807260475301;937.2361525356812;937.2501998401286;937.5265490927072;870.5081628879663;872.1757938747886;908.6910450446846;934.8691183234387;940.4592359393376;649.5907578225688;663.6151032401195;679.2222904774055;697.8639165362756;698.0471656189316;14574.198419086946;14766.335514901855;14973.850261497464;14984.100953942798;15002.849971500254;14656;14790.260486975609;14834.406623735145;14942.327595258239;15144.772828407582;10312.948435257777;11818.822717659155;12033.157678962476;12217;12471.688207794878;3930.8820735377985;3961.2869683456966;4002.3196056670436;4105.055837157471;4105.363668631367;91000.54499727525;121317;122512;122891;123187.15219271719;10736.818949915503;11360.772784544428;11379.487923043484;11384.20310578268;11385.601503947322;18911.432657020312;23009.964551595218;23763.643545346833;23831.285061448183;23867.403314917265;7718.343940764986;7856.09654889695;7936.087349954713;8075.757727268191;8094.676212951534;3727.4408838674417;4305.784710764449;4438.955610443919;4444.044530425974;4567.748773817472;2970.495015847311;3209.4864821628425;3392.6268110507826;3488.930221395558;3504.159001839591;529.2722506553489;659.7394029358377;660.8546119853625;664.8365360618917;673.7944926797373;591.1605520161381;605.228333874305;617.7992152550439;677.5503340768284;725.8004048886598;9144;9173.678921237724;9651.420914745138;9661.951690241503;9890.406575605486;550.2599004339237;593.3858456497504;638.5849198021323;662.8210383196606;686.3273991488369;4614.607758340579;4767.022760334124;4858.927116093261;4865.245886887538;4913.1893237616105;162774;165232.3476765241;166315;170332;173882;61400.69299653473;89001.66497502543;89242.10757892468;90662;128887;72448.63775681087;75164.24835751682;75819.48361032859;109478;125806;9394.248460123037;9407.85888211691;9432.669856554987;9467.34321493722;9496.168334840853;61111.77776444535;63464;64022;64133;64459.67770161119;87490.56254718686;102183;105550.47224763827;105994.47002764937;107422.92577074129;11513.59702410445;11523.250988685708;11583.8262426062;11953.163278570417;12053.457594408097;12056.397180141134;12640.43118059708;13725.794113088512;13875.375608097862;14253.643658908195;12015.339156346485;12095.649783863542;13455.596332110052;14077.648058798612;14077.859221407654;13954.860451395356;14159.716805664035;14243.572692819233;14251.287435628385;14256.714865702836;13381;13395.799063013868;13538.93230533841;13724.794128088286;14127.64680882986;10978.560857565608;11341.384623030468;11571;11738.295702257892;11739;9632.614695412105;11319.547218111184;11422.200445969034;11428.37143957057;11704.88295117072 03:08:00 INFO - PROCESS | 1958 | __end_tp_report 03:08:00 INFO - PROCESS | 1958 | __start_cc_report 03:08:00 INFO - PROCESS | 1958 | _x_x_mozilla_cycle_collect,416 03:08:00 INFO - PROCESS | 1958 | __end_cc_report 03:08:00 INFO - PROCESS | 1958 | __startTimestamp1470391680295__endTimestamp 03:08:00 INFO - PROCESS | 1958 | 03:08:00 INFO - PROCESS | 1958 | ------- Summary: start ------- 03:08:00 INFO - PROCESS | 1958 | Number of tests: 6 03:08:00 INFO - PROCESS | 1958 | 03:08:00 INFO - PROCESS | 1958 | [#0] dojo.html Cycles:165 Average:5736.43 Median:5944.05 stddev:695.17 (11.7%) stddev-sans-first:658.96 03:08:00 INFO - PROCESS | 1958 | Values: 2833.8 2845.1 3191.5 3295.0 3407.2 4978.7 5482.8 5659.1 5830.6 5853.0 5759.3 5797.9 5804.5 5878.8 5890.9 5160.8 5259.2 5273.1 5328.8 5356.5 5351.5 5370.3 5375.8 5384.5 5416.8 4915.6 5187.7 5248.8 5344.6 5348.6 5273.3 5299.1 5303.2 5315.4 5322.7 5158.6 5221.7 5258.6 5282.1 5293.6 4465.7 5503.3 5696.2 5803.3 5897.7 6205.0 6213.3 6261.0 6278.9 6291.1 6150.1 6248.5 6263.1 6269.6 6277.4 5808.5 5898.0 5921.1 5944.0 5989.5 6296.0 6328.3 6336.4 6342.1 6364.0 6114.4 6153.6 6225.1 6240.2 6261.5 6143.7 6177.1 6193.9 6196.7 6233.8 6199.3 6271.7 6277.2 6289.2 6294.8 5853.6 6242.9 6266.0 6306.1 6316.6 4096.9 4914.3 5015.9 5032.1 5050.0 4463.5 4545.5 4555.6 4567.4 4575.4 5127.3 5750.0 5840.6 5902.1 5941.2 6172.9 6192.6 6201.9 6204.3 6250.8 5879.8 5889.6 5905.3 5921.4 5966.8 5520.1 5528.6 5533.1 5551.4 5562.0 6200.5 6265.0 6276.8 6330.9 6424.7 6245.7 6249.2 6250.9 6268.0 6268.9 6347.2 6377.7 6391.6 6416.2 6425.1 4752.5 4835.4 6102.9 6151.0 6250.0 5231.9 6255.3 6268.9 6270.8 6272.6 4776.5 6199.7 6212.7 6232.6 6241.2 6107.3 6122.3 6151.7 6152.2 6233.5 5535.2 5653.9 5730.5 5975.3 6122.2 5243.7 6177.6 6181.0 6251.4 6267.0 5943.7 6016.4 6059.9 6101.2 6164.7 03:08:00 INFO - PROCESS | 1958 | 03:08:00 INFO - PROCESS | 1958 | [#1] ext.html Cycles:180 Average:72304.80 Median:38677.52 stddev:168010.59 (434.4%) stddev-sans-first:168395.33 03:08:00 INFO - PROCESS | 1958 | Values: 465.7 497.3 520.5 530.5 536.7 35945.3 41509.6 41553.0 41590.6 41737.6 42088.7 42896.6 42913.4 42925.8 42931.8 9683.3 9862.6 9897.1 9899.2 9904.0 9728.3 9820.9 9822.6 9829.4 9854.2 9825.7 9835.4 9841.3 9858.8 9882.9 9761.7 9768.2 9808.9 9809.9 9871.1 8431.1 9630.7 9662.2 9712.0 9718.5 40051.0 40165.4 40535.0 40598.8 40643.4 3050.3 3333.9 3381.3 3444.6 3455.2 30868.8 31016.7 31376.7 31377.7 31431.7 3124.5 3135.6 3150.4 3167.8 3223.3 437236.0 439433.0 440527.0 442113.8 442474.0 32178.0 32294.8 32368.5 32398.7 32413.7 34598.0 35005.6 35268.1 35619.0 35826.5 13600.6 15963.8 16113.6 16126.2 16142.3 10744.5 11680.9 12305.7 12333.1 12439.2 19291.4 19417.7 19504.7 19511.0 19551.4 7776.7 7867.9 7927.4 7938.1 7950.2 875.8 895.7 996.7 1011.2 1110.8 25184.7 29619.6 30617.3 30660.4 31385.4 1017.0 1048.5 1053.1 1065.4 1105.8 15430.0 15551.5 15584.3 15637.2 15664.5 711678.0 734085.0 734659.0 735177.0 736265.0 58549.4 58672.7 58847.0 59077.7 59124.0 1348.4 1363.2 1397.6 1400.7 1402.4 27335.0 29291.7 29340.4 29556.9 30106.7 51113.0 51375.0 51990.7 51992.0 52054.5 661435.0 665637.0 667201.7 668404.7 671120.0 24559.4 25387.6 25797.4 25863.5 25878.9 46921.5 47643.5 48107.8 48419.8 48927.3 34266.0 34755.1 39926.0 40170.6 41063.8 34823.5 38682.2 38809.6 39320.6 40220.4 31698.5 35731.5 37887.4 38419.0 38672.8 27067.1 33257.0 33262.5 33418.7 33651.0 25470.5 25534.5 25847.1 25867.7 26183.2 03:08:00 INFO - PROCESS | 1958 | 03:08:00 INFO - PROCESS | 1958 | [#2] jquery.html Cycles:180 Average:34962.01 Median:12077.48 stddev:104776.92 (867.5%) stddev-sans-first:105038.65 03:08:00 INFO - PROCESS | 1958 | Values: 372.5 378.6 387.7 400.6 406.5 17874.7 18423.4 20732.7 20842.2 21050.6 19285.5 19338.2 19392.3 19749.6 20365.4 5317.4 5606.7 5905.7 5982.0 6020.3 4113.8 6289.0 6556.8 6603.6 6686.2 6479.8 6516.4 6525.0 6604.0 6630.9 6333.2 6455.3 6498.3 6577.0 6605.5 5385.6 5546.8 5582.6 5601.3 5608.4 24856.9 25060.7 25358.7 25553.6 25958.9 2216.1 2235.2 2236.1 2278.0 2305.5 15358.0 15537.3 15643.1 15784.9 16067.2 1830.2 1943.2 1944.2 1951.2 1958.8 113322.3 114497.4 115333.0 115741.5 116077.0 10291.3 10533.7 10893.6 10903.0 11068.0 13050.9 13175.8 13257.1 13271.7 13285.9 8116.4 8228.6 8331.3 8459.2 8476.7 8274.3 8289.0 8323.7 8395.0 8442.8 5763.3 6325.1 6484.1 6579.7 6635.0 1679.3 1737.1 1839.2 1870.9 1871.2 937.5 957.1 992.2 998.5 1039.9 21068.7 21853.2 21893.5 21933.1 21938.9 950.7 971.3 1015.2 1064.4 1067.4 11381.3 11554.8 11718.0 11835.5 12158.0 623129.0 628149.0 635096.0 639578.0 646305.0 68670.7 94774.5 108572.0 109107.5 111112.4 1003.5 1003.8 1016.4 1019.0 1022.5 18543.0 18700.4 18764.9 18885.3 19059.4 39871.0 47576.4 48842.8 49849.8 50641.0 66766.7 69608.0 70001.6 70651.6 72319.6 7886.5 7945.9 8102.4 8153.0 8307.7 12976.9 13146.5 13307.1 13439.3 13655.5 10991.0 11298.9 11447.9 11690.0 11750.6 8546.3 11213.4 11461.7 11503.9 11566.7 11462.5 11476.4 11574.9 11856.5 11983.2 6672.8 6831.2 7356.6 8021.6 8282.0 10564.5 11253.9 11412.9 11552.1 11564.8 03:08:00 INFO - PROCESS | 1958 | 03:08:00 INFO - PROCESS | 1958 | [#3] mootools.html Cycles:180 Average:5557.94 Median:5286.25 stddev:3044.57 (57.6%) stddev-sans-first:3037.60 03:08:00 INFO - PROCESS | 1958 | Values: 1467.7 1487.1 1641.4 1765.5 1779.5 7921.3 8406.2 8537.8 8949.6 9005.0 7076.8 8598.5 8806.7 8807.5 8818.3 2323.6 2350.2 2362.6 2374.0 2374.9 2042.5 2299.6 2324.7 2364.3 2374.8 2337.5 2343.5 2352.6 2364.8 2375.3 2317.3 2327.1 2333.2 2347.3 2354.7 2342.3 2345.8 2347.1 2351.5 2368.0 8711.7 8832.0 8878.2 8907.3 8938.1 5134.2 5153.4 5244.3 5316.8 5325.1 3117.0 3415.3 3541.2 3580.7 3640.5 1035.2 1072.9 1073.4 1075.9 1088.7 9917.4 11370.9 11471.4 11475.0 11619.8 4244.4 4497.6 4728.5 4744.2 4779.9 9765.9 9883.1 9895.7 9910.2 9916.0 4509.8 5212.2 5280.4 5282.6 5289.9 4369.6 4718.9 4841.9 4866.3 4875.4 3913.8 3985.1 4001.1 4048.8 4083.9 1245.9 1247.3 1253.6 1255.0 1257.8 827.3 921.9 925.9 938.4 967.6 5958.5 6075.8 6094.8 6149.1 6153.5 374.1 414.1 423.2 423.5 429.0 4038.5 4076.1 4091.9 4151.4 4165.8 8125.6 9846.6 9964.2 9972.3 9976.2 9921.3 9927.0 9965.8 9969.9 9990.7 7430.0 7439.9 7628.5 7696.6 7701.3 5588.9 5598.7 5666.6 5747.7 5749.2 9083.2 9145.0 9211.0 9239.6 9342.0 8168.9 9133.0 9285.8 9398.0 9470.7 6952.4 7159.9 7218.3 7331.9 7505.4 8432.5 8505.4 8505.5 8525.8 8545.2 7199.7 7385.4 7545.7 7614.8 7627.8 7238.7 7370.8 7427.9 7516.2 7528.8 6889.2 6916.5 6985.9 6987.8 6991.3 4984.9 4999.6 5077.2 5155.7 5195.9 5100.8 5139.1 5175.6 5193.1 5205.7 03:08:00 INFO - PROCESS | 1958 | 03:08:00 INFO - PROCESS | 1958 | [#4] prototype.html Cycles:180 Average:4705.38 Median:5048.48 stddev:1483.41 (29.4%) stddev-sans-first:1449.43 03:08:00 INFO - PROCESS | 1958 | Values: 252.3 303.6 307.1 317.9 318.0 4715.0 5320.9 5500.6 5720.9 5767.6 5498.5 5577.3 5593.4 5640.5 5672.6 3574.5 3783.9 4336.9 4365.3 4387.4 4191.8 4282.4 4296.2 4333.9 4390.5 4240.2 4249.6 4258.2 4285.7 4294.3 3831.6 4004.9 4284.8 4318.0 4345.2 3544.2 3547.8 3728.5 3756.2 3760.7 4523.5 4552.6 4793.7 5426.5 5465.3 4361.3 4543.4 4728.7 4778.0 4948.8 5482.5 5938.8 5955.2 6001.7 6011.7 3935.7 3964.3 3975.4 3978.1 3982.2 4870.4 5595.7 6150.4 6242.3 6245.3 3357.4 3835.7 4005.4 4019.8 4043.2 3788.3 3995.6 4056.7 4076.9 4078.7 4793.4 4808.6 4811.5 4815.6 4828.5 5358.1 5412.9 5982.1 5990.2 6106.4 1159.5 1340.4 1348.5 1390.9 1392.2 808.2 828.4 849.0 850.7 854.8 4568.5 4627.6 4665.3 4671.8 4672.4 4792.9 4856.5 4945.7 4983.7 5028.0 4222.3 4298.7 4419.2 4496.6 4546.2 2619.8 2639.2 2947.9 3193.6 3242.9 6143.4 6286.7 6349.3 6404.5 6463.7 5740.3 5811.2 5813.3 6208.3 6340.4 5982.1 6188.8 6271.5 6298.3 6341.9 5832.3 5921.3 6066.7 6081.3 6090.7 5575.4 5926.4 6018.7 6021.7 6069.5 6350.4 6351.0 6383.4 6421.3 6425.9 3710.8 3981.6 3993.3 4012.3 4044.1 5958.7 6076.2 6111.6 6167.4 6227.2 5261.9 5265.8 5327.3 5527.8 5972.7 5278.2 5364.6 5667.6 5759.4 6012.8 5776.3 5778.4 5790.0 5821.7 5832.9 4923.0 5270.5 5404.0 5605.2 5950.4 5069.0 5729.1 5771.6 5777.8 5791.4 03:08:00 INFO - PROCESS | 1958 | 03:08:00 INFO - PROCESS | 1958 | [#5] yui.html Cycles:180 Average:24364.59 Median:3829.16 stddev:39472.50 (1030.8%) stddev-sans-first:39542.98 03:08:00 INFO - PROCESS | 1958 | Values: 621.7 720.4 732.9 733.5 774.2 15190.5 15857.8 15940.3 16025.4 16168.8 13895.0 14420.4 14626.8 14698.9 14727.4 866.3 892.3 895.7 897.4 901.4 712.5 858.1 889.7 894.4 902.2 876.5 917.8 937.2 937.3 937.5 870.5 872.2 908.7 934.9 940.5 649.6 663.6 679.2 697.9 698.0 14574.2 14766.3 14973.9 14984.1 15002.8 14656.0 14790.3 14834.4 14942.3 15144.8 10312.9 11818.8 12033.2 12217.0 12471.7 3930.9 3961.3 4002.3 4105.1 4105.4 91000.5 121317.0 122512.0 122891.0 123187.2 10736.8 11360.8 11379.5 11384.2 11385.6 18911.4 23010.0 23763.6 23831.3 23867.4 7718.3 7856.1 7936.1 8075.8 8094.7 3727.4 4305.8 4439.0 4444.0 4567.7 2970.5 3209.5 3392.6 3488.9 3504.2 529.3 659.7 660.9 664.8 673.8 591.2 605.2 617.8 677.6 725.8 9144.0 9173.7 9651.4 9662.0 9890.4 550.3 593.4 638.6 662.8 686.3 4614.6 4767.0 4858.9 4865.2 4913.2 162774.0 165232.3 166315.0 170332.0 173882.0 61400.7 89001.7 89242.1 90662.0 128887.0 72448.6 75164.2 75819.5 109478.0 125806.0 9394.2 9407.9 9432.7 9467.3 9496.2 61111.8 63464.0 64022.0 64133.0 64459.7 87490.6 102183.0 105550.5 105994.5 107422.9 11513.6 11523.3 11583.8 11953.2 12053.5 12056.4 12640.4 13725.8 13875.4 14253.6 12015.3 12095.6 13455.6 14077.6 14077.9 13954.9 14159.7 14243.6 14251.3 14256.7 13381.0 13395.8 13538.9 13724.8 14127.6 10978.6 11341.4 11571.0 11738.3 11739.0 9632.6 11319.5 11422.2 11428.4 11704.9 03:08:00 INFO - PROCESS | 1958 | -------- Summary: end -------- 03:08:00 INFO - PROCESS | 1958 | 03:08:00 INFO - TEST-INFO | 1958: exit 0 03:08:00 INFO - TEST-OK | dromaeo_css | took 1112875ms 03:08:00 INFO - TEST-START | kraken 03:08:00 INFO - operating with platform_type : mac_ 03:08:00 INFO - Initialising browser for kraken test... 03:08:00 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpLJ_y3h/profile http://localhost:50334/getInfo.html) 03:08:03 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 03:08:03 INFO - PROCESS | 1964 | colorDepth:24 03:08:03 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 03:08:03 INFO - PROCESS | 1964 | __metrics 03:08:03 ERROR - PROCESS | 1964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:08:04 INFO - TEST-INFO | 1964: exit 0 03:08:04 INFO - Browser initialized. 03:08:04 INFO - Running cycle 1/1 for kraken test... 03:08:04 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpLJ_y3h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:16 INFO - PROCESS | 1966 | RSS: Main: 254439424 03:08:16 INFO - PROCESS | 1966 | 03:08:19 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:20 INFO - PROCESS | 1966 | RSS: Main: 267411456 03:08:20 INFO - PROCESS | 1966 | 03:08:23 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-dft) 03:08:23 INFO - PROCESS | 1966 | RSS: Main: 276230144 03:08:23 INFO - PROCESS | 1966 | 03:08:27 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-fft) 03:08:28 INFO - PROCESS | 1966 | RSS: Main: 279142400 03:08:28 INFO - PROCESS | 1966 | 03:08:30 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-oscillator) 03:08:30 INFO - PROCESS | 1966 | RSS: Main: 280584192 03:08:30 INFO - PROCESS | 1966 | 03:08:33 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:33 INFO - PROCESS | 1966 | RSS: Main: 282296320 03:08:33 INFO - PROCESS | 1966 | 03:08:36 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50334/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:37 INFO - PROCESS | 1966 | RSS: Main: 282820608 03:08:37 INFO - PROCESS | 1966 | 03:08:40 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50334/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:40 INFO - PROCESS | 1966 | RSS: Main: 283312128 03:08:40 INFO - PROCESS | 1966 | 03:08:43 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50334/tests/kraken/driver.html?testName=json-parse-financial) 03:08:44 INFO - PROCESS | 1966 | RSS: Main: 283377664 03:08:44 INFO - PROCESS | 1966 | 03:08:46 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:46 INFO - PROCESS | 1966 | RSS: Main: 283021312 03:08:46 INFO - PROCESS | 1966 | 03:08:48 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:49 INFO - PROCESS | 1966 | RSS: Main: 282849280 03:08:49 INFO - PROCESS | 1966 | 03:08:51 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:52 INFO - PROCESS | 1966 | RSS: Main: 283099136 03:08:52 INFO - PROCESS | 1966 | 03:08:55 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:08:55 INFO - PROCESS | 1966 | RSS: Main: 283176960 03:08:55 INFO - PROCESS | 1966 | 03:08:58 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:08:59 INFO - PROCESS | 1966 | RSS: Main: 283209728 03:08:59 INFO - PROCESS | 1966 | 03:09:00 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50334/tests/kraken/driver.html?testName=ai-astar) 03:09:01 INFO - PROCESS | 1966 | RSS: Main: 284262400 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | __start_tp_report 03:09:01 INFO - PROCESS | 1966 | _x_x_mozilla_page_load 03:09:01 INFO - PROCESS | 1966 | _x_x_mozilla_page_load_details 03:09:01 INFO - PROCESS | 1966 | |i|pagename|runs| 03:09:01 INFO - PROCESS | 1966 | |0;ai-astar;104;116;109;119;118;118;115;131;108;177 03:09:01 INFO - PROCESS | 1966 | |1;audio-beat-detection;139;111;133;160;107;127;125;130;204;111 03:09:01 INFO - PROCESS | 1966 | |2;audio-dft;175;234;264;255;193;269;276;198;275;196 03:09:01 INFO - PROCESS | 1966 | |3;audio-fft;81;121;67;185;52;61;77;82;149;56 03:09:01 INFO - PROCESS | 1966 | |4;audio-oscillator;70;71;123;102;100;88;118;72;72;114 03:09:01 INFO - PROCESS | 1966 | |5;imaging-gaussian-blur;89;86;101;87;90;86;101;114;88;86 03:09:01 INFO - PROCESS | 1966 | |6;imaging-darkroom;95;95;97;95;116;128;150;97;149;151 03:09:01 INFO - PROCESS | 1966 | |7;imaging-desaturate;86;147;142;95;92;114;119;91;93;90 03:09:01 INFO - PROCESS | 1966 | |8;json-parse-financial;55;57;59;54;56;54;55;56;50;57 03:09:01 INFO - PROCESS | 1966 | |9;json-stringify-tinderbox;66;69;67;69;77;75;87;97;73;71 03:09:01 INFO - PROCESS | 1966 | |10;stanford-crypto-aes;87;88;96;108;81;89;86;84;87;81 03:09:01 INFO - PROCESS | 1966 | |11;stanford-crypto-ccm;140;139;140;138;138;137;140;136;171;157 03:09:01 INFO - PROCESS | 1966 | |12;stanford-crypto-pbkdf2;165;169;164;166;179;167;166;167;164;168 03:09:01 INFO - PROCESS | 1966 | |13;stanford-crypto-sha256-iterative;67;69;65;68;73;67;69;69;69;87 03:09:01 INFO - PROCESS | 1966 | __end_tp_report 03:09:01 INFO - PROCESS | 1966 | __start_cc_report 03:09:01 INFO - PROCESS | 1966 | _x_x_mozilla_cycle_collect,1048 03:09:01 INFO - PROCESS | 1966 | __end_cc_report 03:09:01 INFO - PROCESS | 1966 | __startTimestamp1470391741229__endTimestamp 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | ------- Summary: start ------- 03:09:01 INFO - PROCESS | 1966 | Number of tests: 14 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#0] ai-astar Cycles:10 Average:121.50 Median:118.00 stddev:20.87 (17.7%) stddev-sans-first:21.15 03:09:01 INFO - PROCESS | 1966 | Values: 104.0 116.0 109.0 119.0 118.0 118.0 115.0 131.0 108.0 177.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:131.50 stddev:28.93 (22.0%) stddev-sans-first:30.64 03:09:01 INFO - PROCESS | 1966 | Values: 139.0 111.0 133.0 160.0 107.0 127.0 125.0 130.0 204.0 111.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#2] audio-dft Cycles:10 Average:233.50 Median:259.50 stddev:39.31 (15.2%) stddev-sans-first:35.55 03:09:01 INFO - PROCESS | 1966 | Values: 175.0 234.0 264.0 255.0 193.0 269.0 276.0 198.0 275.0 196.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#3] audio-fft Cycles:10 Average:93.10 Median:64.00 stddev:44.29 (69.2%) stddev-sans-first:46.76 03:09:01 INFO - PROCESS | 1966 | Values: 81.0 121.0 67.0 185.0 52.0 61.0 77.0 82.0 149.0 56.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:70.50 stddev:21.12 (30.0%) stddev-sans-first:20.70 03:09:01 INFO - PROCESS | 1966 | Values: 70.0 71.0 123.0 102.0 100.0 88.0 118.0 72.0 72.0 114.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:86.50 stddev:9.44 (10.9%) stddev-sans-first:9.91 03:09:01 INFO - PROCESS | 1966 | Values: 89.0 86.0 101.0 87.0 90.0 86.0 101.0 114.0 88.0 86.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#6] imaging-darkroom Cycles:10 Average:117.30 Median:95.00 stddev:25.04 (26.4%) stddev-sans-first:25.22 03:09:01 INFO - PROCESS | 1966 | Values: 95.0 95.0 97.0 95.0 116.0 128.0 150.0 97.0 149.0 151.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#7] imaging-desaturate Cycles:10 Average:106.90 Median:90.50 stddev:22.53 (24.9%) stddev-sans-first:22.59 03:09:01 INFO - PROCESS | 1966 | Values: 86.0 147.0 142.0 95.0 92.0 114.0 119.0 91.0 93.0 90.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:2.41 (4.3%) stddev-sans-first:2.55 03:09:01 INFO - PROCESS | 1966 | Values: 55.0 57.0 59.0 54.0 56.0 54.0 55.0 56.0 50.0 57.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#9] json-stringify-tinderbox Cycles:10 Average:75.10 Median:74.00 stddev:9.83 (13.3%) stddev-sans-first:9.85 03:09:01 INFO - PROCESS | 1966 | Values: 66.0 69.0 67.0 69.0 77.0 75.0 87.0 97.0 73.0 71.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:87.00 stddev:8.03 (9.2%) stddev-sans-first:8.49 03:09:01 INFO - PROCESS | 1966 | Values: 87.0 88.0 96.0 108.0 81.0 89.0 86.0 84.0 87.0 81.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:140.00 stddev:11.33 (8.1%) stddev-sans-first:11.94 03:09:01 INFO - PROCESS | 1966 | Values: 140.0 139.0 140.0 138.0 138.0 137.0 140.0 136.0 171.0 157.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.00 stddev:4.35 (2.6%) stddev-sans-first:4.52 03:09:01 INFO - PROCESS | 1966 | Values: 165.0 169.0 164.0 166.0 179.0 167.0 166.0 167.0 164.0 168.0 03:09:01 INFO - PROCESS | 1966 | 03:09:01 INFO - PROCESS | 1966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:69.00 stddev:6.22 (9.0%) stddev-sans-first:6.48 03:09:01 INFO - PROCESS | 1966 | Values: 67.0 69.0 65.0 68.0 73.0 67.0 69.0 69.0 69.0 87.0 03:09:01 INFO - PROCESS | 1966 | -------- Summary: end -------- 03:09:01 INFO - PROCESS | 1966 | 03:09:02 INFO - TEST-INFO | 1966: exit 0 03:09:02 INFO - TEST-OK | kraken | took 61186ms 03:09:02 INFO - SUITE-END | took 1174s 03:09:02 INFO - Completed test suite (00:19:34) 03:09:02 INFO - javascript benchmark 03:09:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7337.472034876832, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2833.773298136149, 2845.0753505110833, 3191.5372271020715, 3294.9505757413644, 3407.2163402417436, 4978.676386034915, 5482.80810171644, 5659.066254068074, 5830.621009634371, 5853.004989151844, 5759.337676167242, 5797.884042319151, 5804.506616937555, 5878.823635290937, 5890.911636325459, 5160.767765450545, 5259.184826351921, 5273.077211487975, 5328.760205790749, 5356.54469370102, 5351.491608297206, 5370.301860758096, 5375.784968601251, 5384.461553844604, 5416.837494875141, 4915.557599816016, 5187.688738675692, 5248.842534723926, 5344.5724342052545, 5348.572114230852, 5273.31446911899, 5299.072662284085, 5303.178007408857, 5315.44187860273, 5322.680639161624, 5158.613104017214, 5221.708270196972, 5258.605604579634, 5282.10204265272, 5293.6294459387855, 4465.68740188187, 5503.3395992481155, 5696.202531645573, 5803.303603567557, 5897.675627840467, 6205.027938505515, 6213.316535181127, 6260.966940454819, 6278.937210627881, 6291.1192433059405, 6150.077488376779, 6248.50011999039, 6263.060540918898, 6269.561130720851, 6277.435030847246, 5808.506276966463, 5898.0, 5921.111833225008, 5944.048952167633, 5989.520838332923, 6296.028159872164, 6328.303886572473, 6336.398042185985, 6342.112104305401, 6364.0, 6114.38856114385, 6153.569250152446, 6225.128482012522, 6240.157578726905, 6261.530385221126, 6143.696113957266, 6177.135201071854, 6193.876122477525, 6196.690165491707, 6233.812985610439, 6199.318075011745, 6271.717772700148, 6277.18396608438, 6289.213848268966, 6294.8111556653375, 5853.560982926298, 6242.875142497124, 6265.96867015662, 6306.148669929593, 6316.62100273985, 4096.897577560525, 4914.311996320518, 5015.949840501621, 5032.144535428986, 5049.974750126225, 4463.486699029589, 4545.477270113979, 4555.63554915606, 4567.383403240587, 4575.405197324327, 5127.256547800548, 5749.9937510935415, 5840.620359676607, 5902.144189092557, 5941.168236446901, 6172.938270617326, 6192.59748116371, 6201.937980620226, 6204.286507051746, 6250.843728906813, 5879.823605291848, 5889.646621202742, 5905.320888097838, 5921.407859214044, 5966.791162309299, 5520.1167813149705, 5528.55771538276, 5533.114701647717, 5551.444855514497, 5562.0, 6200.503959683215, 6264.968675156595, 6276.843078923063, 6330.873382532415, 6424.71088801005, 6245.68771561411, 6249.218847644044, 6250.874982500415, 6267.96866015667, 6268.874622507433, 6347.174867267226, 6377.7130029147875, 6391.552591318563, 6416.165898433361, 6425.068365086942, 4752.500987396274, 4835.419749630067, 6102.943731970988, 6150.985087460519, 6249.96875015622, 5231.869203269796, 6255.343188965093, 6268.905966410599, 6270.811875643738, 6272.5922815016875, 4776.474587795409, 6199.690015499297, 6212.72042758086, 6232.626042437469, 6241.157443745036, 6107.297660768891, 6122.337166850181, 6151.66165860864, 6152.169457123231, 6233.532485063548, 5535.225068490334, 5653.925754106706, 5730.455606717355, 5975.25309336333, 6122.234720659918, 5243.737813109406, 6177.567570270217, 6180.969095154495, 6251.374862513894, 6267.0, 5943.702814859326, 6016.42843929826, 6059.909101363395, 6101.237345331833, 6164.722587483484], "value": 5690.691833505488, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.6740281802738, 497.2714972565191, 520.4691214960737, 530.5039787798411, 536.6833568194766, 35945.28109437809, 41509.58490415095, 41553.0, 41590.58409415905, 41737.58262417379, 42088.73733787991, 42896.57103428973, 42913.35629965553, 42925.78537107318, 42931.78534107325, 9683.273754468408, 9862.556184971694, 9897.059779320953, 9899.208063354914, 9904.00959904011, 9728.270379721514, 9820.852687209697, 9822.557984890696, 9829.4102353859, 9854.211663066973, 9825.65610203643, 9835.360701554411, 9841.26190535709, 9858.802823943517, 9882.901170988305, 9761.707148785548, 9768.169705575, 9808.901910980905, 9809.852852207223, 9871.062249086326, 8431.114732953074, 9630.711078667651, 9662.17871480925, 9711.951440242754, 9718.514074296258, 40051.0, 40165.39751903724, 40535.0, 40598.79700601478, 40643.390349144785, 3050.2526880914097, 3333.866645334184, 3381.340638575479, 3444.639367449868, 3455.1707590178175, 30868.845655771576, 31016.689833101605, 31376.744930202763, 31377.686223137705, 31431.685683143103, 3124.5000799872137, 3135.608048993876, 3150.4329220740256, 3167.825769582672, 3223.2908760072746, 437236.0, 439433.0, 440527.0, 442113.789431054, 442474.0, 32178.0, 32294.83852580769, 32368.514472282935, 32398.676013240038, 32413.675863241067, 34598.0, 35005.64994350024, 35268.11829704227, 35619.0, 35826.46260306097, 13600.591982240549, 15963.760543591856, 16113.597160070858, 16126.193690315436, 16142.273597688132, 10744.516496757664, 11680.948714615726, 12305.692357691129, 12333.075019373582, 12439.191452555555, 19291.4212573623, 19417.708734368713, 19504.70742938857, 19511.024448777505, 19551.413457596296, 7776.7278145264645, 7867.881981770278, 7927.423587334024, 7938.087119981161, 7950.204979502119, 875.772299202212, 895.6596493332491, 996.7259003773875, 1011.2466212671607, 1110.7722916802036, 25184.740762962145, 29619.555706664418, 30617.261744161893, 30660.38679226403, 31385.37229255448, 1017.0388982411698, 1048.4862417415563, 1053.1048608682559, 1065.3661071662348, 1105.7567335186245, 15430.0, 15551.455699050479, 15584.298706558233, 15637.218139093, 15664.494078371985, 711678.0, 734085.0, 734659.0, 735177.0, 736265.0, 58549.414505855246, 58672.706636466544, 58847.0, 59077.70461147667, 59124.0, 1348.366267854107, 1363.1889026029496, 1397.6086695725214, 1400.698849747289, 1402.3759427054863, 27335.04327348533, 29291.68187431528, 29340.413191735617, 29556.852215738785, 30106.69893301039, 51113.0, 51375.0, 51990.74004629953, 51992.0, 52054.479455204964, 661435.0, 665637.0, 667201.663991677, 668404.657976707, 671120.0, 24559.38601534976, 25387.61918571186, 25797.3550661235, 25863.482730345662, 25878.87060564685, 46921.53078469171, 47643.523564763906, 48107.75946120247, 48419.757901210265, 48927.26609100795, 34265.972020839414, 34755.13112172216, 39926.0, 40170.59829401786, 41063.794681026404, 34823.47764783581, 38682.22635547217, 38809.641662541675, 39320.60679393284, 40220.39669404903, 31698.524522131724, 35731.46402804012, 37887.43168852414, 38419.0, 38672.80663596664, 27067.052653157047, 33257.0, 33262.5010624836, 33418.665813341555, 33650.99047028593, 25470.490590188463, 25534.48931021332, 25847.095351662603, 25867.741322587288, 26183.214503564162], "value": 19393.831798522464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.46923134533284, 378.61759622780994, 387.7344019346747, 400.643427349659, 406.5487309086913, 17874.731879021823, 18423.35518256861, 20732.689009664868, 20842.166313347447, 21050.578988420242, 19285.517862053457, 19338.226470941147, 19392.321268755597, 19749.60500789987, 20365.389038328838, 5317.41508434072, 5606.6636001840025, 5905.734241959122, 5981.9700901495435, 6020.307664618581, 4113.814878330468, 6288.968555157217, 6556.770513032045, 6603.570767900095, 6686.197656281253, 6479.83800404989, 6516.446102081329, 6524.967375163117, 6603.966980165116, 6630.933690663104, 6333.20834895638, 6455.322191169954, 6498.317676643932, 6577.046328282396, 6605.471562275006, 5385.623006389555, 5546.833594992157, 5582.609217354787, 5601.271834661508, 5608.411116832755, 24856.87571562149, 25060.749392506023, 25358.746412535824, 25553.616695749577, 25958.87020564885, 2216.0803266644325, 2235.2065016918923, 2236.1167338901205, 2277.9544409111727, 2305.5158416732506, 15358.0, 15537.30082146306, 15643.061416315057, 15784.921075394665, 16067.196640167946, 1830.2404502131599, 1943.1935746665117, 1944.202876820511, 1951.248769223859, 1958.8139126782933, 113322.30016549758, 114497.42751286273, 115333.0, 115741.52775416752, 116077.0, 10291.279610427198, 10533.683989480327, 10893.618723344645, 10903.018728314331, 11068.0, 13050.934745326213, 13175.802362964563, 13257.138286011379, 13271.66820829487, 13285.93357033228, 8116.35069194463, 8228.62971166299, 8331.33349332052, 8459.196376344238, 8476.703315384055, 8274.338052955749, 8288.958555207306, 8323.66705331792, 8394.958025209835, 8442.831143377098, 5763.308402991668, 6325.114483972247, 6484.092227088211, 6579.703913323912, 6634.966825165843, 1679.3366620184959, 1737.1314342828587, 1839.2363777815256, 1870.8690391672453, 1871.1766822598013, 937.4750139921666, 957.1479187771545, 992.2161492421051, 998.4807899892161, 1039.870016247969, 21068.699253690724, 21853.23197694658, 21893.523518491587, 21933.08364793359, 21938.882403998647, 950.6530116507425, 971.2763990826879, 1015.223354134088, 1064.38213914849, 1067.428925524856, 11381.317120972768, 11554.826677599844, 11718.003969662504, 11835.526578936746, 12158.0, 623129.0, 628149.0, 635096.0, 639578.0, 646305.0, 68670.65664671645, 94774.52612736892, 108572.0, 109107.45446272718, 111112.44443777729, 1003.5283416794096, 1003.8193125237382, 1016.4409574733867, 1018.994905025485, 1022.4989755019986, 18543.0, 18700.438986830417, 18764.93585705544, 18885.339013134475, 19059.42821715351, 39871.00322491961, 47576.42365573318, 48842.77893052702, 49849.750751246014, 50641.0, 66766.66616666886, 69608.0, 70001.64999174971, 70651.64674176596, 72319.63840180765, 7886.526808391515, 7945.920540794749, 8102.392320576098, 8153.0, 8307.709230176915, 12976.935115324362, 13146.474141034252, 13307.06850520493, 13439.328033598476, 13655.522056727967, 10991.016909638294, 11298.887011129784, 11447.942760286145, 11690.006349460391, 11750.58872939443, 8546.316294696533, 11213.439328033728, 11461.656150315504, 11503.884961150281, 11566.65300041, 11462.484188211383, 11476.368799716096, 11574.942125289319, 11856.525738970344, 11983.161178717406, 6672.797976667785, 6831.180258369028, 7356.558606483414, 8021.63902624395, 8281.95859020701, 10564.524596393027, 11253.943730281297, 11412.885871141183, 11552.133589980616, 11564.768704625692], "value": 9724.417673028816, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.6771110355721, 1487.122597667376, 1641.4419097506845, 1765.4880084775416, 1779.528424967383, 7921.326687231593, 8406.159384061599, 8537.786555336119, 8949.597268122941, 9005.0, 7076.752313669022, 8598.527081010541, 8806.735797926056, 8807.471551706902, 8818.250448711868, 2323.616603260464, 2350.1539445799585, 2362.574736547421, 2373.9762602373926, 2374.9168779092734, 2042.5404284036047, 2299.574578702937, 2324.721033475985, 2364.3025307534317, 2374.76252374762, 2337.5091230841545, 2343.5430091132234, 2352.5882970480184, 2364.798992085666, 2375.2517956843626, 2317.29322556621, 2327.080803082773, 2333.2067097186955, 2347.3427440316655, 2354.6703461515403, 2342.2504798464497, 2345.8006069484113, 2347.0963678983544, 2351.5061837014246, 2367.993602718838, 8711.695090671796, 8831.955840220822, 8878.200961913395, 8907.331950103768, 8938.10618938101, 5134.1528647773075, 5153.433122356538, 5244.318238628954, 5316.813911513079, 5325.121354976424, 3116.9869792317586, 3415.316936612687, 3541.1501239702284, 3580.6777390034763, 3640.453931910208, 1035.2057096097917, 1072.8873468285797, 1073.420353009374, 1075.93006454581, 1088.6516314779274, 9917.404955702608, 11370.886291137065, 11471.369074700804, 11475.0, 11619.825702614384, 4244.448221731217, 4497.64018878489, 4728.503507131771, 4744.240921452551, 4779.904401911942, 9765.853512197322, 9883.061109194616, 9895.65365212214, 9910.20718342531, 9915.950420247853, 4509.751963642031, 5212.244224587489, 5280.419153893069, 5282.630215884851, 5289.867753306198, 4369.628581570539, 4718.9292160617615, 4841.903161936812, 4866.343043689128, 4875.414950205998, 3913.804309784556, 3985.123272879962, 4001.139754952699, 4048.817803198863, 4083.9387409188885, 1245.9314737689333, 1247.3015111537568, 1253.6113804720567, 1254.9811752823714, 1257.7798885195054, 827.2596026556319, 921.9078092190728, 925.9305552083621, 938.4088024544493, 967.6226271754022, 5958.493528050078, 6075.75696972125, 6094.756209751649, 6149.13912052313, 6153.538484613672, 374.11148522259634, 414.06834622100274, 423.1705856521253, 423.45585922089964, 429.0239704671834, 4038.5153781545814, 4076.103257283393, 4091.8772436826944, 4151.4395556599475, 4165.812538435777, 8125.553094579855, 9846.60613575449, 9964.153046990941, 9972.252081093948, 9976.15202707778, 9921.305508614472, 9927.007299270159, 9965.80068398628, 9969.900300996896, 9990.650327238513, 7430.0, 7439.888401673979, 7628.466007379541, 7696.576688282086, 7701.3068823806125, 5588.888222235614, 5598.748056337556, 5666.603337766317, 5747.655140691572, 5749.1663708762835, 9083.18251357381, 9145.0, 9211.0, 9239.584218710308, 9342.0, 8168.918310816815, 9133.041030691682, 9285.814283714422, 9398.0, 9470.715878523655, 6952.374286314256, 7159.8926016110845, 7218.27817218274, 7331.890021649786, 7505.437092217996, 8432.45189062709, 8505.404621676671, 8505.489670619783, 8525.829483410422, 8545.2309292164, 7199.676014579251, 7385.409167266714, 7545.6981720730555, 7614.847703046019, 7627.771166865003, 7238.746643867439, 7370.815729606803, 7427.851442971002, 7516.173220945801, 7528.849423011399, 6889.207741109836, 6916.515843890879, 6985.860282794214, 6987.825304367431, 6991.335823096798, 4984.850454486371, 4999.575036121971, 5077.162268225701, 5155.690658560348, 5195.870103247449, 5100.770465328995, 5139.100657385017, 5175.637705360588, 5193.11717008102, 5205.687658740488], "value": 4421.860038587531, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.31622303557359, 303.6280556318509, 307.0940724861659, 317.9030395729304, 318.04110606521334, 4714.9528504714945, 5320.866978325539, 5500.5874559408, 5720.856978575533, 5767.5962682612235, 5498.477644623765, 5577.274954255951, 5593.440655934404, 5640.5487560995125, 5672.602917795756, 3574.481700153476, 3783.905402364949, 4336.913261734763, 4365.301551751721, 4387.407699960512, 4191.7694526801015, 4282.379055037018, 4296.162248361571, 4333.891652708676, 4390.538993405694, 4240.194363071022, 4249.596288352602, 4258.190943720683, 4285.678574106939, 4294.291441912081, 3831.5861007565336, 4004.919901601966, 4284.807183676727, 4318.042141133303, 4345.1961387143165, 3544.2379888324135, 3547.840347184383, 3728.496652951871, 3756.211195648917, 3760.736748427611, 4523.525029871882, 4552.567506086916, 4793.716304331544, 5426.538744206747, 5465.262189604392, 4361.323994780814, 4543.363929049936, 4728.723244723905, 4778.0205057963385, 4948.758563141148, 5482.479164479368, 5938.782549577326, 5955.166276721263, 6001.66990815505, 6011.699415029275, 3935.681546681865, 3964.32606456903, 3975.363941769332, 3978.124812541236, 3982.18365235129, 4870.439899411542, 5595.664260144364, 6150.446459818638, 6242.250929888397, 6245.344238854946, 3357.4460214064407, 3835.712321575893, 4005.379166229239, 4019.7789121598007, 4043.1509383029893, 3788.2802267569623, 3995.62041606047, 4056.7363121397016, 4076.899237205997, 4078.6737061035637, 4793.352897358812, 4808.609929999412, 4811.49479304675, 4815.6147508199965, 4828.46886842447, 5358.132844535227, 5412.864678383072, 5982.055831854665, 5990.232881300027, 6106.374259068554, 1159.478234794346, 1340.4102195034154, 1348.501054609781, 1390.9026368154334, 1392.2064423278634, 808.1675873849944, 828.3745771942146, 848.9787755306044, 850.6767428377177, 854.833307505043, 4568.451785785661, 4627.629789616823, 4665.2768820832825, 4671.789769460383, 4672.369230153886, 4792.939036214461, 4856.465788763233, 4945.67853089548, 4983.700977941335, 5027.994401119718, 4222.282212023963, 4298.677599180074, 4419.204543182258, 4496.6177874881005, 4546.249693867885, 2619.816612837083, 2639.178966513138, 2947.8820847166303, 3193.6486986431473, 3242.8702851886133, 6143.385661433821, 6286.685665716695, 6349.269833969152, 6404.48764098871, 6463.741450342028, 5740.339860916049, 5811.2227052416265, 5813.302403711497, 6208.255009398901, 6340.365963403715, 5982.102684597346, 6188.845278867974, 6271.498280137578, 6298.307186209513, 6341.90487142684, 5832.334132693743, 5921.259842519685, 6066.696665166813, 6081.27024757032, 6090.665013424305, 5575.438877114414, 5926.377730338425, 6018.6689732063405, 6021.698915054318, 6069.514438844793, 6350.428461438492, 6351.0, 6383.425491705583, 6421.325760795049, 6425.947674854594, 3710.7959062251834, 3981.581933896899, 3993.281209382223, 4012.317905956053, 4044.090079732037, 5958.679957031118, 6076.210092687922, 6111.633302001894, 6167.414095660905, 6227.225240806349, 5261.947380526299, 5265.842024739264, 5327.280817089798, 5527.806526771544, 5972.731227094878, 5278.181881808326, 5364.597655175799, 5667.603267771216, 5759.39526349744, 6012.759489620366, 5776.306843178845, 5778.364379918122, 5789.9710501447225, 5821.679807610622, 5832.883342333044, 4922.981577553186, 5270.472952704852, 5403.972980135074, 5605.200640139962, 5950.434708702666, 5068.974655126848, 5729.054705973468, 5771.5671324649975, 5777.768889244383, 5791.420857914175], "value": 4218.569994488503, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.7083118837365, 720.4488566246822, 732.868083744926, 733.4645708632698, 774.2347447818968, 15190.468333608325, 15857.841421585781, 15940.282687279072, 16025.35898564056, 16168.757468637965, 13895.0, 14420.423183072664, 14626.780598291034, 14698.853011469882, 14727.410903563845, 866.319938848006, 892.2505095719595, 895.6820328783253, 897.3808072430035, 901.3555307954811, 712.4763298975249, 858.0947100808644, 889.6574818694817, 894.369469523984, 902.1700035966926, 876.4565969099167, 917.807260475301, 937.2361525356812, 937.2501998401286, 937.5265490927072, 870.5081628879663, 872.1757938747886, 908.6910450446846, 934.8691183234387, 940.4592359393376, 649.5907578225688, 663.6151032401195, 679.2222904774055, 697.8639165362756, 698.0471656189316, 14574.198419086946, 14766.335514901855, 14973.850261497464, 14984.100953942798, 15002.849971500254, 14656.0, 14790.260486975609, 14834.406623735145, 14942.327595258239, 15144.772828407582, 10312.948435257777, 11818.822717659155, 12033.157678962476, 12217.0, 12471.688207794878, 3930.8820735377985, 3961.2869683456966, 4002.3196056670436, 4105.055837157471, 4105.363668631367, 91000.54499727525, 121317.0, 122512.0, 122891.0, 123187.15219271719, 10736.818949915503, 11360.772784544428, 11379.487923043484, 11384.20310578268, 11385.601503947322, 18911.432657020312, 23009.964551595218, 23763.643545346833, 23831.285061448183, 23867.403314917265, 7718.343940764986, 7856.09654889695, 7936.087349954713, 8075.757727268191, 8094.676212951534, 3727.4408838674417, 4305.784710764449, 4438.955610443919, 4444.044530425974, 4567.748773817472, 2970.495015847311, 3209.4864821628425, 3392.6268110507826, 3488.930221395558, 3504.159001839591, 529.2722506553489, 659.7394029358377, 660.8546119853625, 664.8365360618917, 673.7944926797373, 591.1605520161381, 605.228333874305, 617.7992152550439, 677.5503340768284, 725.8004048886598, 9144.0, 9173.678921237724, 9651.420914745138, 9661.951690241503, 9890.406575605486, 550.2599004339237, 593.3858456497504, 638.5849198021323, 662.8210383196606, 686.3273991488369, 4614.607758340579, 4767.022760334124, 4858.927116093261, 4865.245886887538, 4913.1893237616105, 162774.0, 165232.3476765241, 166315.0, 170332.0, 173882.0, 61400.69299653473, 89001.66497502543, 89242.10757892468, 90662.0, 128887.0, 72448.63775681087, 75164.24835751682, 75819.48361032859, 109478.0, 125806.0, 9394.248460123037, 9407.85888211691, 9432.669856554987, 9467.34321493722, 9496.168334840853, 61111.77776444535, 63464.0, 64022.0, 64133.0, 64459.67770161119, 87490.56254718686, 102183.0, 105550.47224763827, 105994.47002764937, 107422.92577074129, 11513.59702410445, 11523.250988685708, 11583.8262426062, 11953.163278570417, 12053.457594408097, 12056.397180141134, 12640.43118059708, 13725.794113088512, 13875.375608097862, 14253.643658908195, 12015.339156346485, 12095.649783863542, 13455.596332110052, 14077.648058798612, 14077.859221407654, 13954.860451395356, 14159.716805664035, 14243.572692819233, 14251.287435628385, 14256.714865702836, 13381.0, 13395.799063013868, 13538.93230533841, 13724.794128088286, 14127.64680882986, 10978.560857565608, 11341.384623030468, 11571.0, 11738.295702257892, 11739.0, 9632.614695412105, 11319.547218111184, 11422.200445969034, 11428.37143957057, 11704.88295117072], "value": 7794.191925632979, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 109.0, 119.0, 118.0, 118.0, 115.0, 131.0, 108.0, 177.0], "value": 121.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 111.0, 133.0, 160.0, 107.0, 127.0, 125.0, 130.0, 204.0, 111.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 234.0, 264.0, 255.0, 193.0, 269.0, 276.0, 198.0, 275.0, 196.0], "value": 233.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 121.0, 67.0, 185.0, 52.0, 61.0, 77.0, 82.0, 149.0, 56.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 123.0, 102.0, 100.0, 88.0, 118.0, 72.0, 72.0, 114.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 101.0, 87.0, 90.0, 86.0, 101.0, 114.0, 88.0, 86.0], "value": 92.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 116.0, 128.0, 150.0, 97.0, 149.0, 151.0], "value": 117.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 147.0, 142.0, 95.0, 92.0, 114.0, 119.0, 91.0, 93.0, 90.0], "value": 106.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 59.0, 54.0, 56.0, 54.0, 55.0, 56.0, 50.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 69.0, 77.0, 75.0, 87.0, 97.0, 73.0, 71.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 96.0, 108.0, 81.0, 89.0, 86.0, 84.0, 87.0, 81.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 140.0, 138.0, 138.0, 137.0, 140.0, 136.0, 171.0, 157.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 164.0, 166.0, 179.0, 167.0, 166.0, 167.0, 164.0, 168.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 65.0, 68.0, 73.0, 67.0, 69.0, 69.0, 69.0, 87.0], "value": 70.3, "unit": "score"}]}]} 03:09:02 INFO - Return code: 0 03:09:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:09:02 ERROR - # TBPL SUCCESS # 03:09:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:02 INFO - 2016-08-05 03:09:02.516 screenresolution[1971:15297] starting screenresolution argv=screenresolution get 03:09:02 INFO - 2016-08-05 03:09:02.519 screenresolution[1971:15297] Display 0: 1600x1200x32@60 03:09:02 INFO - 2016-08-05 03:09:02.525 screenresolution[1972:15300] starting screenresolution argv=screenresolution list 03:09:02 INFO - Available Modes on Display 0 03:09:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:02 INFO - Intel Iris: 03:09:02 INFO - Chipset Model: Intel Iris 03:09:02 INFO - Type: GPU 03:09:02 INFO - Bus: Built-In 03:09:02 INFO - VRAM (Dynamic, Max): 1536 MB 03:09:02 INFO - Vendor: Intel (0x8086) 03:09:02 INFO - Device ID: 0x0a2e 03:09:02 INFO - Revision ID: 0x0009 03:09:02 INFO - Displays: 03:09:02 INFO - Display: 03:09:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:02 INFO - Display Serial Number: 1600x1200 60 03:09:02 INFO - Main Display: Yes 03:09:02 INFO - Mirror: Off 03:09:02 INFO - Online: Yes 03:09:02 INFO - Rotation: Supported 03:09:02 INFO - Return code: 0 03:09:02 INFO - Running post-action listener: _resource_record_post_action 03:09:02 INFO - [mozharness: 2016-08-05 10:09:02.762086Z] Finished run-tests step (success) 03:09:02 INFO - Running post-run listener: _resource_record_post_run 03:09:02 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 970752; Write bytes: 704961024; Read time: 8; Write time: 2040 03:09:02 INFO - TinderboxPrint: CPU usage
54.6% 03:09:02 INFO - TinderboxPrint: I/O read bytes / time
970,752 / 8 03:09:02 INFO - TinderboxPrint: I/O write bytes / time
704,961,024 / 2,040 03:09:02 INFO - TinderboxPrint: CPU idle
2,194.6 (45.4%) 03:09:02 INFO - TinderboxPrint: CPU system
982.5 (20.3%) 03:09:02 INFO - TinderboxPrint: CPU user
1,660.5 (34.3%) 03:09:02 INFO - TinderboxPrint: Swap in / out
403,554,304 / 0 03:09:02 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 394260992; Write bytes: 388462080; Read time: 29722; Write time: 848 03:09:02 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 970752; Write bytes: 298705920; Read time: 8; Write time: 1142 03:09:03 INFO - Running post-run listener: _upload_blobber_files 03:09:03 INFO - Blob upload gear active. 03:09:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:03 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 03:09:03 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:09:03 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:09:03 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:09:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:09:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:04 INFO - (blobuploader) - INFO - Done attempting. 03:09:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:09:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:09:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:05 INFO - (blobuploader) - INFO - Done attempting. 03:09:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:09:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:09:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:07 INFO - (blobuploader) - INFO - Done attempting. 03:09:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:07 INFO - Return code: 0 03:09:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac7b50e088386b04132de7e9461892feb78ea6dcb19be0063178e447fbefcadb6ee3438cc22edbb1325a87c60ab3607a2193b56be5f31f71c7d2e13677159a31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4365f1608aca3a8db2e07bd6ff05367c734837a3bfa9849fa632135c8395345a039647ee18b1601f272bc4b5bf860510da44afb6e5db4d0449d742b3f441e666", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adfb0971487f86b4d1340b9611313f3a256341dd2ade57a43cd80225015bc7e3415b22f0bbe7f009cc3be905545a825cde590bde2176be06e77d9dab6ae2c05a"} 03:09:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:07 INFO - Contents: 03:09:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac7b50e088386b04132de7e9461892feb78ea6dcb19be0063178e447fbefcadb6ee3438cc22edbb1325a87c60ab3607a2193b56be5f31f71c7d2e13677159a31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4365f1608aca3a8db2e07bd6ff05367c734837a3bfa9849fa632135c8395345a039647ee18b1601f272bc4b5bf860510da44afb6e5db4d0449d742b3f441e666", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adfb0971487f86b4d1340b9611313f3a256341dd2ade57a43cd80225015bc7e3415b22f0bbe7f009cc3be905545a825cde590bde2176be06e77d9dab6ae2c05a"} 03:09:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:07 INFO - Copying logs to upload dir... 03:09:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.507380 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-08-05 03:09:07.742049) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 03:09:07.745254) ========= 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.bBrV56WvhS/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.z4N4EGIpqw/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac7b50e088386b04132de7e9461892feb78ea6dcb19be0063178e447fbefcadb6ee3438cc22edbb1325a87c60ab3607a2193b56be5f31f71c7d2e13677159a31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4365f1608aca3a8db2e07bd6ff05367c734837a3bfa9849fa632135c8395345a039647ee18b1601f272bc4b5bf860510da44afb6e5db4d0449d742b3f441e666", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adfb0971487f86b4d1340b9611313f3a256341dd2ade57a43cd80225015bc7e3415b22f0bbe7f009cc3be905545a825cde590bde2176be06e77d9dab6ae2c05a"} build_url:https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/NfJ5ZgB1SuOtbyG2rzSFdw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac7b50e088386b04132de7e9461892feb78ea6dcb19be0063178e447fbefcadb6ee3438cc22edbb1325a87c60ab3607a2193b56be5f31f71c7d2e13677159a31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4365f1608aca3a8db2e07bd6ff05367c734837a3bfa9849fa632135c8395345a039647ee18b1601f272bc4b5bf860510da44afb6e5db4d0449d742b3f441e666", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adfb0971487f86b4d1340b9611313f3a256341dd2ade57a43cd80225015bc7e3415b22f0bbe7f009cc3be905545a825cde590bde2176be06e77d9dab6ae2c05a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 03:09:07.779033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 03:09:07.779410) ========= 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.bBrV56WvhS/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.z4N4EGIpqw/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.005112 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 03:09:07.829190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 03:09:07.829549) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 03:09:07.830232) ========= ========= Total master_lag: 0.24 =========