builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0078 starttime: 1470849299.37 results: success (0) buildid: 20160810070552 builduid: cf5ff9afe4b74e039620f2052869c8aa revision: 531100c1d950c8857dda172573fbd23360f7619b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 10:14:59.375252) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 10:14:59.375864) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 10:14:59.376149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 10:14:59.401442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 10:14:59.401789) ========= 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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-10 10:14:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 207M=0s 2016-08-10 10:14:59 (207 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084145 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 10:14:59.555566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 10:14:59.555841) ========= 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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.027123 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 10:14:59.608120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 10:14:59.608484) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 531100c1d950c8857dda172573fbd23360f7619b --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 531100c1d950c8857dda172573fbd23360f7619b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-10 10:14:59,683 truncating revision to first 12 chars 2016-08-10 10:14:59,683 Setting DEBUG logging. 2016-08-10 10:14:59,683 attempt 1/10 2016-08-10 10:14:59,683 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/531100c1d950?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 10:15:00,797 unpacking tar archive at: fx-team-531100c1d950/testing/mozharness/ program finished with exit code 0 elapsedTime=1.363511 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 10:15:00.991684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 10:15:00.991966) ========= script_repo_revision: 531100c1d950c8857dda172573fbd23360f7619b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 10:15:00.992351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 10:15:00.992616) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 10:15:01.011318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-08-10 10:15:01.011585) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:15:01 INFO - MultiFileLogger online at 20160810 10:15:01 in /builds/slave/test 10:15:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:15:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:01 INFO - {'append_to_log': False, 10:15:01 INFO - 'base_work_dir': '/builds/slave/test', 10:15:01 INFO - 'blob_upload_branch': 'Fx-Team', 10:15:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:01 INFO - 'branch': 'Fx-Team', 10:15:01 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:01 INFO - 'config_files': ('talos/mac_config.py',), 10:15:01 INFO - 'default_actions': ('clobber', 10:15:01 INFO - 'read-buildbot-config', 10:15:01 INFO - 'download-and-extract', 10:15:01 INFO - 'populate-webroot', 10:15:01 INFO - 'create-virtualenv', 10:15:01 INFO - 'install', 10:15:01 INFO - 'run-tests'), 10:15:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:01 INFO - 'download_minidump_stackwalk': True, 10:15:01 INFO - 'download_symbols': 'ondemand', 10:15:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:01 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:01 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:01 INFO - 'installer_path': 'installer.exe', 10:15:01 INFO - 'log_level': 'info', 10:15:01 INFO - 'log_name': 'talos', 10:15:01 INFO - 'log_to_console': True, 10:15:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:15:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:15:01 INFO - 'opt_config_files': (), 10:15:01 INFO - 'pip_index': False, 10:15:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:01 INFO - 'cmd': ('bash', 10:15:01 INFO - '-c', 10:15:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:01 INFO - 'enabled': True, 10:15:01 INFO - 'halt_on_failure': False, 10:15:01 INFO - 'name': 'check_screen_resolution'},), 10:15:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:01 INFO - 'cmd': ('bash', 10:15:01 INFO - '-c', 10:15:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:01 INFO - 'enabled': True, 10:15:01 INFO - 'halt_on_failure': False, 10:15:01 INFO - 'name': 'check_screen_resolution'},), 10:15:01 INFO - 'run_cmd_checks_enabled': True, 10:15:01 INFO - 'sps_profile': False, 10:15:01 INFO - 'sps_profile_interval': 0, 10:15:01 INFO - 'suite': 'dromaeojs', 10:15:01 INFO - 'system_bits': '32', 10:15:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:01 INFO - 'title': 't-yosemite-r7-0078', 10:15:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:01 INFO - 'use_talos_json': True, 10:15:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:01 INFO - 'work_dir': 'build'} 10:15:01 INFO - [mozharness: 2016-08-10 17:15:01.205719Z] Running clobber step. 10:15:01 INFO - Running pre-action listener: _resource_record_pre_action 10:15:01 INFO - Running main action method: clobber 10:15:01 INFO - rmtree: /builds/slave/test/build 10:15:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:03 INFO - Running post-action listener: _resource_record_post_action 10:15:03 INFO - [mozharness: 2016-08-10 17:15:03.258820Z] Finished clobber step (success) 10:15:03 INFO - [mozharness: 2016-08-10 17:15:03.258897Z] Running read-buildbot-config step. 10:15:03 INFO - Running pre-action listener: _resource_record_pre_action 10:15:03 INFO - Running main action method: read_buildbot_config 10:15:03 INFO - Using buildbot properties: 10:15:03 INFO - { 10:15:03 INFO - "project": "", 10:15:03 INFO - "product": "firefox", 10:15:03 INFO - "script_repo_revision": "production", 10:15:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:15:03 INFO - "repository": "", 10:15:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:15:03 INFO - "buildid": "20160810070552", 10:15:03 INFO - "pgo_build": "False", 10:15:03 INFO - "basedir": "/builds/slave/test", 10:15:03 INFO - "buildnumber": 116, 10:15:03 INFO - "slavename": "t-yosemite-r7-0078", 10:15:03 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:15:03 INFO - "platform": "yosemite_r7", 10:15:03 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 10:15:03 INFO - "branch": "fx-team", 10:15:03 INFO - "repo_path": "integration/fx-team", 10:15:03 INFO - "revision": "531100c1d950c8857dda172573fbd23360f7619b", 10:15:03 INFO - "stage_platform": "macosx64", 10:15:03 INFO - "builduid": "cf5ff9afe4b74e039620f2052869c8aa", 10:15:03 INFO - "slavebuilddir": "test" 10:15:03 INFO - } 10:15:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:15:03 INFO - Running post-action listener: _resource_record_post_action 10:15:03 INFO - [mozharness: 2016-08-10 17:15:03.262149Z] Finished read-buildbot-config step (success) 10:15:03 INFO - [mozharness: 2016-08-10 17:15:03.262281Z] Running download-and-extract step. 10:15:03 INFO - Running pre-action listener: _resource_record_pre_action 10:15:03 INFO - Running main action method: download_and_extract 10:15:03 INFO - mkdir: /builds/slave/test/build/tests 10:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:03 INFO - trying https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:15:03 INFO - Downloading https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/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 10:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/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 10:15:04 INFO - Downloaded 1199 bytes. 10:15:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:15:04 INFO - Using the following test package requirements: 10:15:04 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:15:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:15:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:15:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'jsshell-mac.zip'], 10:15:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:15:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:15:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:15:04 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:15:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:15:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:15:04 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:15:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:15: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')]} 10:15:04 INFO - trying https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:15:04 INFO - Downloading https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/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 10:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/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 10:15:05 INFO - Downloaded 16325990 bytes. 10:15: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'] 10:15: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 10:15:08 INFO - Return code: 0 10:15: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 10:15: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')]} 10:15:08 INFO - trying https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:15:08 INFO - Downloading https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/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 10:15:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/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 10:15:09 INFO - Downloaded 16325990 bytes. 10:15: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'] 10:15: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 10:15:12 INFO - Return code: 0 10:15: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')]} 10:15:12 INFO - trying https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:15:12 INFO - Downloading https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/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 10:15:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/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 10:15:13 INFO - Downloaded 14413719 bytes. 10:15: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'] 10:15: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 10:15:13 INFO - Return code: 0 10:15: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')]} 10:15:13 INFO - trying https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:15:13 INFO - Downloading https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/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 10:15:17 INFO - Downloaded 110931388 bytes. 10:15:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:15:17 INFO - mkdir: /builds/slave/test/properties 10:15:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:17 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:17 INFO - Contents: 10:15:17 INFO - build_url:https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:15:18 INFO - Running post-action listener: _resource_record_post_action 10:15:18 INFO - Running post-action listener: set_extra_try_arguments 10:15:18 INFO - [mozharness: 2016-08-10 17:15:18.120983Z] Finished download-and-extract step (success) 10:15:18 INFO - [mozharness: 2016-08-10 17:15:18.121100Z] Running populate-webroot step. 10:15:18 INFO - Running pre-action listener: _resource_record_pre_action 10:15:18 INFO - Running main action method: populate_webroot 10:15:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:18 INFO - '--tppagecycles', 10:15:18 INFO - '7'], 10:15:18 INFO - 'tests': ['tsvgm']}}, 10:15:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:18 INFO - 'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:18 INFO - 'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['damp', 'tps']}, 10:15:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:18 INFO - 'tests': ['damp', 'tps']}, 10:15:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['dromaeo_dom']}, 10:15:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['basic_compositor_video']}, 10:15:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:15:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['a11yr', 10:15:18 INFO - 'ts_paint', 10:15:18 INFO - 'tpaint', 10:15:18 INFO - 'sessionrestore', 10:15:18 INFO - 'sessionrestore_no_auto_restore', 10:15:18 INFO - 'tabpaint']}, 10:15:18 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:18 INFO - 'ts_paint', 10:15:18 INFO - 'tpaint', 10:15:18 INFO - 'sessionrestore', 10:15:18 INFO - 'sessionrestore_no_auto_restore', 10:15:18 INFO - 'tabpaint']}, 10:15:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:18 INFO - 'ts_paint', 10:15:18 INFO - 'tpaint', 10:15:18 INFO - 'sessionrestore', 10:15:18 INFO - 'sessionrestore_no_auto_restore', 10:15:18 INFO - 'tabpaint']}, 10:15:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:18 INFO - 'ts_paint', 10:15:18 INFO - 'tpaint', 10:15:18 INFO - 'sessionrestore', 10:15:18 INFO - 'sessionrestore_no_auto_restore', 10:15:18 INFO - 'tabpaint']}, 10:15:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['a11yr', 10:15:18 INFO - 'ts_paint', 10:15:18 INFO - 'tpaint', 10:15:18 INFO - 'sessionrestore', 10:15:18 INFO - 'sessionrestore_no_auto_restore', 10:15:18 INFO - 'tabpaint']}, 10:15:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['a11yr', 10:15:18 INFO - 'ts_paint', 10:15:18 INFO - 'tpaint', 10:15:18 INFO - 'sessionrestore', 10:15:18 INFO - 'sessionrestore_no_auto_restore', 10:15:18 INFO - 'tabpaint']}, 10:15:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['tsvgx', 10:15:18 INFO - 'tsvgr_opacity', 10:15:18 INFO - 'tart', 10:15:18 INFO - 'tscrollx', 10:15:18 INFO - 'cart']}, 10:15:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:18 INFO - 'tsvgr_opacity', 10:15:18 INFO - 'tart', 10:15:18 INFO - 'tscrollx', 10:15:18 INFO - 'cart']}, 10:15:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:18 INFO - 'talos_options': ['--disable-e10s'], 10:15:18 INFO - 'tests': ['tp5o']}, 10:15:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:18 INFO - 'tests': ['tp5o']}, 10:15:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:18 INFO - 'talos_options': ['--disable-e10s', 10:15:18 INFO - '--xperf_path', 10:15:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:18 INFO - 'tests': ['tp5n']}, 10:15:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:18 INFO - 'talos_options': ['--xperf_path', 10:15:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:18 INFO - 'tests': ['tp5n']}}, 10:15:18 INFO - 'talos.zip': {'path': '', 10:15:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:18 INFO - Running post-action listener: _resource_record_post_action 10:15:18 INFO - [mozharness: 2016-08-10 17:15:18.140333Z] Finished populate-webroot step (success) 10:15:18 INFO - [mozharness: 2016-08-10 17:15:18.140444Z] Running create-virtualenv step. 10:15:18 INFO - Running pre-action listener: _resource_record_pre_action 10:15:18 INFO - Running main action method: create_virtualenv 10:15:18 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:15:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:18 INFO - Using real prefix '/tools/python27' 10:15:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:19 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:21 INFO - Installing pip.................done. 10:15:21 INFO - Return code: 0 10:15:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:21 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 0x10a212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2a7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4e05926f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, '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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:15:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:15:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:21 INFO - 'HOME': '/Users/cltbld', 10:15:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:21 INFO - 'LOGNAME': 'cltbld', 10:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:21 INFO - 'MOZ_NO_REMOTE': '1', 10:15:21 INFO - 'NO_EM_RESTART': '1', 10:15:21 INFO - 'PAGER': '/bin/cat', 10:15:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:21 INFO - 'PWD': '/builds/slave/test', 10:15:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:21 INFO - 'SHELL': '/bin/bash', 10:15:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:15:21 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:15:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:21 INFO - 'USER': 'cltbld', 10:15:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:21 INFO - 'XPC_FLAGS': '0x0', 10:15:21 INFO - 'XPC_SERVICE_NAME': '0', 10:15:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:15:22 INFO - Cleaning up... 10:15:22 INFO - Return code: 0 10:15:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2a7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4e05926f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, '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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:15:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:15:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:22 INFO - 'HOME': '/Users/cltbld', 10:15:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:22 INFO - 'LOGNAME': 'cltbld', 10:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:22 INFO - 'MOZ_NO_REMOTE': '1', 10:15:22 INFO - 'NO_EM_RESTART': '1', 10:15:22 INFO - 'PAGER': '/bin/cat', 10:15:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:22 INFO - 'PWD': '/builds/slave/test', 10:15:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:22 INFO - 'SHELL': '/bin/bash', 10:15:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:15:22 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:15:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:22 INFO - 'USER': 'cltbld', 10:15:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:22 INFO - 'XPC_FLAGS': '0x0', 10:15:22 INFO - 'XPC_SERVICE_NAME': '0', 10:15:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:22 INFO - Downloading/unpacking psutil>=3.1.1 10:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:25 INFO - Installing collected packages: psutil 10:15:25 INFO - Running setup.py install for psutil 10:15:25 INFO - building 'psutil._psutil_osx' extension 10:15:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:15:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:15:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:15:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:15:26 INFO - building 'psutil._psutil_posix' extension 10:15:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:15:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:15:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:15:26 INFO - ^ 10:15:26 INFO - 1 warning generated. 10:15:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:15:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:26 INFO - Successfully installed psutil 10:15:26 INFO - Cleaning up... 10:15:26 INFO - Return code: 0 10:15:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2a7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4e05926f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, '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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:15: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:15: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 mozsystemmonitor==0.3 10:15:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:15:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:26 INFO - 'HOME': '/Users/cltbld', 10:15:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:26 INFO - 'LOGNAME': 'cltbld', 10:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:26 INFO - 'MOZ_NO_REMOTE': '1', 10:15:26 INFO - 'NO_EM_RESTART': '1', 10:15:26 INFO - 'PAGER': '/bin/cat', 10:15:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:26 INFO - 'PWD': '/builds/slave/test', 10:15:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:26 INFO - 'SHELL': '/bin/bash', 10:15:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:15:26 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:15:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:26 INFO - 'USER': 'cltbld', 10:15:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:26 INFO - 'XPC_FLAGS': '0x0', 10:15:26 INFO - 'XPC_SERVICE_NAME': '0', 10:15:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:15:29 INFO - Installing collected packages: mozsystemmonitor 10:15:29 INFO - Running setup.py install for mozsystemmonitor 10:15:29 INFO - Successfully installed mozsystemmonitor 10:15:29 INFO - Cleaning up... 10:15:29 INFO - Return code: 0 10:15:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:29 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 0x10a212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2a7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4e05926f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, '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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:29 INFO - 'HOME': '/Users/cltbld', 10:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:29 INFO - 'LOGNAME': 'cltbld', 10:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:29 INFO - 'MOZ_NO_REMOTE': '1', 10:15:29 INFO - 'NO_EM_RESTART': '1', 10:15:29 INFO - 'PAGER': '/bin/cat', 10:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:29 INFO - 'PWD': '/builds/slave/test', 10:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:29 INFO - 'SHELL': '/bin/bash', 10:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:15:29 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:29 INFO - 'USER': 'cltbld', 10:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:29 INFO - 'XPC_FLAGS': '0x0', 10:15:29 INFO - 'XPC_SERVICE_NAME': '0', 10:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:29 INFO - Downloading/unpacking jsonschema==2.5.1 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:32 INFO - Downloading functools32-3.2.3-2.tar.gz 10:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:15:32 INFO - warning: no files found matching '*.txt' 10:15:32 INFO - no previously-included directories found matching 'build' 10:15:32 INFO - no previously-included directories found matching 'dist' 10:15:32 INFO - no previously-included directories found matching '.git*' 10:15:32 INFO - Installing collected packages: jsonschema, functools32 10:15:32 INFO - Running setup.py install for functools32 10:15:32 INFO - warning: no files found matching '*.txt' 10:15:32 INFO - no previously-included directories found matching 'build' 10:15:32 INFO - no previously-included directories found matching 'dist' 10:15:32 INFO - no previously-included directories found matching '.git*' 10:15:33 INFO - Successfully installed jsonschema functools32 10:15:33 INFO - Cleaning up... 10:15:33 INFO - Return code: 0 10:15:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:33 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 0x10a212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2a7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4e05926f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, '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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:15:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:15:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:33 INFO - 'HOME': '/Users/cltbld', 10:15:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:33 INFO - 'LOGNAME': 'cltbld', 10:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:33 INFO - 'MOZ_NO_REMOTE': '1', 10:15:33 INFO - 'NO_EM_RESTART': '1', 10:15:33 INFO - 'PAGER': '/bin/cat', 10:15:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:33 INFO - 'PWD': '/builds/slave/test', 10:15:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:33 INFO - 'SHELL': '/bin/bash', 10:15:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:15:33 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:15:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:33 INFO - 'USER': 'cltbld', 10:15:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:33 INFO - 'XPC_FLAGS': '0x0', 10:15:33 INFO - 'XPC_SERVICE_NAME': '0', 10:15:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:15:33 INFO - Cleaning up... 10:15:33 INFO - Return code: 0 10:15:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:33 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 0x10a212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2a7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4e05926f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, '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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:15:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:15:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:33 INFO - 'HOME': '/Users/cltbld', 10:15:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:33 INFO - 'LOGNAME': 'cltbld', 10:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:33 INFO - 'MOZ_NO_REMOTE': '1', 10:15:33 INFO - 'NO_EM_RESTART': '1', 10:15:33 INFO - 'PAGER': '/bin/cat', 10:15:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:33 INFO - 'PWD': '/builds/slave/test', 10:15:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:33 INFO - 'SHELL': '/bin/bash', 10:15:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:15:33 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:15:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:33 INFO - 'USER': 'cltbld', 10:15:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:33 INFO - 'XPC_FLAGS': '0x0', 10:15:33 INFO - 'XPC_SERVICE_NAME': '0', 10:15:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:33 INFO - Downloading/unpacking blobuploader==1.2.4 10:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:36 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:37 INFO - Downloading docopt-0.6.1.tar.gz 10:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:37 INFO - Running setup.py install for blobuploader 10:15:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:37 INFO - Running setup.py install for requests 10:15:38 INFO - Running setup.py install for docopt 10:15:38 INFO - Successfully installed blobuploader requests docopt 10:15:38 INFO - Cleaning up... 10:15:38 INFO - Return code: 0 10:15:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:38 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 0x10a212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2a7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4e05926f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, '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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:38 INFO - 'HOME': '/Users/cltbld', 10:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:38 INFO - 'LOGNAME': 'cltbld', 10:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:38 INFO - 'MOZ_NO_REMOTE': '1', 10:15:38 INFO - 'NO_EM_RESTART': '1', 10:15:38 INFO - 'PAGER': '/bin/cat', 10:15:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:38 INFO - 'PWD': '/builds/slave/test', 10:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:38 INFO - 'SHELL': '/bin/bash', 10:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:15:38 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:38 INFO - 'USER': 'cltbld', 10:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:38 INFO - 'XPC_FLAGS': '0x0', 10:15:38 INFO - 'XPC_SERVICE_NAME': '0', 10:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-yeKzKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-pyNlkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-I_SC3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7cwUfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-O0vZr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-BI1huY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-XaCyNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-mnKWjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-3CKBh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-6n4u6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-j13u1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-FBzA3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Fl33Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:39 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-trlqB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:40 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Z45wka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:40 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-uYM2Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:40 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-KeUw59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:40 INFO - Running setup.py install for manifestparser 10:15:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:40 INFO - Running setup.py install for mozcrash 10:15:40 INFO - Running setup.py install for mozdebug 10:15:40 INFO - Running setup.py install for mozdevice 10:15:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:15:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:15:40 INFO - Running setup.py install for mozfile 10:15:41 INFO - Running setup.py install for mozhttpd 10:15:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:15:41 INFO - Running setup.py install for mozinfo 10:15:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:15:41 INFO - Running setup.py install for mozInstall 10:15:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:15:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:15:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:15:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:15:41 INFO - Running setup.py install for mozleak 10:15:41 INFO - Running setup.py install for mozlog 10:15:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:15:41 INFO - Running setup.py install for moznetwork 10:15:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:15:41 INFO - Running setup.py install for mozprocess 10:15:42 INFO - Running setup.py install for mozprofile 10:15:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:15:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:15:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:15:42 INFO - Running setup.py install for mozrunner 10:15:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:15:42 INFO - Running setup.py install for mozscreenshot 10:15:42 INFO - Running setup.py install for moztest 10:15:42 INFO - Running setup.py install for mozversion 10:15:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:15:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:15:42 INFO - Cleaning up... 10:15:42 INFO - Return code: 0 10:15:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:42 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 0x10a212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2a7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4e05926f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, '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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:42 INFO - 'HOME': '/Users/cltbld', 10:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:42 INFO - 'LOGNAME': 'cltbld', 10:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:42 INFO - 'MOZ_NO_REMOTE': '1', 10:15:42 INFO - 'NO_EM_RESTART': '1', 10:15:42 INFO - 'PAGER': '/bin/cat', 10:15:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:42 INFO - 'PWD': '/builds/slave/test', 10:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:42 INFO - 'SHELL': '/bin/bash', 10:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:15:42 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:42 INFO - 'USER': 'cltbld', 10:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:42 INFO - 'XPC_FLAGS': '0x0', 10:15:42 INFO - 'XPC_SERVICE_NAME': '0', 10:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:43 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-y4sO3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:43 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-zyiuQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:43 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-MFmGUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:43 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Ka_wZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:43 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-O54Z6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:43 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-tLLvub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:43 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-B6yP0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:43 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-witqow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:43 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-5SMt1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:44 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-4c0a9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:44 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)) 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:44 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-edbljG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:44 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-sGbCKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:44 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)) 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:44 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-JXfmKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:44 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-HGUx7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:44 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)) 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:44 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-aM2AUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:44 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-pHUdOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:44 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-FxtuTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:47 INFO - Downloading blessings-1.6.tar.gz 10:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:15:47 INFO - Installing collected packages: blessings 10:15:47 INFO - Running setup.py install for blessings 10:15:47 INFO - Successfully installed blessings 10:15:47 INFO - Cleaning up... 10:15:47 INFO - Return code: 0 10:15:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:15:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:47 INFO - Reading from file tmpfile_stdout 10:15:47 INFO - Current package versions: 10:15:47 INFO - blessings == 1.6 10:15:47 INFO - blobuploader == 1.2.4 10:15:47 INFO - docopt == 0.6.1 10:15:47 INFO - functools32 == 3.2.3-2 10:15:47 INFO - jsonschema == 2.5.1 10:15:47 INFO - manifestparser == 1.1 10:15:47 INFO - mozInstall == 1.12 10:15:47 INFO - mozcrash == 0.17 10:15:47 INFO - mozdebug == 0.1 10:15:47 INFO - mozdevice == 0.48 10:15:47 INFO - mozfile == 1.2 10:15:47 INFO - mozhttpd == 0.7 10:15:47 INFO - mozinfo == 0.9 10:15:47 INFO - mozleak == 0.1 10:15:47 INFO - mozlog == 3.3 10:15:47 INFO - moznetwork == 0.27 10:15:47 INFO - mozprocess == 0.23 10:15:47 INFO - mozprofile == 0.28 10:15:47 INFO - mozrunner == 6.12 10:15:47 INFO - mozscreenshot == 0.1 10:15:47 INFO - mozsystemmonitor == 0.3 10:15:47 INFO - moztest == 0.7 10:15:47 INFO - mozversion == 1.4 10:15:47 INFO - psutil == 3.1.1 10:15:47 INFO - requests == 1.2.3 10:15:47 INFO - wsgiref == 0.1.2 10:15:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:48 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 0x10a212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2a7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4e05926f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, '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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:15:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:48 INFO - 'HOME': '/Users/cltbld', 10:15:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:48 INFO - 'LOGNAME': 'cltbld', 10:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:48 INFO - 'MOZ_NO_REMOTE': '1', 10:15:48 INFO - 'NO_EM_RESTART': '1', 10:15:48 INFO - 'PAGER': '/bin/cat', 10:15:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:48 INFO - 'PWD': '/builds/slave/test', 10:15:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:48 INFO - 'SHELL': '/bin/bash', 10:15:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:15:48 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:15:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:48 INFO - 'USER': 'cltbld', 10:15:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:48 INFO - 'XPC_FLAGS': '0x0', 10:15:48 INFO - 'XPC_SERVICE_NAME': '0', 10:15:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:15:48 INFO - Cleaning up... 10:15:48 INFO - Return code: 0 10:15:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:48 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 0x10a212a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2a7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4e05926f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, '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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:15:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:15:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:48 INFO - 'HOME': '/Users/cltbld', 10:15:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:48 INFO - 'LOGNAME': 'cltbld', 10:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:48 INFO - 'MOZ_NO_REMOTE': '1', 10:15:48 INFO - 'NO_EM_RESTART': '1', 10:15:48 INFO - 'PAGER': '/bin/cat', 10:15:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:48 INFO - 'PWD': '/builds/slave/test', 10:15:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:48 INFO - 'SHELL': '/bin/bash', 10:15:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:15:48 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:15:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:48 INFO - 'USER': 'cltbld', 10:15:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:48 INFO - 'XPC_FLAGS': '0x0', 10:15:48 INFO - 'XPC_SERVICE_NAME': '0', 10:15:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:15:48 INFO - Cleaning up... 10:15:48 INFO - Return code: 0 10:15:48 INFO - Running post-action listener: _resource_record_post_action 10:15:48 INFO - Running post-action listener: _start_resource_monitoring 10:15:48 INFO - Starting resource monitoring. 10:15:48 INFO - [mozharness: 2016-08-10 17:15:48.969529Z] Finished create-virtualenv step (success) 10:15:48 INFO - [mozharness: 2016-08-10 17:15:48.970468Z] Running install step. 10:15:48 INFO - Running pre-action listener: _resource_record_pre_action 10:15:48 INFO - Running main action method: install 10:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:49 INFO - Reading from file tmpfile_stdout 10:15:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:15:49 INFO - Reading from file tmpfile_stdout 10:15:49 INFO - Output received: 10:15:49 INFO - Usage: mozinstall [options] installer 10:15:49 INFO - Options: 10:15:49 INFO - -h, --help show this help message and exit 10:15:49 INFO - -d DEST, --destination=DEST 10:15:49 INFO - Directory to install application into. [default: 10:15:49 INFO - "/builds/slave/test"] 10:15:49 INFO - --app=APP Application being installed. [default: firefox] 10:15:49 INFO - mkdir: /builds/slave/test/build/application 10:15:49 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'] 10:15:49 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 10:16:24 INFO - Reading from file tmpfile_stdout 10:16:24 INFO - Output received: 10:16:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:16:24 INFO - Running post-action listener: _resource_record_post_action 10:16:24 INFO - [mozharness: 2016-08-10 17:16:24.227469Z] Finished install step (success) 10:16:24 INFO - [mozharness: 2016-08-10 17:16:24.227614Z] Running run-tests step. 10:16:24 INFO - Running pre-action listener: _resource_record_pre_action 10:16:24 INFO - Running main action method: run_tests 10:16:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:16:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:16:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:16:24 INFO - 2016-08-10 10:16:24.241 screenresolution[1644:7512] starting screenresolution argv=screenresolution get 10:16:24 INFO - 2016-08-10 10:16:24.244 screenresolution[1644:7512] Display 0: 1600x1200x32@60 10:16:24 INFO - 2016-08-10 10:16:24.250 screenresolution[1645:7514] starting screenresolution argv=screenresolution list 10:16:24 INFO - Available Modes on Display 0 10:16:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:16:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:16:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:16:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:16:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:16:24 INFO - Intel Iris: 10:16:24 INFO - Chipset Model: Intel Iris 10:16:24 INFO - Type: GPU 10:16:24 INFO - Bus: Built-In 10:16:24 INFO - VRAM (Dynamic, Max): 1536 MB 10:16:24 INFO - Vendor: Intel (0x8086) 10:16:24 INFO - Device ID: 0x0a2e 10:16:24 INFO - Revision ID: 0x0009 10:16:24 INFO - Displays: 10:16:24 INFO - Display: 10:16:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:16:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:16:24 INFO - Display Serial Number: 1600x1200 60 10:16:24 INFO - Main Display: Yes 10:16:24 INFO - Mirror: Off 10:16:24 INFO - Online: Yes 10:16:24 INFO - Rotation: Supported 10:16:24 INFO - Return code: 0 10:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:24 INFO - Python 2.7.3 10:16:24 INFO - Return code: 0 10:16:24 INFO - grabbing minidump binary from tooltool 10:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:24 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 0x10a176d30>, '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 0x109edbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a16eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:16:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:16:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:16:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:24 INFO - Return code: 0 10:16:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:16:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:16:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:24 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:16:24 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:16:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FnJCO5P5Ew/Render', 10:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:24 INFO - 'HOME': '/Users/cltbld', 10:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:24 INFO - 'LOGNAME': 'cltbld', 10:16:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:24 INFO - 'MOZ_NO_REMOTE': '1', 10:16:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:24 INFO - 'NO_EM_RESTART': '1', 10:16:24 INFO - 'PAGER': '/bin/cat', 10:16:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:24 INFO - 'PWD': '/builds/slave/test', 10:16:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:24 INFO - 'SHELL': '/bin/bash', 10:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8CPbEfyRO6/Listeners', 10:16:24 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:24 INFO - 'USER': 'cltbld', 10:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:24 INFO - 'XPC_FLAGS': '0x0', 10:16:24 INFO - 'XPC_SERVICE_NAME': '0', 10:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:16:24 INFO - mozversion application_buildid: 20160810070552 10:16:24 INFO - mozversion application_changeset: 531100c1d950c8857dda172573fbd23360f7619b 10:16:24 INFO - mozversion application_display_name: Nightly 10:16:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:24 INFO - mozversion application_name: Firefox 10:16:24 INFO - mozversion application_remotingname: firefox 10:16:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:16:24 INFO - mozversion application_vendor: Mozilla 10:16:24 INFO - mozversion application_version: 51.0a1 10:16:24 INFO - mozversion platform_buildid: 20160810070552 10:16:24 INFO - mozversion platform_changeset: 531100c1d950c8857dda172573fbd23360f7619b 10:16:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:16:24 INFO - mozversion platform_version: 51.0a1 10:16:24 INFO - using testdate: 1470849384 10:16:24 INFO - actual date: 1470849384 10:16:24 INFO - starting webserver on 'localhost:49267' 10:16:24 INFO - SUITE-START | Running 2 tests 10:16:24 INFO - TEST-START | dromaeo_css 10:16:24 INFO - operating with platform_type : mac_ 10:16:24 INFO - Initialising browser for dromaeo_css test... 10:16:24 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpcHybRT/profile http://localhost:49267/getInfo.html) 10:16:27 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 10:16:27 INFO - PROCESS | 1655 | colorDepth:24 10:16:27 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 10:16:27 INFO - PROCESS | 1655 | __metrics 10:16:27 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:16:27 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:27 INFO - TEST-INFO | 1655: exit 0 10:16:27 INFO - Browser initialized. 10:16:27 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:27 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpcHybRT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:39 INFO - PROCESS | 1657 | RSS: Main: 243687424 10:16:39 INFO - PROCESS | 1657 | 10:17:31 INFO - PROCESS | 1657 | 1470849451601 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:19:43 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 10:19:44 INFO - PROCESS | 1657 | RSS: Main: 344932352 10:19:44 INFO - PROCESS | 1657 | 10:22:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 10:22:48 INFO - PROCESS | 1657 | RSS: Main: 380727296 10:22:48 INFO - PROCESS | 1657 | 10:25:50 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 10:25:51 INFO - PROCESS | 1657 | RSS: Main: 339341312 10:25:51 INFO - PROCESS | 1657 | 10:28:53 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 10:28:54 INFO - PROCESS | 1657 | RSS: Main: 359411712 10:28:54 INFO - PROCESS | 1657 | 10:31:57 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 10:31:58 INFO - PROCESS | 1657 | RSS: Main: 338419712 10:31:58 INFO - PROCESS | 1657 | 10:35:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 10:35:01 INFO - PROCESS | 1657 | RSS: Main: 421199872 10:35:01 INFO - PROCESS | 1657 | 10:35:01 INFO - PROCESS | 1657 | __start_tp_report 10:35:01 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 10:35:01 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 10:35:01 INFO - PROCESS | 1657 | |i|pagename|runs| 10:35:01 INFO - PROCESS | 1657 | |0;dojo.html;3403.965960340396;3419.316136772646;3419.538362321086;3424.8116353600544;3471.114865709244;5668.914966275509;5723.771049158039;5727.312722473303;5868.4131586841295;5891.410858914106;5703.258576385064;5707.942920570793;5829.154772557977;5866.73599688014;5869.677167755772;5162.612804039693;5219.686818790866;5219.973900130494;5224.921626175591;5403.945960540384;5367.892642147155;5368.141097424413;5369.677819330833;5424.349078110632;5425;5214.869628259324;5268.736563171826;5273.630845840793;5278.63049586531;5326.174442961347;5303.098473259555;5304.867378315573;5306.52241298285;5314.043472175045;5317.840464786024;5158.3552055993005;5233.581313494949;5260.92108618371;5268.473152684739;5308.814191503279;4663.44038715353;5671.744771485293;5719.799807006735;5793.942060579382;5798.565107616945;6246.250449946036;6274.686265686743;6301.747930082791;6318.87362252757;6352.650604216767;6311.242650881878;6353.5234857385885;6380.138681278015;6397.648129352884;6415.8396040098905;5509.228707980846;5545.667259964374;5780.104083867007;5862.062070068769;5883.382244864313;6334.683265836689;6335.936640633627;6345.96827015862;6348.111264422984;6360.1731774869895;6238.688065596702;6248.687565621701;6254.843628909313;6262.12330273762;6264.404881536247;6102.428659372087;6128.625347140816;6134.601250918676;6162.106494558354;6233.438990490878;5133.6919784813035;6057.727402266909;6073.392660733891;6093.360197179321;6101.755929762849;6042.939570604326;6064.636121832704;6107.144999700045;6114.510839132948;6139.508839292846;4905.779239934212;4908.509149085135;4943.728094954812;4960.404751429852;5030.622703297194;4415.602595766396;4436.401085853368;4491.46102467706;4519.276915693474;4542.886427839265;5654.264945557051;5677.744501497443;5682.40334764852;5691.203231547586;5759.222504961776;6174.073888916699;6201.224846894138;6238.064290356483;6249.96875015622;6275.309715931244;5701.572382071361;5748.993926062923;5770.394108618619;5791.478766910998;5825.1844741736195;5452.073147564924;5511.145772405283;5511.614187006951;5530;5530.695811730313;6267.4045965633195;6336.986082226822;6338.683065846689;6348.936510634834;6350.841228969312;5392.406835248041;6262.906056409249;6274.592151510137;6316.747330106744;6334.1765570475545;6322.620642761449;6338.873222535616;6340.968295158495;6361.236651601837;6364.236291645032;5091.4144873338555;6290.528210384331;6304.18045654062;6304.65324407162;6438.742450301936;6191.4118158774845;6256.06159076124;6266.498680105672;6316.084167795552;6361.936380636134;6194.535409844189;6197.473214776614;6214.8135555933395;6227.159333490102;6247.562670613013;6205.782797602063;6207.286162091417;6209.285932117684;6212.9068063978175;6222.906656400248;5896.970515147397;5959.463648271676;5997.730102145327;6007.789727359522;6069.666168360783;6149.508039356751;6189.907151392823;6202.906956395748;6203.96898015507;6219.378062193744;5855;5874.970625146847;5965.8806823862415;6001.189839371629;6025.758969641165 10:35:01 INFO - PROCESS | 1657 | |1;ext.html;456.34286627256756;517.5574883474629;539.175062154903;539.7112544788539;542.987328632101;30730.69269307309;40368.59631403685;41406.58593414065;41413.79293103538;41488;42838.14323713524;43240.13519729603;43347;43438.56561434385;43473.13053738923;8636.524991125485;9599.904000960007;9781.608735650565;9787.119159275664;9789.461579613118;8696.04343522212;11605.30368177912;11741.589044383449;11762.0590352772;12067.456964436578;11675.766484670301;11757.706057348549;11771.470283837205;11783.234089784179;11846.644600661952;11786.46960886758;11885.762284754299;11889.821652675217;11902.702432439259;11913.106517011172;10593.78812423755;11334.943325283402;11413.942930285379;11420.14348923834;11440.94279528597;40890.59109408927;41010;41012;41020.794896025625;41117.38323925144;3401.812900290483;3601.9279614407565;3679.337719210541;3900.180961997984;4346.521882592912;31914.840425797956;32280.496103392823;33202.833985829915;33238;33451.832740836384;3197.7441804655573;3250.8374581271078;3322.700956913865;3340.6325304216516;3389.7288216942584;481418;485800;485851;487631;487736;62252.75494490175;62566.0615090774;62640.37359626436;62643.6867815658;62730;65262.34737652657;65513;65553.01670474946;65602.34397656057;65631.34368656347;16235.91882040606;16432.424865129902;16440.75338869918;16471.25879335433;16480;11403.657890263305;11610.24533405326;12521.812172817416;12750.936245318713;12762.68093297675;17542.91228543849;17793.19930603126;17815.287388504574;17875.46373608794;18142.727859082126;6300.30696623371;6787.694553745093;7007.754728584475;7126.2873712628325;7155.89266161008;892.3887137310833;992.5781542844262;1025.3898930136556;1069.3316677076828;1080.56777289085;30235.395292094036;30368.39263214723;30461.086167415015;30778.53832192519;31117.377652447278;999.9600015999424;1048.7587854793287;1051.695008447557;1063.9946800266105;1097.5280629329466;15728.60678483047;15795;15808.209589520478;16062.277197526138;16158.27287772053;517967;614776;616080;616674;617523;59151.704241479376;59171;59191.70404147952;59236;59306;1242.9254244745343;1353.3368649361742;1375.0924389902616;1396.294871090093;1403.4596680278166;25528.489430211663;28239.01163459269;31024.53463198099;31981;33066.842660506765;51131;51791;51823.74088129535;51834.222486663486;51849;524130;527044;528234;528281;530540;26371.472570548864;27272.181834544994;27282.863585681946;28089.297767555974;28112.87548498037;48115.5188448111;48499.75750121227;48703;48948.2657760141;50019;39515.81452556428;39700.2059958805;40268.81800901133;40418.39372409475;41280.79359603183;38540;39604.405933910435;39691.603083969945;39775.40336894891;41049.384259235536;33395.83302083474;38266.426003610526;38862.6113738859;39062.828115155455;39081.413778792776;32940.835295823366;34071.82964085164;34289.48565771466;34531.136721581155;34601;25490.490190196462;25583.872080640223;25621.10326138576;25867.741322587288;26318.60522092132 10:35:01 INFO - PROCESS | 1657 | |2;jquery.html;355.9003479025874;376.4353469795307;378.4247943126448;385.94596756454104;409.32665764816875;15272.923635381821;15522;20689.482762930897;21078.789212107873;21141.788582114175;20763.792362076376;21016.789832101673;21322;21600.243991460302;21656.891715541402;4847.709137451755;5039.622028347871;5046.419661738892;5847.79532716355;6118.112873633343;3889.4165875118815;6142.815715528542;6178.41305076017;6199.659018753967;6203.534734894901;5852.473277405054;6125.5712100153005;6145.907811382833;6200.78297259596;6212.068189771525;5186.429492755794;5792.160136780185;6149.385061493815;6176.413240742122;6186.8453288667915;5901.940980590182;5911.320198177222;5912.201852749909;5913.940860591425;5922.378150294243;13004.284764337957;13362.866371336357;13408.195508269535;13575.117617354841;13704.3833027514;2319.0375993962653;2420.407000284924;2435.549423356667;2689.233568433007;2711.552593822017;10015.44915029673;10088.64689735863;10526.052655261063;10558.419286939215;10560.788784224349;1840.1811194018667;1841.9723704144449;1868.7664041994751;1897.2411035585737;1897.4307707687638;102312.46531302037;109399;115156;118398.40800795941;128810.35594822059;11453.54185832574;11531.88468115308;11557.133215008907;11664.650060498028;11899.940500297444;14607.123572585679;14620.780688289684;14625.122492650475;14642.267886605627;14683.55949321522;8263.173682631808;8512.574371281535;8556.058833528306;8624.223819856243;8638.222559969507;8502.1922917324;8503.74488765338;8522.65909363631;8679.566021699016;8699.608517616722;4436.578525040116;4527.0553432762235;4528.796204170821;4606.30905364198;4637.768111594407;1873.4566975577202;1892.4606487151095;1923.5960448306012;1935.2839449403812;1941.4660968233566;867.8915135608049;871.0549054276181;873.4235404632911;906.6418764588083;938.3947353956796;19469.90265048694;20913.477163071046;21648.89175554112;21695.132194712034;21798;916.922061624756;934.7008957133788;967.656481948898;985.3841349156777;997.2670087485692;10499.265051446479;10516;11372.715682108013;11430.485628146587;11438.828417573743;546138;576618.1169094128;582259;583701;592638;76669.6166519175;76891.2331575123;81142.59428702819;136303;137728;950.3205208276116;957.4494665567327;966.8066386722825;969.7042402067437;971.2666936462925;16324.347026119298;18667.533311666775;18970.715439268148;19081.522961926064;19082;56719.43280567307;57043;57401.56496087631;57639.13541296968;57722.71138644448;81621;82841;82975.58512207642;83753.16246837698;84468;8108.148644392254;8178.1821817817745;8309.626066827128;8537;8563.272121869712;9439.764005899908;12789.8081528779;13150;13625.773680368815;13633.79549306781;11258.38078905668;11525.250858694159;11859;11862.703432414259;11947.581834635746;8085.757427277191;9517.381370211191;9763.1701305387;9799.265055121037;10248.231382646181;10823.647044119485;11577.884221158018;11609.709757255798;11728.472218750347;11787.646370608896;5651.717414129359;7388.926110738824;7401.444891633041;7484.588347640932;7655.2344765523;9566.952165239129;9633.614655413985;10717.303375280582;10935.781284374109;11437.199396042197 10:35:01 INFO - PROCESS | 1657 | |3;mootools.html;1340.3432318164103;1477.9187144707041;1486.5168820133458;1703.2335449047923;1900.4488698277491;7674.424418168639;8405.243528082472;8699.434536755107;8750.124987501247;8826.77933051674;8620;8688.782780430492;8701.999270083943;8709.651613935452;8731.083236260181;2302.792748652625;2328.9650655240184;2333.8249631277636;2334.3580515358244;2336.4626135988733;2285.885705714716;2319.3158018384615;2338.7778161074757;2339.8596084235;2340.216027630746;2280.053777682268;2308.7922087012166;2315.0623997281127;2320.118355025088;2329.8485598436046;2264.547090581874;2277.146070223666;2286.588414085464;2291.724993000834;2293.3578597992505;2255.4699645583273;2267.2744721689064;2268.671042698816;2268.6823844661762;2271.3072512883564;8684;8700.042995270514;8763.079876612928;8777.956110219407;8797.428167169113;5124.0776660201145;5343.519083282485;5345.679259244419;5376.677399356012;5378.058839703075;3579.8210089495683;3591.4612808078737;3634.1823089804584;3644;3649.160693040589;1082.220801023262;1083.5774048121239;1086.8369744538304;1102.8070087734613;1112.2992514715677;10616.469176541143;11370.658880233523;11427.60003399877;11521.711957201138;11528.942355288254;4072.1041370898356;4103.815328310233;4315.5900189481945;4555.476120246214;4565.269556870885;8594.87107693385;9057.501837398875;9067.909320906838;9068.229200517899;9075.727728168165;5169.302144210558;5182.844514664566;5184.533391994739;5188.870278243074;5201.219817027476;4385.824567017347;4533.52397998212;4625.4911959684405;4858.927116093261;4862.270659401118;3882.1847412043785;3894.7273690841935;4003.619656132663;4049.797510124482;4058.5941405859176;1265.1523479268913;1282.4357282795727;1284.865089165624;1297.2994582925303;1299.883010529057;765.7855800375904;865.523961820996;888.1562515610067;897.6588896219525;952.842780941137;5527.723613819293;5696.458836410535;5848.1227815827115;6007.128966299862;6108.4807791338235;777.8444311137795;960.7510236692272;964.1226483899758;978.3493976505687;1023.5445226874118;3558.8576456941432;3777.8111094445167;3842.5965273645866;3872.896224575982;3946.3291240489184;10170.033846784543;10622.628208012682;10632.89367106319;10655.041046305869;10659.14726821868;10568.678915135608;10590.4704764763;10595.894041059644;10596.364218146937;10599.523021464052;6775.457963362919;8080.959595201986;8100.392470564731;8100.878486822702;8115;5125.410577783603;5826.592138550261;5950.375210602824;6003.879922401615;6172.537059720449;7770.844583108419;9734.513274336396;9796.281309634573;9813.950930245303;9869.654562090293;9723.85414218773;9830.311878168459;10012.098911098035;10034.29759916828;10096.444695541815;6192.969035154975;6896.413804826646;7119.359257666835;7408.777736667908;7590.8102297443;8150;8378.706745263886;8387.32901367877;8388.203120703523;8396.37027222973;7224;7427.925720742724;7446.553206807609;7499.175090740124;7532.058492688414;7180.461465390221;7257.201707812031;7272.636368181464;7338.082739657543;7360.77917662471;6895.931040689529;6902.447804175554;6981.685824138028;6983.825404364931;6986.6157361343585;4708.293755936637;4746.121967436035;4812.205986012409;4832.806687732592;4890.828820991248;4809.78355973975;4874.829380971649;4938.555530002317;5001.324821149244;5055.721935293447 10:35:01 INFO - PROCESS | 1657 | |4;prototype.html;250.5715226961895;295.7973787955251;298.47319481115835;304.6146624519982;310.46754815491454;4507.797149128289;5347.518723314901;5355;5448.101063324551;5496.862578435536;4015.4980627421573;4840.322354870321;4880.804202970268;5204.776877433809;5272.650063697455;3875.3218186817335;3985.7010724195657;3998.280309544281;4018.6584140348104;4057.8782636520805;3748.512693349861;3983.3825757007567;3997.6402123808853;4051.858184963527;4057.411675307079;3600.2799440111953;3709.6475834795788;4014.4179094031347;4014.7189696721243;4064.1871625674985;3339.7662163648556;3477.0959550516795;3638.290533345972;3948.756141815333;4079.8572049978256;3493.4934434506854;3512.543369361992;3521.5774107107054;3538.2392785550974;3555.911102222465;4151.875443736692;5062.696238225682;5066.265391518246;5095.898082038376;5132.589392848563;4355.956440435587;4568.588827005552;4570.08056616222;4586.289125185602;4606.825259558825;4192.895177620553;4899.036083169667;5455.454454554552;5461.460420904298;5491.615586908918;3851.480050193216;3875.476810630557;3890.3386424307937;3913.063033798288;3916.432117342998;4652.55800698933;4814.15752243356;5240.68555886648;5771.307443106812;5844.561657875676;3313.7349012078976;3353.5975682918206;3612.230007296406;3936.173403585222;3967.6230758077936;3972.7553932028313;3980.24375368679;3987.8205480752854;4011.117554138085;4029.778362190049;3647.379945409287;3900.7074469414906;4456.732596044248;4595.540445955377;4683.9390668105925;4795.376601041842;5501.944980550224;5536.695481748542;5542.61201715876;5566.526845218121;1166.3410173252084;1310.7968264918952;1342.0806747378078;1366.5012270521188;1380.6548362909273;723.4284914917262;751.2074761126954;770.6570576093585;844.3667249562828;895.3150839607705;4227.062191776748;4704.341392205094;5081.856582269033;5125.846224613268;5328.415718376585;5058.015770695234;5706.831404066511;5712.571557133231;5759.712014399263;5801.6519008859605;4735.384400027974;5126.974365128151;5146.0479811235045;5229.294045303911;5237.857285628668;2631.973680263211;2820.633317668731;2954.793164478509;2982.6719060903283;2986.4922963096324;5481.616286859881;5770.826045674862;5797.391273916178;5828.5337173026055;5847.970760146172;5401.459854014567;5420.593455490854;5772.806333593292;5782.913256301159;5822.7000334868335;5813.331466881278;5862.530997520103;5862.736176872051;5892.94107058924;5893.557983151195;5240.423553409199;5611.270534830446;5641.407652196624;5707.971460142673;5718.914216286842;5191.662541934913;5319.441458646941;5535.426026897512;5594.272744543184;5615.894039735099;5417.918731219113;5808.9543882101625;5819.679917604572;5845.064789633639;5859.4666946355355;3211.9518207226442;3428.794272343667;3591.6408359163875;3914.119323152268;3953.6046395361386;5234.895302094013;5444.591655625764;5637.49262566371;5738.569607279387;5775.220345253505;4863.659543831898;5345.006796194144;5346.518813306821;5581.985727706992;5591.82571659956;5471.2613797138465;5570.61005729595;5570.721463926707;5604.281923267131;5654.858628534155;5546.500814926676;5583.274174357308;5584.4136365681015;5614.2701448811395;5638.645006221292;4420.983173869963;4611.239145540948;4921.557059864486;5269.809237900741;5580.525655319343;5428.647137936022;5462.726863656721;5467.589930755289;5470.890582188414;5473.151661492475 10:35:01 INFO - PROCESS | 1657 | |5;yui.html;695.0512550368749;715.5241764226789;742.4951033297363;754.6302311867187;826.8346330733855;14779.482718104855;15584;15934.601634959132;15968.760468592965;15990.920045399786;12149.453274602642;14105.717885642282;14115.647108822284;14146.92926535366;14200.218987955659;674.9325067493261;702.7786247332074;828.035338830262;829.0300348592161;865.6234537976001;657.9868402631945;852.4160949749441;853.1553761775859;853.3770347646222;853.9573021348908;903.8463461211577;906.3519583497798;907.3920473282883;907.9364444488889;912.0651332384293;703.7255470366562;862.9525376104311;899.1862364560084;903.2457897655432;903.5346796399859;667.3860048755157;667.4660271782554;667.8998150277449;668.9431398331147;669.5781657555709;13556.254406007665;13576.456941722417;13579.049466537346;13595;13600.04799664024;13261.469541218436;13636.386362613606;13695.315234238347;13751.449942002308;13863.514776982858;12042.458089385998;12359.814602780965;12374.443150058269;12432.440540175714;12928;4469.1061787642275;4521.412216411845;4542.863714088583;4618.976905115486;4714.575688188045;77830;97563.04873902553;119602.20596691057;119768;124235;10937.726556835984;10983.791782903874;10986.560537578567;11521.251118677259;11583.189176757545;21965.67051494229;22022;22031.33905982823;22036.559268814533;22039;7641.3886889048745;7761.223877612307;8059.274665280153;8172.7956801080445;8172.836543269102;4386.342048692658;4391.780410979438;4446.688731788744;4608.101420223092;4623.16782979067;3639.636036396339;3787.5833658297565;3792.089898424358;3798.2783271178387;3799.886003419902;666.6899891550453;680.3332733920786;681.8908974564046;698.6820996446604;705.1995984557564;567.5062695454981;594.9583529152918;649.2403887451693;658.2495954611746;675.2032601530143;9102.726918192464;9188.38266421464;9410.01194874542;9599.280053995839;9660.130588247092;557.345119484612;563.2847977907282;585.0054906658697;612.4946918792015;683.1494788987643;3519.6832285094465;4167.562405947392;4409.4488188976375;4490.50604433512;4614.884627884329;155841;157003;159852;161123;163579;111339.44330278458;134716;136066;138519;139693;115155;119065;120277;121470.78529214772;123327;8753.518556479201;8800.60397282111;8839.779005524657;8890.688825891062;8986.550672466481;48285.03429931452;58451.70774146102;59914.70042649759;60848.69575652093;61143.38856611555;80471;84959;93247;95883.52058239664;97295;10859.891401085888;11342.773144537228;11412.657620271406;11554.59558915434;11853.940730296294;12362.938185309016;12458.626241212778;12502.374881255719;13094.541691040768;14542.345594448063;9957.950210248902;11745.530178792753;12186.146969712036;13664;14267.857321426653;13484.932575337061;13501.324933753469;13967.860321396656;14272.714545709236;14536;13420.351226802839;13484.797728034284;13742.587722368346;13785;13862.306884655929;10715.464226788785;10771.838422423827;11451;11787.705307367385;11811.055115590903;11396.487158078073;11456.312621242752;11479.8278025828;11658.18392712502;11701.356425396685 10:35:01 INFO - PROCESS | 1657 | __end_tp_report 10:35:01 INFO - PROCESS | 1657 | __start_cc_report 10:35:01 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1174 10:35:01 INFO - PROCESS | 1657 | __end_cc_report 10:35:01 INFO - PROCESS | 1657 | __startTimestamp1470850501438__endTimestamp 10:35:01 INFO - PROCESS | 1657 | 10:35:01 INFO - PROCESS | 1657 | ------- Summary: start ------- 10:35:01 INFO - PROCESS | 1657 | Number of tests: 6 10:35:01 INFO - PROCESS | 1657 | 10:35:01 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5771.20 Median:5965.88 stddev:638.14 (10.7%) stddev-sans-first:612.48 10:35:01 INFO - PROCESS | 1657 | Values: 3404.0 3419.3 3419.5 3424.8 3471.1 5668.9 5723.8 5727.3 5868.4 5891.4 5703.3 5707.9 5829.2 5866.7 5869.7 5162.6 5219.7 5220.0 5224.9 5403.9 5367.9 5368.1 5369.7 5424.3 5425.0 5214.9 5268.7 5273.6 5278.6 5326.2 5303.1 5304.9 5306.5 5314.0 5317.8 5158.4 5233.6 5260.9 5268.5 5308.8 4663.4 5671.7 5719.8 5793.9 5798.6 6246.3 6274.7 6301.7 6318.9 6352.7 6311.2 6353.5 6380.1 6397.6 6415.8 5509.2 5545.7 5780.1 5862.1 5883.4 6334.7 6335.9 6346.0 6348.1 6360.2 6238.7 6248.7 6254.8 6262.1 6264.4 6102.4 6128.6 6134.6 6162.1 6233.4 5133.7 6057.7 6073.4 6093.4 6101.8 6042.9 6064.6 6107.1 6114.5 6139.5 4905.8 4908.5 4943.7 4960.4 5030.6 4415.6 4436.4 4491.5 4519.3 4542.9 5654.3 5677.7 5682.4 5691.2 5759.2 6174.1 6201.2 6238.1 6250.0 6275.3 5701.6 5749.0 5770.4 5791.5 5825.2 5452.1 5511.1 5511.6 5530.0 5530.7 6267.4 6337.0 6338.7 6348.9 6350.8 5392.4 6262.9 6274.6 6316.7 6334.2 6322.6 6338.9 6341.0 6361.2 6364.2 5091.4 6290.5 6304.2 6304.7 6438.7 6191.4 6256.1 6266.5 6316.1 6361.9 6194.5 6197.5 6214.8 6227.2 6247.6 6205.8 6207.3 6209.3 6212.9 6222.9 5897.0 5959.5 5997.7 6007.8 6069.7 6149.5 6189.9 6202.9 6204.0 6219.4 5855.0 5875.0 5965.9 6001.2 6025.8 10:35:01 INFO - PROCESS | 1657 | 10:35:01 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:68203.93 Median:20972.88 stddev:143579.25 (684.6%) stddev-sans-first:143891.92 10:35:01 INFO - PROCESS | 1657 | Values: 456.3 517.6 539.2 539.7 543.0 30730.7 40368.6 41406.6 41413.8 41488.0 42838.1 43240.1 43347.0 43438.6 43473.1 8636.5 9599.9 9781.6 9787.1 9789.5 8696.0 11605.3 11741.6 11762.1 12067.5 11675.8 11757.7 11771.5 11783.2 11846.6 11786.5 11885.8 11889.8 11902.7 11913.1 10593.8 11334.9 11413.9 11420.1 11440.9 40890.6 41010.0 41012.0 41020.8 41117.4 3401.8 3601.9 3679.3 3900.2 4346.5 31914.8 32280.5 33202.8 33238.0 33451.8 3197.7 3250.8 3322.7 3340.6 3389.7 481418.0 485800.0 485851.0 487631.0 487736.0 62252.8 62566.1 62640.4 62643.7 62730.0 65262.3 65513.0 65553.0 65602.3 65631.3 16235.9 16432.4 16440.8 16471.3 16480.0 11403.7 11610.2 12521.8 12750.9 12762.7 17542.9 17793.2 17815.3 17875.5 18142.7 6300.3 6787.7 7007.8 7126.3 7155.9 892.4 992.6 1025.4 1069.3 1080.6 30235.4 30368.4 30461.1 30778.5 31117.4 1000.0 1048.8 1051.7 1064.0 1097.5 15728.6 15795.0 15808.2 16062.3 16158.3 517967.0 614776.0 616080.0 616674.0 617523.0 59151.7 59171.0 59191.7 59236.0 59306.0 1242.9 1353.3 1375.1 1396.3 1403.5 25528.5 28239.0 31024.5 31981.0 33066.8 51131.0 51791.0 51823.7 51834.2 51849.0 524130.0 527044.0 528234.0 528281.0 530540.0 26371.5 27272.2 27282.9 28089.3 28112.9 48115.5 48499.8 48703.0 48948.3 50019.0 39515.8 39700.2 40268.8 40418.4 41280.8 38540.0 39604.4 39691.6 39775.4 41049.4 33395.8 38266.4 38862.6 39062.8 39081.4 32940.8 34071.8 34289.5 34531.1 34601.0 25490.5 25583.9 25621.1 25867.7 26318.6 10:35:01 INFO - PROCESS | 1657 | 10:35:01 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:33476.81 Median:2422.95 stddev:96024.02 (3963.1%) stddev-sans-first:96261.19 10:35:01 INFO - PROCESS | 1657 | Values: 355.9 376.4 378.4 385.9 409.3 15272.9 15522.0 20689.5 21078.8 21141.8 20763.8 21016.8 21322.0 21600.2 21656.9 4847.7 5039.6 5046.4 5847.8 6118.1 3889.4 6142.8 6178.4 6199.7 6203.5 5852.5 6125.6 6145.9 6200.8 6212.1 5186.4 5792.2 6149.4 6176.4 6186.8 5901.9 5911.3 5912.2 5913.9 5922.4 13004.3 13362.9 13408.2 13575.1 13704.4 2319.0 2420.4 2435.5 2689.2 2711.6 10015.4 10088.6 10526.1 10558.4 10560.8 1840.2 1842.0 1868.8 1897.2 1897.4 102312.5 109399.0 115156.0 118398.4 128810.4 11453.5 11531.9 11557.1 11664.7 11899.9 14607.1 14620.8 14625.1 14642.3 14683.6 8263.2 8512.6 8556.1 8624.2 8638.2 8502.2 8503.7 8522.7 8679.6 8699.6 4436.6 4527.1 4528.8 4606.3 4637.8 1873.5 1892.5 1923.6 1935.3 1941.5 867.9 871.1 873.4 906.6 938.4 19469.9 20913.5 21648.9 21695.1 21798.0 916.9 934.7 967.7 985.4 997.3 10499.3 10516.0 11372.7 11430.5 11438.8 546138.0 576618.1 582259.0 583701.0 592638.0 76669.6 76891.2 81142.6 136303.0 137728.0 950.3 957.4 966.8 969.7 971.3 16324.3 18667.5 18970.7 19081.5 19082.0 56719.4 57043.0 57401.6 57639.1 57722.7 81621.0 82841.0 82975.6 83753.2 84468.0 8108.1 8178.2 8309.6 8537.0 8563.3 9439.8 12789.8 13150.0 13625.8 13633.8 11258.4 11525.3 11859.0 11862.7 11947.6 8085.8 9517.4 9763.2 9799.3 10248.2 10823.6 11577.9 11609.7 11728.5 11787.6 5651.7 7388.9 7401.4 7484.6 7655.2 9567.0 9633.6 10717.3 10935.8 11437.2 10:35:01 INFO - PROCESS | 1657 | 10:35:01 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5585.22 Median:4914.69 stddev:3108.17 (63.2%) stddev-sans-first:3100.52 10:35:01 INFO - PROCESS | 1657 | Values: 1340.3 1477.9 1486.5 1703.2 1900.4 7674.4 8405.2 8699.4 8750.1 8826.8 8620.0 8688.8 8702.0 8709.7 8731.1 2302.8 2329.0 2333.8 2334.4 2336.5 2285.9 2319.3 2338.8 2339.9 2340.2 2280.1 2308.8 2315.1 2320.1 2329.8 2264.5 2277.1 2286.6 2291.7 2293.4 2255.5 2267.3 2268.7 2268.7 2271.3 8684.0 8700.0 8763.1 8778.0 8797.4 5124.1 5343.5 5345.7 5376.7 5378.1 3579.8 3591.5 3634.2 3644.0 3649.2 1082.2 1083.6 1086.8 1102.8 1112.3 10616.5 11370.7 11427.6 11521.7 11528.9 4072.1 4103.8 4315.6 4555.5 4565.3 8594.9 9057.5 9067.9 9068.2 9075.7 5169.3 5182.8 5184.5 5188.9 5201.2 4385.8 4533.5 4625.5 4858.9 4862.3 3882.2 3894.7 4003.6 4049.8 4058.6 1265.2 1282.4 1284.9 1297.3 1299.9 765.8 865.5 888.2 897.7 952.8 5527.7 5696.5 5848.1 6007.1 6108.5 777.8 960.8 964.1 978.3 1023.5 3558.9 3777.8 3842.6 3872.9 3946.3 10170.0 10622.6 10632.9 10655.0 10659.1 10568.7 10590.5 10595.9 10596.4 10599.5 6775.5 8081.0 8100.4 8100.9 8115.0 5125.4 5826.6 5950.4 6003.9 6172.5 7770.8 9734.5 9796.3 9814.0 9869.7 9723.9 9830.3 10012.1 10034.3 10096.4 6193.0 6896.4 7119.4 7408.8 7590.8 8150.0 8378.7 8387.3 8388.2 8396.4 7224.0 7427.9 7446.6 7499.2 7532.1 7180.5 7257.2 7272.6 7338.1 7360.8 6895.9 6902.4 6981.7 6983.8 6986.6 4708.3 4746.1 4812.2 4832.8 4890.8 4809.8 4874.8 4938.6 5001.3 5055.7 10:35:01 INFO - PROCESS | 1657 | 10:35:01 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4475.93 Median:5088.88 stddev:1389.80 (27.3%) stddev-sans-first:1357.03 10:35:01 INFO - PROCESS | 1657 | Values: 250.6 295.8 298.5 304.6 310.5 4507.8 5347.5 5355.0 5448.1 5496.9 4015.5 4840.3 4880.8 5204.8 5272.7 3875.3 3985.7 3998.3 4018.7 4057.9 3748.5 3983.4 3997.6 4051.9 4057.4 3600.3 3709.6 4014.4 4014.7 4064.2 3339.8 3477.1 3638.3 3948.8 4079.9 3493.5 3512.5 3521.6 3538.2 3555.9 4151.9 5062.7 5066.3 5095.9 5132.6 4356.0 4568.6 4570.1 4586.3 4606.8 4192.9 4899.0 5455.5 5461.5 5491.6 3851.5 3875.5 3890.3 3913.1 3916.4 4652.6 4814.2 5240.7 5771.3 5844.6 3313.7 3353.6 3612.2 3936.2 3967.6 3972.8 3980.2 3987.8 4011.1 4029.8 3647.4 3900.7 4456.7 4595.5 4683.9 4795.4 5501.9 5536.7 5542.6 5566.5 1166.3 1310.8 1342.1 1366.5 1380.7 723.4 751.2 770.7 844.4 895.3 4227.1 4704.3 5081.9 5125.8 5328.4 5058.0 5706.8 5712.6 5759.7 5801.7 4735.4 5127.0 5146.0 5229.3 5237.9 2632.0 2820.6 2954.8 2982.7 2986.5 5481.6 5770.8 5797.4 5828.5 5848.0 5401.5 5420.6 5772.8 5782.9 5822.7 5813.3 5862.5 5862.7 5892.9 5893.6 5240.4 5611.3 5641.4 5708.0 5718.9 5191.7 5319.4 5535.4 5594.3 5615.9 5417.9 5809.0 5819.7 5845.1 5859.5 3212.0 3428.8 3591.6 3914.1 3953.6 5234.9 5444.6 5637.5 5738.6 5775.2 4863.7 5345.0 5346.5 5582.0 5591.8 5471.3 5570.6 5570.7 5604.3 5654.9 5546.5 5583.3 5584.4 5614.3 5638.6 4421.0 4611.2 4921.6 5269.8 5580.5 5428.6 5462.7 5467.6 5470.9 5473.2 10:35:01 INFO - PROCESS | 1657 | 10:35:01 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:25187.61 Median:3795.18 stddev:41279.15 (1087.7%) stddev-sans-first:41353.98 10:35:01 INFO - PROCESS | 1657 | Values: 695.1 715.5 742.5 754.6 826.8 14779.5 15584.0 15934.6 15968.8 15990.9 12149.5 14105.7 14115.6 14146.9 14200.2 674.9 702.8 828.0 829.0 865.6 658.0 852.4 853.2 853.4 854.0 903.8 906.4 907.4 907.9 912.1 703.7 863.0 899.2 903.2 903.5 667.4 667.5 667.9 668.9 669.6 13556.3 13576.5 13579.0 13595.0 13600.0 13261.5 13636.4 13695.3 13751.4 13863.5 12042.5 12359.8 12374.4 12432.4 12928.0 4469.1 4521.4 4542.9 4619.0 4714.6 77830.0 97563.0 119602.2 119768.0 124235.0 10937.7 10983.8 10986.6 11521.3 11583.2 21965.7 22022.0 22031.3 22036.6 22039.0 7641.4 7761.2 8059.3 8172.8 8172.8 4386.3 4391.8 4446.7 4608.1 4623.2 3639.6 3787.6 3792.1 3798.3 3799.9 666.7 680.3 681.9 698.7 705.2 567.5 595.0 649.2 658.2 675.2 9102.7 9188.4 9410.0 9599.3 9660.1 557.3 563.3 585.0 612.5 683.1 3519.7 4167.6 4409.4 4490.5 4614.9 155841.0 157003.0 159852.0 161123.0 163579.0 111339.4 134716.0 136066.0 138519.0 139693.0 115155.0 119065.0 120277.0 121470.8 123327.0 8753.5 8800.6 8839.8 8890.7 8986.6 48285.0 58451.7 59914.7 60848.7 61143.4 80471.0 84959.0 93247.0 95883.5 97295.0 10859.9 11342.8 11412.7 11554.6 11853.9 12362.9 12458.6 12502.4 13094.5 14542.3 9958.0 11745.5 12186.1 13664.0 14267.9 13484.9 13501.3 13967.9 14272.7 14536.0 13420.4 13484.8 13742.6 13785.0 13862.3 10715.5 10771.8 11451.0 11787.7 11811.1 11396.5 11456.3 11479.8 11658.2 11701.4 10:35:01 INFO - PROCESS | 1657 | -------- Summary: end -------- 10:35:01 INFO - PROCESS | 1657 | 10:35:02 INFO - TEST-INFO | 1657: exit 0 10:35:02 INFO - TEST-OK | dromaeo_css | took 1117296ms 10:35:02 INFO - TEST-START | kraken 10:35:02 INFO - operating with platform_type : mac_ 10:35:02 INFO - Initialising browser for kraken test... 10:35:02 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpniQn_P/profile http://localhost:49267/getInfo.html) 10:35:04 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 10:35:04 INFO - PROCESS | 1668 | colorDepth:24 10:35:04 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 10:35:04 INFO - PROCESS | 1668 | __metrics 10:35:04 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:35:04 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:05 INFO - TEST-INFO | 1668: exit 0 10:35:05 INFO - Browser initialized. 10:35:05 INFO - Running cycle 1/1 for kraken test... 10:35:05 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpniQn_P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:17 INFO - PROCESS | 1669 | RSS: Main: 243671040 10:35:17 INFO - PROCESS | 1669 | 10:35:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:20 INFO - PROCESS | 1669 | RSS: Main: 293085184 10:35:20 INFO - PROCESS | 1669 | 10:35:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 10:35:24 INFO - PROCESS | 1669 | RSS: Main: 299769856 10:35:24 INFO - PROCESS | 1669 | 10:35:27 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 10:35:28 INFO - PROCESS | 1669 | RSS: Main: 393187328 10:35:28 INFO - PROCESS | 1669 | 10:35:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 10:35:30 INFO - PROCESS | 1669 | RSS: Main: 294907904 10:35:30 INFO - PROCESS | 1669 | 10:35:32 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:33 INFO - PROCESS | 1669 | RSS: Main: 300441600 10:35:33 INFO - PROCESS | 1669 | 10:35:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:37 INFO - PROCESS | 1669 | RSS: Main: 338182144 10:35:37 INFO - PROCESS | 1669 | 10:35:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:40 INFO - PROCESS | 1669 | RSS: Main: 337870848 10:35:40 INFO - PROCESS | 1669 | 10:35:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 10:35:43 INFO - PROCESS | 1669 | RSS: Main: 337186816 10:35:43 INFO - PROCESS | 1669 | 10:35:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:46 INFO - PROCESS | 1669 | RSS: Main: 313769984 10:35:46 INFO - PROCESS | 1669 | 10:35:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:48 INFO - PROCESS | 1669 | RSS: Main: 319479808 10:35:48 INFO - PROCESS | 1669 | 10:35:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:51 INFO - PROCESS | 1669 | RSS: Main: 325275648 10:35:51 INFO - PROCESS | 1669 | 10:35:54 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:55 INFO - PROCESS | 1669 | RSS: Main: 329830400 10:35:55 INFO - PROCESS | 1669 | 10:35:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:58 INFO - PROCESS | 1669 | RSS: Main: 332423168 10:35:58 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 10:36:00 INFO - PROCESS | 1669 | RSS: Main: 376332288 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | __start_tp_report 10:36:00 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 10:36:00 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 10:36:00 INFO - PROCESS | 1669 | |i|pagename|runs| 10:36:00 INFO - PROCESS | 1669 | |0;ai-astar;102;113;112;113;113;114;113;113;113;114 10:36:00 INFO - PROCESS | 1669 | |1;audio-beat-detection;144;106;106;167;106;106;125;105;157;134 10:36:00 INFO - PROCESS | 1669 | |2;audio-dft;182;185;185;186;185;182;182;184;185;190 10:36:00 INFO - PROCESS | 1669 | |3;audio-fft;78;59;64;87;57;58;65;68;83;56 10:36:00 INFO - PROCESS | 1669 | |4;audio-oscillator;84;90;95;72;71;69;126;100;97;103 10:36:00 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;94;86;95;91;91;91;95;90;94;86 10:36:00 INFO - PROCESS | 1669 | |6;imaging-darkroom;95;95;95;95;96;93;100;148;133;94 10:36:00 INFO - PROCESS | 1669 | |7;imaging-desaturate;86;85;86;86;85;84;86;85;85;86 10:36:00 INFO - PROCESS | 1669 | |8;json-parse-financial;53;54;54;55;55;55;53;52;55;52 10:36:00 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;66;78;67;76;73;70;70;70;71;72 10:36:00 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;86;83;80;84;84;85;86;83;86;82 10:36:00 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;133;137;137;137;148;173;146;144;207;138 10:36:00 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;166;163;164;165;164;162;160;159;212;144 10:36:00 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;68;67;68;68;68;66;70;66;66;66 10:36:00 INFO - PROCESS | 1669 | __end_tp_report 10:36:00 INFO - PROCESS | 1669 | __start_cc_report 10:36:00 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,2173 10:36:00 INFO - PROCESS | 1669 | __end_cc_report 10:36:00 INFO - PROCESS | 1669 | __startTimestamp1470850560664__endTimestamp 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | ------- Summary: start ------- 10:36:00 INFO - PROCESS | 1669 | Number of tests: 14 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.56 (3.1%) stddev-sans-first:0.60 10:36:00 INFO - PROCESS | 1669 | Values: 102.0 113.0 112.0 113.0 113.0 114.0 113.0 113.0 113.0 114.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:125.60 Median:129.50 stddev:23.74 (18.3%) stddev-sans-first:24.22 10:36:00 INFO - PROCESS | 1669 | Values: 144.0 106.0 106.0 167.0 106.0 106.0 125.0 105.0 157.0 134.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:2.41 (1.3%) stddev-sans-first:2.37 10:36:00 INFO - PROCESS | 1669 | Values: 182.0 185.0 185.0 186.0 185.0 182.0 182.0 184.0 185.0 190.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:67.50 Median:66.50 stddev:11.33 (17.0%) stddev-sans-first:11.36 10:36:00 INFO - PROCESS | 1669 | Values: 78.0 59.0 64.0 87.0 57.0 58.0 65.0 68.0 83.0 56.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:78.00 stddev:17.63 (22.6%) stddev-sans-first:18.53 10:36:00 INFO - PROCESS | 1669 | Values: 84.0 90.0 95.0 72.0 71.0 69.0 126.0 100.0 97.0 103.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:92.50 stddev:3.33 (3.6%) stddev-sans-first:3.39 10:36:00 INFO - PROCESS | 1669 | Values: 94.0 86.0 95.0 91.0 91.0 91.0 95.0 90.0 94.0 86.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:104.40 Median:95.00 stddev:19.44 (20.5%) stddev-sans-first:20.32 10:36:00 INFO - PROCESS | 1669 | Values: 95.0 95.0 95.0 95.0 96.0 93.0 100.0 148.0 133.0 94.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 10:36:00 INFO - PROCESS | 1669 | Values: 86.0 85.0 86.0 86.0 85.0 84.0 86.0 85.0 85.0 86.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.50 stddev:1.23 (2.3%) stddev-sans-first:1.27 10:36:00 INFO - PROCESS | 1669 | Values: 53.0 54.0 54.0 55.0 55.0 55.0 53.0 52.0 55.0 52.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:3.68 (5.2%) stddev-sans-first:3.37 10:36:00 INFO - PROCESS | 1669 | Values: 66.0 78.0 67.0 76.0 73.0 70.0 70.0 70.0 71.0 72.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.50 stddev:1.97 (2.3%) stddev-sans-first:1.94 10:36:00 INFO - PROCESS | 1669 | Values: 86.0 83.0 80.0 84.0 84.0 85.0 86.0 83.0 86.0 82.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:145.00 stddev:23.03 (15.9%) stddev-sans-first:23.59 10:36:00 INFO - PROCESS | 1669 | Values: 133.0 137.0 137.0 137.0 148.0 173.0 146.0 144.0 207.0 138.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:164.00 stddev:17.38 (10.6%) stddev-sans-first:18.44 10:36:00 INFO - PROCESS | 1669 | Values: 166.0 163.0 164.0 165.0 164.0 162.0 160.0 159.0 212.0 144.0 10:36:00 INFO - PROCESS | 1669 | 10:36:00 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.34 (2.0%) stddev-sans-first:1.39 10:36:00 INFO - PROCESS | 1669 | Values: 68.0 67.0 68.0 68.0 68.0 66.0 70.0 66.0 66.0 66.0 10:36:00 INFO - PROCESS | 1669 | -------- Summary: end -------- 10:36:00 INFO - PROCESS | 1669 | 10:36:01 INFO - TEST-INFO | 1669: exit 0 10:36:01 INFO - TEST-OK | kraken | took 59427ms 10:36:01 INFO - SUITE-END | took 1176s 10:36:01 INFO - Completed test suite (00:19:36) 10:36:01 INFO - javascript benchmark 10:36:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3403.965960340396, 3419.316136772646, 3419.538362321086, 3424.8116353600544, 3471.114865709244, 5668.914966275509, 5723.771049158039, 5727.312722473303, 5868.4131586841295, 5891.410858914106, 5703.258576385064, 5707.942920570793, 5829.154772557977, 5866.73599688014, 5869.677167755772, 5162.612804039693, 5219.686818790866, 5219.973900130494, 5224.921626175591, 5403.945960540384, 5367.892642147155, 5368.141097424413, 5369.677819330833, 5424.349078110632, 5425.0, 5214.869628259324, 5268.736563171826, 5273.630845840793, 5278.63049586531, 5326.174442961347, 5303.098473259555, 5304.867378315573, 5306.52241298285, 5314.043472175045, 5317.840464786024, 5158.3552055993005, 5233.581313494949, 5260.92108618371, 5268.473152684739, 5308.814191503279, 4663.44038715353, 5671.744771485293, 5719.799807006735, 5793.942060579382, 5798.565107616945, 6246.250449946036, 6274.686265686743, 6301.747930082791, 6318.87362252757, 6352.650604216767, 6311.242650881878, 6353.5234857385885, 6380.138681278015, 6397.648129352884, 6415.8396040098905, 5509.228707980846, 5545.667259964374, 5780.104083867007, 5862.062070068769, 5883.382244864313, 6334.683265836689, 6335.936640633627, 6345.96827015862, 6348.111264422984, 6360.1731774869895, 6238.688065596702, 6248.687565621701, 6254.843628909313, 6262.12330273762, 6264.404881536247, 6102.428659372087, 6128.625347140816, 6134.601250918676, 6162.106494558354, 6233.438990490878, 5133.6919784813035, 6057.727402266909, 6073.392660733891, 6093.360197179321, 6101.755929762849, 6042.939570604326, 6064.636121832704, 6107.144999700045, 6114.510839132948, 6139.508839292846, 4905.779239934212, 4908.509149085135, 4943.728094954812, 4960.404751429852, 5030.622703297194, 4415.602595766396, 4436.401085853368, 4491.46102467706, 4519.276915693474, 4542.886427839265, 5654.264945557051, 5677.744501497443, 5682.40334764852, 5691.203231547586, 5759.222504961776, 6174.073888916699, 6201.224846894138, 6238.064290356483, 6249.96875015622, 6275.309715931244, 5701.572382071361, 5748.993926062923, 5770.394108618619, 5791.478766910998, 5825.1844741736195, 5452.073147564924, 5511.145772405283, 5511.614187006951, 5530.0, 5530.695811730313, 6267.4045965633195, 6336.986082226822, 6338.683065846689, 6348.936510634834, 6350.841228969312, 5392.406835248041, 6262.906056409249, 6274.592151510137, 6316.747330106744, 6334.1765570475545, 6322.620642761449, 6338.873222535616, 6340.968295158495, 6361.236651601837, 6364.236291645032, 5091.4144873338555, 6290.528210384331, 6304.18045654062, 6304.65324407162, 6438.742450301936, 6191.4118158774845, 6256.06159076124, 6266.498680105672, 6316.084167795552, 6361.936380636134, 6194.535409844189, 6197.473214776614, 6214.8135555933395, 6227.159333490102, 6247.562670613013, 6205.782797602063, 6207.286162091417, 6209.285932117684, 6212.9068063978175, 6222.906656400248, 5896.970515147397, 5959.463648271676, 5997.730102145327, 6007.789727359522, 6069.666168360783, 6149.508039356751, 6189.907151392823, 6202.906956395748, 6203.96898015507, 6219.378062193744, 5855.0, 5874.970625146847, 5965.8806823862415, 6001.189839371629, 6025.758969641165], "value": 5731.995250588002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.34286627256756, 517.5574883474629, 539.175062154903, 539.7112544788539, 542.987328632101, 30730.69269307309, 40368.59631403685, 41406.58593414065, 41413.79293103538, 41488.0, 42838.14323713524, 43240.13519729603, 43347.0, 43438.56561434385, 43473.13053738923, 8636.524991125485, 9599.904000960007, 9781.608735650565, 9787.119159275664, 9789.461579613118, 8696.04343522212, 11605.30368177912, 11741.589044383449, 11762.0590352772, 12067.456964436578, 11675.766484670301, 11757.706057348549, 11771.470283837205, 11783.234089784179, 11846.644600661952, 11786.46960886758, 11885.762284754299, 11889.821652675217, 11902.702432439259, 11913.106517011172, 10593.78812423755, 11334.943325283402, 11413.942930285379, 11420.14348923834, 11440.94279528597, 40890.59109408927, 41010.0, 41012.0, 41020.794896025625, 41117.38323925144, 3401.812900290483, 3601.9279614407565, 3679.337719210541, 3900.180961997984, 4346.521882592912, 31914.840425797956, 32280.496103392823, 33202.833985829915, 33238.0, 33451.832740836384, 3197.7441804655573, 3250.8374581271078, 3322.700956913865, 3340.6325304216516, 3389.7288216942584, 481418.0, 485800.0, 485851.0, 487631.0, 487736.0, 62252.75494490175, 62566.0615090774, 62640.37359626436, 62643.6867815658, 62730.0, 65262.34737652657, 65513.0, 65553.01670474946, 65602.34397656057, 65631.34368656347, 16235.91882040606, 16432.424865129902, 16440.75338869918, 16471.25879335433, 16480.0, 11403.657890263305, 11610.24533405326, 12521.812172817416, 12750.936245318713, 12762.68093297675, 17542.91228543849, 17793.19930603126, 17815.287388504574, 17875.46373608794, 18142.727859082126, 6300.30696623371, 6787.694553745093, 7007.754728584475, 7126.2873712628325, 7155.89266161008, 892.3887137310833, 992.5781542844262, 1025.3898930136556, 1069.3316677076828, 1080.56777289085, 30235.395292094036, 30368.39263214723, 30461.086167415015, 30778.53832192519, 31117.377652447278, 999.9600015999424, 1048.7587854793287, 1051.695008447557, 1063.9946800266105, 1097.5280629329466, 15728.60678483047, 15795.0, 15808.209589520478, 16062.277197526138, 16158.27287772053, 517967.0, 614776.0, 616080.0, 616674.0, 617523.0, 59151.704241479376, 59171.0, 59191.70404147952, 59236.0, 59306.0, 1242.9254244745343, 1353.3368649361742, 1375.0924389902616, 1396.294871090093, 1403.4596680278166, 25528.489430211663, 28239.01163459269, 31024.53463198099, 31981.0, 33066.842660506765, 51131.0, 51791.0, 51823.74088129535, 51834.222486663486, 51849.0, 524130.0, 527044.0, 528234.0, 528281.0, 530540.0, 26371.472570548864, 27272.181834544994, 27282.863585681946, 28089.297767555974, 28112.87548498037, 48115.5188448111, 48499.75750121227, 48703.0, 48948.2657760141, 50019.0, 39515.81452556428, 39700.2059958805, 40268.81800901133, 40418.39372409475, 41280.79359603183, 38540.0, 39604.405933910435, 39691.603083969945, 39775.40336894891, 41049.384259235536, 33395.83302083474, 38266.426003610526, 38862.6113738859, 39062.828115155455, 39081.413778792776, 32940.835295823366, 34071.82964085164, 34289.48565771466, 34531.136721581155, 34601.0, 25490.490190196462, 25583.872080640223, 25621.10326138576, 25867.741322587288, 26318.60522092132], "value": 20524.491046027037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.9003479025874, 376.4353469795307, 378.4247943126448, 385.94596756454104, 409.32665764816875, 15272.923635381821, 15522.0, 20689.482762930897, 21078.789212107873, 21141.788582114175, 20763.792362076376, 21016.789832101673, 21322.0, 21600.243991460302, 21656.891715541402, 4847.709137451755, 5039.622028347871, 5046.419661738892, 5847.79532716355, 6118.112873633343, 3889.4165875118815, 6142.815715528542, 6178.41305076017, 6199.659018753967, 6203.534734894901, 5852.473277405054, 6125.5712100153005, 6145.907811382833, 6200.78297259596, 6212.068189771525, 5186.429492755794, 5792.160136780185, 6149.385061493815, 6176.413240742122, 6186.8453288667915, 5901.940980590182, 5911.320198177222, 5912.201852749909, 5913.940860591425, 5922.378150294243, 13004.284764337957, 13362.866371336357, 13408.195508269535, 13575.117617354841, 13704.3833027514, 2319.0375993962653, 2420.407000284924, 2435.549423356667, 2689.233568433007, 2711.552593822017, 10015.44915029673, 10088.64689735863, 10526.052655261063, 10558.419286939215, 10560.788784224349, 1840.1811194018667, 1841.9723704144449, 1868.7664041994751, 1897.2411035585737, 1897.4307707687638, 102312.46531302037, 109399.0, 115156.0, 118398.40800795941, 128810.35594822059, 11453.54185832574, 11531.88468115308, 11557.133215008907, 11664.650060498028, 11899.940500297444, 14607.123572585679, 14620.780688289684, 14625.122492650475, 14642.267886605627, 14683.55949321522, 8263.173682631808, 8512.574371281535, 8556.058833528306, 8624.223819856243, 8638.222559969507, 8502.1922917324, 8503.74488765338, 8522.65909363631, 8679.566021699016, 8699.608517616722, 4436.578525040116, 4527.0553432762235, 4528.796204170821, 4606.30905364198, 4637.768111594407, 1873.4566975577202, 1892.4606487151095, 1923.5960448306012, 1935.2839449403812, 1941.4660968233566, 867.8915135608049, 871.0549054276181, 873.4235404632911, 906.6418764588083, 938.3947353956796, 19469.90265048694, 20913.477163071046, 21648.89175554112, 21695.132194712034, 21798.0, 916.922061624756, 934.7008957133788, 967.656481948898, 985.3841349156777, 997.2670087485692, 10499.265051446479, 10516.0, 11372.715682108013, 11430.485628146587, 11438.828417573743, 546138.0, 576618.1169094128, 582259.0, 583701.0, 592638.0, 76669.6166519175, 76891.2331575123, 81142.59428702819, 136303.0, 137728.0, 950.3205208276116, 957.4494665567327, 966.8066386722825, 969.7042402067437, 971.2666936462925, 16324.347026119298, 18667.533311666775, 18970.715439268148, 19081.522961926064, 19082.0, 56719.43280567307, 57043.0, 57401.56496087631, 57639.13541296968, 57722.71138644448, 81621.0, 82841.0, 82975.58512207642, 83753.16246837698, 84468.0, 8108.148644392254, 8178.1821817817745, 8309.626066827128, 8537.0, 8563.272121869712, 9439.764005899908, 12789.8081528779, 13150.0, 13625.773680368815, 13633.79549306781, 11258.38078905668, 11525.250858694159, 11859.0, 11862.703432414259, 11947.581834635746, 8085.757427277191, 9517.381370211191, 9763.1701305387, 9799.265055121037, 10248.231382646181, 10823.647044119485, 11577.884221158018, 11609.709757255798, 11728.472218750347, 11787.646370608896, 5651.717414129359, 7388.926110738824, 7401.444891633041, 7484.588347640932, 7655.2344765523, 9566.952165239129, 9633.614655413985, 10717.303375280582, 10935.781284374109, 11437.199396042197], "value": 9321.705420051518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.3432318164103, 1477.9187144707041, 1486.5168820133458, 1703.2335449047923, 1900.4488698277491, 7674.424418168639, 8405.243528082472, 8699.434536755107, 8750.124987501247, 8826.77933051674, 8620.0, 8688.782780430492, 8701.999270083943, 8709.651613935452, 8731.083236260181, 2302.792748652625, 2328.9650655240184, 2333.8249631277636, 2334.3580515358244, 2336.4626135988733, 2285.885705714716, 2319.3158018384615, 2338.7778161074757, 2339.8596084235, 2340.216027630746, 2280.053777682268, 2308.7922087012166, 2315.0623997281127, 2320.118355025088, 2329.8485598436046, 2264.547090581874, 2277.146070223666, 2286.588414085464, 2291.724993000834, 2293.3578597992505, 2255.4699645583273, 2267.2744721689064, 2268.671042698816, 2268.6823844661762, 2271.3072512883564, 8684.0, 8700.042995270514, 8763.079876612928, 8777.956110219407, 8797.428167169113, 5124.0776660201145, 5343.519083282485, 5345.679259244419, 5376.677399356012, 5378.058839703075, 3579.8210089495683, 3591.4612808078737, 3634.1823089804584, 3644.0, 3649.160693040589, 1082.220801023262, 1083.5774048121239, 1086.8369744538304, 1102.8070087734613, 1112.2992514715677, 10616.469176541143, 11370.658880233523, 11427.60003399877, 11521.711957201138, 11528.942355288254, 4072.1041370898356, 4103.815328310233, 4315.5900189481945, 4555.476120246214, 4565.269556870885, 8594.87107693385, 9057.501837398875, 9067.909320906838, 9068.229200517899, 9075.727728168165, 5169.302144210558, 5182.844514664566, 5184.533391994739, 5188.870278243074, 5201.219817027476, 4385.824567017347, 4533.52397998212, 4625.4911959684405, 4858.927116093261, 4862.270659401118, 3882.1847412043785, 3894.7273690841935, 4003.619656132663, 4049.797510124482, 4058.5941405859176, 1265.1523479268913, 1282.4357282795727, 1284.865089165624, 1297.2994582925303, 1299.883010529057, 765.7855800375904, 865.523961820996, 888.1562515610067, 897.6588896219525, 952.842780941137, 5527.723613819293, 5696.458836410535, 5848.1227815827115, 6007.128966299862, 6108.4807791338235, 777.8444311137795, 960.7510236692272, 964.1226483899758, 978.3493976505687, 1023.5445226874118, 3558.8576456941432, 3777.8111094445167, 3842.5965273645866, 3872.896224575982, 3946.3291240489184, 10170.033846784543, 10622.628208012682, 10632.89367106319, 10655.041046305869, 10659.14726821868, 10568.678915135608, 10590.4704764763, 10595.894041059644, 10596.364218146937, 10599.523021464052, 6775.457963362919, 8080.959595201986, 8100.392470564731, 8100.878486822702, 8115.0, 5125.410577783603, 5826.592138550261, 5950.375210602824, 6003.879922401615, 6172.537059720449, 7770.844583108419, 9734.513274336396, 9796.281309634573, 9813.950930245303, 9869.654562090293, 9723.85414218773, 9830.311878168459, 10012.098911098035, 10034.29759916828, 10096.444695541815, 6192.969035154975, 6896.413804826646, 7119.359257666835, 7408.777736667908, 7590.8102297443, 8150.0, 8378.706745263886, 8387.32901367877, 8388.203120703523, 8396.37027222973, 7224.0, 7427.925720742724, 7446.553206807609, 7499.175090740124, 7532.058492688414, 7180.461465390221, 7257.201707812031, 7272.636368181464, 7338.082739657543, 7360.77917662471, 6895.931040689529, 6902.447804175554, 6981.685824138028, 6983.825404364931, 6986.6157361343585, 4708.293755936637, 4746.121967436035, 4812.205986012409, 4832.806687732592, 4890.828820991248, 4809.78355973975, 4874.829380971649, 4938.555530002317, 5001.324821149244, 5055.721935293447], "value": 4504.692104310044, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [250.5715226961895, 295.7973787955251, 298.47319481115835, 304.6146624519982, 310.46754815491454, 4507.797149128289, 5347.518723314901, 5355.0, 5448.101063324551, 5496.862578435536, 4015.4980627421573, 4840.322354870321, 4880.804202970268, 5204.776877433809, 5272.650063697455, 3875.3218186817335, 3985.7010724195657, 3998.280309544281, 4018.6584140348104, 4057.8782636520805, 3748.512693349861, 3983.3825757007567, 3997.6402123808853, 4051.858184963527, 4057.411675307079, 3600.2799440111953, 3709.6475834795788, 4014.4179094031347, 4014.7189696721243, 4064.1871625674985, 3339.7662163648556, 3477.0959550516795, 3638.290533345972, 3948.756141815333, 4079.8572049978256, 3493.4934434506854, 3512.543369361992, 3521.5774107107054, 3538.2392785550974, 3555.911102222465, 4151.875443736692, 5062.696238225682, 5066.265391518246, 5095.898082038376, 5132.589392848563, 4355.956440435587, 4568.588827005552, 4570.08056616222, 4586.289125185602, 4606.825259558825, 4192.895177620553, 4899.036083169667, 5455.454454554552, 5461.460420904298, 5491.615586908918, 3851.480050193216, 3875.476810630557, 3890.3386424307937, 3913.063033798288, 3916.432117342998, 4652.55800698933, 4814.15752243356, 5240.68555886648, 5771.307443106812, 5844.561657875676, 3313.7349012078976, 3353.5975682918206, 3612.230007296406, 3936.173403585222, 3967.6230758077936, 3972.7553932028313, 3980.24375368679, 3987.8205480752854, 4011.117554138085, 4029.778362190049, 3647.379945409287, 3900.7074469414906, 4456.732596044248, 4595.540445955377, 4683.9390668105925, 4795.376601041842, 5501.944980550224, 5536.695481748542, 5542.61201715876, 5566.526845218121, 1166.3410173252084, 1310.7968264918952, 1342.0806747378078, 1366.5012270521188, 1380.6548362909273, 723.4284914917262, 751.2074761126954, 770.6570576093585, 844.3667249562828, 895.3150839607705, 4227.062191776748, 4704.341392205094, 5081.856582269033, 5125.846224613268, 5328.415718376585, 5058.015770695234, 5706.831404066511, 5712.571557133231, 5759.712014399263, 5801.6519008859605, 4735.384400027974, 5126.974365128151, 5146.0479811235045, 5229.294045303911, 5237.857285628668, 2631.973680263211, 2820.633317668731, 2954.793164478509, 2982.6719060903283, 2986.4922963096324, 5481.616286859881, 5770.826045674862, 5797.391273916178, 5828.5337173026055, 5847.970760146172, 5401.459854014567, 5420.593455490854, 5772.806333593292, 5782.913256301159, 5822.7000334868335, 5813.331466881278, 5862.530997520103, 5862.736176872051, 5892.94107058924, 5893.557983151195, 5240.423553409199, 5611.270534830446, 5641.407652196624, 5707.971460142673, 5718.914216286842, 5191.662541934913, 5319.441458646941, 5535.426026897512, 5594.272744543184, 5615.894039735099, 5417.918731219113, 5808.9543882101625, 5819.679917604572, 5845.064789633639, 5859.4666946355355, 3211.9518207226442, 3428.794272343667, 3591.6408359163875, 3914.119323152268, 3953.6046395361386, 5234.895302094013, 5444.591655625764, 5637.49262566371, 5738.569607279387, 5775.220345253505, 4863.659543831898, 5345.006796194144, 5346.518813306821, 5581.985727706992, 5591.82571659956, 5471.2613797138465, 5570.61005729595, 5570.721463926707, 5604.281923267131, 5654.858628534155, 5546.500814926676, 5583.274174357308, 5584.4136365681015, 5614.2701448811395, 5638.645006221292, 4420.983173869963, 4611.239145540948, 4921.557059864486, 5269.809237900741, 5580.525655319343, 5428.647137936022, 5462.726863656721, 5467.589930755289, 5470.890582188414, 5473.151661492475], "value": 4023.9683607483043, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.0512550368749, 715.5241764226789, 742.4951033297363, 754.6302311867187, 826.8346330733855, 14779.482718104855, 15584.0, 15934.601634959132, 15968.760468592965, 15990.920045399786, 12149.453274602642, 14105.717885642282, 14115.647108822284, 14146.92926535366, 14200.218987955659, 674.9325067493261, 702.7786247332074, 828.035338830262, 829.0300348592161, 865.6234537976001, 657.9868402631945, 852.4160949749441, 853.1553761775859, 853.3770347646222, 853.9573021348908, 903.8463461211577, 906.3519583497798, 907.3920473282883, 907.9364444488889, 912.0651332384293, 703.7255470366562, 862.9525376104311, 899.1862364560084, 903.2457897655432, 903.5346796399859, 667.3860048755157, 667.4660271782554, 667.8998150277449, 668.9431398331147, 669.5781657555709, 13556.254406007665, 13576.456941722417, 13579.049466537346, 13595.0, 13600.04799664024, 13261.469541218436, 13636.386362613606, 13695.315234238347, 13751.449942002308, 13863.514776982858, 12042.458089385998, 12359.814602780965, 12374.443150058269, 12432.440540175714, 12928.0, 4469.1061787642275, 4521.412216411845, 4542.863714088583, 4618.976905115486, 4714.575688188045, 77830.0, 97563.04873902553, 119602.20596691057, 119768.0, 124235.0, 10937.726556835984, 10983.791782903874, 10986.560537578567, 11521.251118677259, 11583.189176757545, 21965.67051494229, 22022.0, 22031.33905982823, 22036.559268814533, 22039.0, 7641.3886889048745, 7761.223877612307, 8059.274665280153, 8172.7956801080445, 8172.836543269102, 4386.342048692658, 4391.780410979438, 4446.688731788744, 4608.101420223092, 4623.16782979067, 3639.636036396339, 3787.5833658297565, 3792.089898424358, 3798.2783271178387, 3799.886003419902, 666.6899891550453, 680.3332733920786, 681.8908974564046, 698.6820996446604, 705.1995984557564, 567.5062695454981, 594.9583529152918, 649.2403887451693, 658.2495954611746, 675.2032601530143, 9102.726918192464, 9188.38266421464, 9410.01194874542, 9599.280053995839, 9660.130588247092, 557.345119484612, 563.2847977907282, 585.0054906658697, 612.4946918792015, 683.1494788987643, 3519.6832285094465, 4167.562405947392, 4409.4488188976375, 4490.50604433512, 4614.884627884329, 155841.0, 157003.0, 159852.0, 161123.0, 163579.0, 111339.44330278458, 134716.0, 136066.0, 138519.0, 139693.0, 115155.0, 119065.0, 120277.0, 121470.78529214772, 123327.0, 8753.518556479201, 8800.60397282111, 8839.779005524657, 8890.688825891062, 8986.550672466481, 48285.03429931452, 58451.70774146102, 59914.70042649759, 60848.69575652093, 61143.38856611555, 80471.0, 84959.0, 93247.0, 95883.52058239664, 97295.0, 10859.891401085888, 11342.773144537228, 11412.657620271406, 11554.59558915434, 11853.940730296294, 12362.938185309016, 12458.626241212778, 12502.374881255719, 13094.541691040768, 14542.345594448063, 9957.950210248902, 11745.530178792753, 12186.146969712036, 13664.0, 14267.857321426653, 13484.932575337061, 13501.324933753469, 13967.860321396656, 14272.714545709236, 14536.0, 13420.351226802839, 13484.797728034284, 13742.587722368346, 13785.0, 13862.306884655929, 10715.464226788785, 10771.838422423827, 11451.0, 11787.705307367385, 11811.055115590903, 11396.487158078073, 11456.312621242752, 11479.8278025828, 11658.18392712502, 11701.356425396685], "value": 7763.921105492117, "unit": "score"}], "name": "dromaeo_css", "value": 7324.0909515018, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 112.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 106.0, 106.0, 167.0, 106.0, 106.0, 125.0, 105.0, 157.0, 134.0], "value": 125.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 185.0, 186.0, 185.0, 182.0, 182.0, 184.0, 185.0, 190.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 64.0, 87.0, 57.0, 58.0, 65.0, 68.0, 83.0, 56.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 95.0, 72.0, 71.0, 69.0, 126.0, 100.0, 97.0, 103.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 86.0, 95.0, 91.0, 91.0, 91.0, 95.0, 90.0, 94.0, 86.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 93.0, 100.0, 148.0, 133.0, 94.0], "value": 104.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 85.0, 84.0, 86.0, 85.0, 85.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 55.0, 55.0, 55.0, 53.0, 52.0, 55.0, 52.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 67.0, 76.0, 73.0, 70.0, 70.0, 70.0, 71.0, 72.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 80.0, 84.0, 84.0, 85.0, 86.0, 83.0, 86.0, 82.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 137.0, 137.0, 137.0, 148.0, 173.0, 146.0, 144.0, 207.0, 138.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 164.0, 165.0, 164.0, 162.0, 160.0, 159.0, 212.0, 144.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 66.0, 70.0, 66.0, 66.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1453.6999999999998, "alertThreshold": 2.0}]} 10:36:01 INFO - Return code: 0 10:36:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:36:01 INFO - # TBPL SUCCESS # 10:36:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:36:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:36:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:36:01 INFO - 2016-08-10 10:36:01.980 screenresolution[1673:9957] starting screenresolution argv=screenresolution get 10:36:01 INFO - 2016-08-10 10:36:01.983 screenresolution[1673:9957] Display 0: 1600x1200x32@60 10:36:01 INFO - 2016-08-10 10:36:01.989 screenresolution[1674:9960] starting screenresolution argv=screenresolution list 10:36:01 INFO - Available Modes on Display 0 10:36:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:36:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:36:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:36:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:36:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:36:02 INFO - Intel Iris: 10:36:02 INFO - Chipset Model: Intel Iris 10:36:02 INFO - Type: GPU 10:36:02 INFO - Bus: Built-In 10:36:02 INFO - VRAM (Dynamic, Max): 1536 MB 10:36:02 INFO - Vendor: Intel (0x8086) 10:36:02 INFO - Device ID: 0x0a2e 10:36:02 INFO - Revision ID: 0x0009 10:36:02 INFO - Displays: 10:36:02 INFO - Display: 10:36:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:36:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:36:02 INFO - Display Serial Number: 1600x1200 60 10:36:02 INFO - Main Display: Yes 10:36:02 INFO - Mirror: Off 10:36:02 INFO - Online: Yes 10:36:02 INFO - Rotation: Supported 10:36:02 INFO - Return code: 0 10:36:02 INFO - Running post-action listener: _resource_record_post_action 10:36:02 INFO - [mozharness: 2016-08-10 17:36:02.224199Z] Finished run-tests step (success) 10:36:02 INFO - Running post-run listener: _resource_record_post_run 10:36:02 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 38155264; Write bytes: 703703040; Read time: 385; Write time: 2532 10:36:02 INFO - TinderboxPrint: CPU usage
53.5% 10:36:02 INFO - TinderboxPrint: I/O read bytes / time
38,155,264 / 385 10:36:02 INFO - TinderboxPrint: I/O write bytes / time
703,703,040 / 2,532 10:36:02 INFO - TinderboxPrint: CPU idle
2,257.4 (46.5%) 10:36:02 INFO - TinderboxPrint: CPU system
970.1 (20.0%) 10:36:02 INFO - TinderboxPrint: CPU user
1,622.1 (33.4%) 10:36:02 INFO - TinderboxPrint: Swap in / out
441,565,184 / 0 10:36:02 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 401244672; Write bytes: 396519424; Read time: 30261; Write time: 860 10:36:02 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 34542592; Write bytes: 295272448; Read time: 354; Write time: 1639 10:36:02 INFO - Running post-run listener: _upload_blobber_files 10:36:02 INFO - Blob upload gear active. 10:36:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:36:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:36:02 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'] 10:36:02 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 10:36:03 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:36:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:36:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:03 INFO - (blobuploader) - INFO - Done attempting. 10:36:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:36:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:36:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:05 INFO - (blobuploader) - INFO - Done attempting. 10:36:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:36:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:36:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:07 INFO - (blobuploader) - INFO - Done attempting. 10:36:07 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:07 INFO - Return code: 0 10:36:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96cd98ea6c1c1bdd5729e7180a1ccae396543e836c43c50d0307436203ff4c610016f019db79cf3e86c98a95a11cb54cbeda7092d4ac0c590aa3486dbd563689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2865073bd295db2af0d416c497f6d4adbbcd695a0103090f0a0aae983e6f8e3ab74c852c209a4664764608ebd6d74332c9dd26bef86cd6d5c45114610d3fec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c31a12f48992860a65eb81d1a363707a44faba174bd3368904855250a88446cb8e5b7dee6444dd30532bd215261c83da3ec693e6e3c44043275b505d50be55b"} 10:36:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:07 INFO - Contents: 10:36:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96cd98ea6c1c1bdd5729e7180a1ccae396543e836c43c50d0307436203ff4c610016f019db79cf3e86c98a95a11cb54cbeda7092d4ac0c590aa3486dbd563689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2865073bd295db2af0d416c497f6d4adbbcd695a0103090f0a0aae983e6f8e3ab74c852c209a4664764608ebd6d74332c9dd26bef86cd6d5c45114610d3fec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c31a12f48992860a65eb81d1a363707a44faba174bd3368904855250a88446cb8e5b7dee6444dd30532bd215261c83da3ec693e6e3c44043275b505d50be55b"} 10:36:07 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:07 INFO - Copying logs to upload dir... 10:36:07 INFO - mkdir: /builds/slave/test/build/upload/logs 10:36:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.608060 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-08-10 10:36:07.656248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 10:36:07.659975) ========= 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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96cd98ea6c1c1bdd5729e7180a1ccae396543e836c43c50d0307436203ff4c610016f019db79cf3e86c98a95a11cb54cbeda7092d4ac0c590aa3486dbd563689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2865073bd295db2af0d416c497f6d4adbbcd695a0103090f0a0aae983e6f8e3ab74c852c209a4664764608ebd6d74332c9dd26bef86cd6d5c45114610d3fec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c31a12f48992860a65eb81d1a363707a44faba174bd3368904855250a88446cb8e5b7dee6444dd30532bd215261c83da3ec693e6e3c44043275b505d50be55b"} build_url:https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010934 build_url: 'https://queue.taskcluster.net/v1/task/R9vw-aXMQROjfG4cqdm64g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96cd98ea6c1c1bdd5729e7180a1ccae396543e836c43c50d0307436203ff4c610016f019db79cf3e86c98a95a11cb54cbeda7092d4ac0c590aa3486dbd563689", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2865073bd295db2af0d416c497f6d4adbbcd695a0103090f0a0aae983e6f8e3ab74c852c209a4664764608ebd6d74332c9dd26bef86cd6d5c45114610d3fec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c31a12f48992860a65eb81d1a363707a44faba174bd3368904855250a88446cb8e5b7dee6444dd30532bd215261c83da3ec693e6e3c44043275b505d50be55b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 10:36:07.695805) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 10:36:07.696161) ========= 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.FnJCO5P5Ew/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.8CPbEfyRO6/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005020 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 10:36:07.748111) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 10:36:07.748440) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 10:36:07.748789) ========= ========= Total master_lag: 0.22 =========