builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0232 starttime: 1471953890.62 results: success (0) buildid: 20160823033146 builduid: 5be4b92a78e64c48b5afda22a060b1f8 revision: c01a9c030fd094e73d45bf88639fc320127b9a3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 05:04:50.617398) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 05:04:50.617880) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-08-23 05:04:50.618157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-08-23 05:04:54.223459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-08-23 05:04:54.223839) ========= 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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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-23 05:04:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-08-23 05:04:54 (37.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119530 ========= master_lag: 3.90 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-08-23 05:04:58.240650) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:04:58.240931) ========= 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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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.021367 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:04:58.286383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 05:04:58.286795) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c01a9c030fd094e73d45bf88639fc320127b9a3e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev c01a9c030fd094e73d45bf88639fc320127b9a3e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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-23 05:04:58,372 truncating revision to first 12 chars 2016-08-23 05:04:58,372 Setting DEBUG logging. 2016-08-23 05:04:58,372 attempt 1/10 2016-08-23 05:04:58,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c01a9c030fd0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 05:04:59,868 unpacking tar archive at: autoland-c01a9c030fd0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.779307 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 05:05:00.089442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 05:05:00.089802) ========= script_repo_revision: c01a9c030fd094e73d45bf88639fc320127b9a3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 05:05:00.090225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 05:05:00.090490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 05:05:00.110456) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-23 05:05:00.110829) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:00 INFO - MultiFileLogger online at 20160823 05:05:00 in /builds/slave/test 05:05:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 05:05:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:00 INFO - {'append_to_log': False, 05:05:00 INFO - 'base_work_dir': '/builds/slave/test', 05:05:00 INFO - 'blob_upload_branch': 'Autoland', 05:05:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:00 INFO - 'branch': 'Autoland', 05:05:00 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:00 INFO - 'config_files': ('talos/mac_config.py',), 05:05:00 INFO - 'default_actions': ('clobber', 05:05:00 INFO - 'read-buildbot-config', 05:05:00 INFO - 'download-and-extract', 05:05:00 INFO - 'populate-webroot', 05:05:00 INFO - 'create-virtualenv', 05:05:00 INFO - 'install', 05:05:00 INFO - 'run-tests'), 05:05:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:00 INFO - 'download_minidump_stackwalk': True, 05:05:00 INFO - 'download_symbols': 'ondemand', 05:05:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:05:00 INFO - 'tooltool.py': '/tools/tooltool.py', 05:05:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:05:00 INFO - '/tools/misc-python/virtualenv.py')}, 05:05:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:00 INFO - 'installer_path': 'installer.exe', 05:05:00 INFO - 'log_level': 'info', 05:05:00 INFO - 'log_name': 'talos', 05:05:00 INFO - 'log_to_console': True, 05:05:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:05:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:05:00 INFO - 'opt_config_files': (), 05:05:00 INFO - 'pip_index': False, 05:05:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:05:00 INFO - 'cmd': ('bash', 05:05:00 INFO - '-c', 05:05:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:05:00 INFO - 'enabled': True, 05:05:00 INFO - 'halt_on_failure': False, 05:05:00 INFO - 'name': 'check_screen_resolution'},), 05:05:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:05:00 INFO - 'cmd': ('bash', 05:05:00 INFO - '-c', 05:05:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:05:00 INFO - 'enabled': True, 05:05:00 INFO - 'halt_on_failure': False, 05:05:00 INFO - 'name': 'check_screen_resolution'},), 05:05:00 INFO - 'run_cmd_checks_enabled': True, 05:05:00 INFO - 'sps_profile': False, 05:05:00 INFO - 'sps_profile_interval': 0, 05:05:00 INFO - 'suite': 'dromaeojs-e10s', 05:05:00 INFO - 'system_bits': '32', 05:05:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:00 INFO - 'title': 't-yosemite-r7-0232', 05:05:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:00 INFO - 'use_talos_json': True, 05:05:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:00 INFO - 'work_dir': 'build'} 05:05:00 INFO - [mozharness: 2016-08-23 12:05:00.306534Z] Running clobber step. 05:05:00 INFO - Running pre-action listener: _resource_record_pre_action 05:05:00 INFO - Running main action method: clobber 05:05:00 INFO - rmtree: /builds/slave/test/build 05:05:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:01 INFO - Running post-action listener: _resource_record_post_action 05:05:01 INFO - [mozharness: 2016-08-23 12:05:01.343824Z] Finished clobber step (success) 05:05:01 INFO - [mozharness: 2016-08-23 12:05:01.343955Z] Running read-buildbot-config step. 05:05:01 INFO - Running pre-action listener: _resource_record_pre_action 05:05:01 INFO - Running main action method: read_buildbot_config 05:05:01 INFO - Using buildbot properties: 05:05:01 INFO - { 05:05:01 INFO - "project": "", 05:05:01 INFO - "product": "firefox", 05:05:01 INFO - "script_repo_revision": "production", 05:05:01 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 05:05:01 INFO - "repository": "", 05:05:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 05:05:01 INFO - "buildid": "20160823033146", 05:05:01 INFO - "pgo_build": "False", 05:05:01 INFO - "basedir": "/builds/slave/test", 05:05:01 INFO - "buildnumber": 150, 05:05:01 INFO - "slavename": "t-yosemite-r7-0232", 05:05:01 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:05:01 INFO - "platform": "yosemite_r7", 05:05:01 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 05:05:01 INFO - "branch": "autoland", 05:05:01 INFO - "repo_path": "integration/autoland", 05:05:01 INFO - "revision": "c01a9c030fd094e73d45bf88639fc320127b9a3e", 05:05:01 INFO - "stage_platform": "macosx64", 05:05:01 INFO - "builduid": "5be4b92a78e64c48b5afda22a060b1f8", 05:05:01 INFO - "slavebuilddir": "test" 05:05:01 INFO - } 05:05:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:05:01 INFO - Running post-action listener: _resource_record_post_action 05:05:01 INFO - [mozharness: 2016-08-23 12:05:01.347226Z] Finished read-buildbot-config step (success) 05:05:01 INFO - [mozharness: 2016-08-23 12:05:01.347351Z] Running download-and-extract step. 05:05:01 INFO - Running pre-action listener: _resource_record_pre_action 05:05:01 INFO - Running main action method: download_and_extract 05:05:01 INFO - mkdir: /builds/slave/test/build/tests 05:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:01 INFO - trying https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:05:01 INFO - Downloading https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/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 05:05:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/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 05:05:02 INFO - Downloaded 1199 bytes. 05:05:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:05:02 INFO - Using the following test package requirements: 05:05:02 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:05:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:02 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:05:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:02 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:05:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:02 INFO - u'jsshell-mac.zip'], 05:05:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:02 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:05:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:05:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:02 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:05:02 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:02 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:05:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:02 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:05:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:02 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:05:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - trying https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:05:02 INFO - Downloading https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/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 05:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/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 05:05:03 INFO - Downloaded 16353654 bytes. 05:05:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:05:10 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 05:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:10 INFO - trying https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:05:10 INFO - Downloading https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/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 05:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/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 05:05:11 INFO - Downloaded 16353654 bytes. 05:05:11 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:05:17 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')]} 05:05:17 INFO - trying https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:05:17 INFO - Downloading https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/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 05:05:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/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 05:05:19 INFO - Downloaded 14413981 bytes. 05:05:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:05:19 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')]} 05:05:19 INFO - trying https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:05:19 INFO - Downloading https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/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 05:05:22 INFO - Downloaded 111537333 bytes. 05:05:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:05:22 INFO - mkdir: /builds/slave/test/properties 05:05:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:22 INFO - Contents: 05:05:22 INFO - build_url:https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:05:22 INFO - Running post-action listener: _resource_record_post_action 05:05:22 INFO - Running post-action listener: set_extra_try_arguments 05:05:22 INFO - [mozharness: 2016-08-23 12:05:22.972679Z] Finished download-and-extract step (success) 05:05:22 INFO - [mozharness: 2016-08-23 12:05:22.972803Z] Running populate-webroot step. 05:05:22 INFO - Running pre-action listener: _resource_record_pre_action 05:05:22 INFO - Running main action method: populate_webroot 05:05:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:05:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:05:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:05:22 INFO - '--tppagecycles', 05:05:22 INFO - '7'], 05:05:22 INFO - 'tests': ['tsvgm']}}, 05:05:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:05:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:05:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:05:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:05:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:22 INFO - 'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:22 INFO - 'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['damp', 'tps']}, 05:05:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:22 INFO - 'tests': ['damp', 'tps']}, 05:05:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['dromaeo_dom']}, 05:05:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['basic_compositor_video']}, 05:05:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:05:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['a11yr', 05:05:22 INFO - 'ts_paint', 05:05:22 INFO - 'tpaint', 05:05:22 INFO - 'sessionrestore', 05:05:22 INFO - 'sessionrestore_no_auto_restore', 05:05:22 INFO - 'tabpaint']}, 05:05:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:05:22 INFO - 'ts_paint', 05:05:22 INFO - 'tpaint', 05:05:22 INFO - 'sessionrestore', 05:05:22 INFO - 'sessionrestore_no_auto_restore', 05:05:22 INFO - 'tabpaint']}, 05:05:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:05:22 INFO - 'ts_paint', 05:05:22 INFO - 'tpaint', 05:05:22 INFO - 'sessionrestore', 05:05:22 INFO - 'sessionrestore_no_auto_restore', 05:05:22 INFO - 'tabpaint']}, 05:05:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:05:22 INFO - 'ts_paint', 05:05:22 INFO - 'tpaint', 05:05:22 INFO - 'sessionrestore', 05:05:22 INFO - 'sessionrestore_no_auto_restore', 05:05:22 INFO - 'tabpaint']}, 05:05:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['a11yr', 05:05:22 INFO - 'ts_paint', 05:05:22 INFO - 'tpaint', 05:05:22 INFO - 'sessionrestore', 05:05:22 INFO - 'sessionrestore_no_auto_restore', 05:05:22 INFO - 'tabpaint']}, 05:05:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['a11yr', 05:05:22 INFO - 'ts_paint', 05:05:22 INFO - 'tpaint', 05:05:22 INFO - 'sessionrestore', 05:05:22 INFO - 'sessionrestore_no_auto_restore', 05:05:22 INFO - 'tabpaint']}, 05:05:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['tsvgx', 05:05:22 INFO - 'tsvgr_opacity', 05:05:22 INFO - 'tart', 05:05:22 INFO - 'tscrollx', 05:05:22 INFO - 'cart']}, 05:05:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:05:22 INFO - 'tsvgr_opacity', 05:05:22 INFO - 'tart', 05:05:22 INFO - 'tscrollx', 05:05:22 INFO - 'cart']}, 05:05:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:22 INFO - 'talos_options': ['--disable-e10s'], 05:05:22 INFO - 'tests': ['tp5o']}, 05:05:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:22 INFO - 'tests': ['tp5o']}, 05:05:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:22 INFO - 'talos_options': ['--disable-e10s', 05:05:22 INFO - '--xperf_path', 05:05:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:22 INFO - 'tests': ['tp5n']}, 05:05:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:22 INFO - 'talos_options': ['--xperf_path', 05:05:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:22 INFO - 'tests': ['tp5n']}}, 05:05:22 INFO - 'talos.zip': {'path': '', 05:05:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:05:22 INFO - Running post-action listener: _resource_record_post_action 05:05:22 INFO - [mozharness: 2016-08-23 12:05:22.991733Z] Finished populate-webroot step (success) 05:05:22 INFO - [mozharness: 2016-08-23 12:05:22.991878Z] Running create-virtualenv step. 05:05:22 INFO - Running pre-action listener: _resource_record_pre_action 05:05:22 INFO - Running main action method: create_virtualenv 05:05:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:05:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:23 INFO - Using real prefix '/tools/python27' 05:05:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:26 INFO - Installing pip.................done. 05:05:26 INFO - Return code: 0 05:05:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e01618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb204cbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, '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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:05:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:05:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:26 INFO - 'HOME': '/Users/cltbld', 05:05:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:26 INFO - 'LOGNAME': 'cltbld', 05:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:26 INFO - 'MOZ_NO_REMOTE': '1', 05:05:26 INFO - 'NO_EM_RESTART': '1', 05:05:26 INFO - 'PAGER': '/bin/cat', 05:05:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:26 INFO - 'PWD': '/builds/slave/test', 05:05:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:26 INFO - 'SHELL': '/bin/bash', 05:05:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:05:26 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:05:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:26 INFO - 'USER': 'cltbld', 05:05:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:26 INFO - 'XPC_FLAGS': '0x0', 05:05:26 INFO - 'XPC_SERVICE_NAME': '0', 05:05:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:05:26 INFO - Cleaning up... 05:05:26 INFO - Return code: 0 05:05:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e01618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb204cbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, '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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:05:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:05:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:26 INFO - 'HOME': '/Users/cltbld', 05:05:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:26 INFO - 'LOGNAME': 'cltbld', 05:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:26 INFO - 'MOZ_NO_REMOTE': '1', 05:05:26 INFO - 'NO_EM_RESTART': '1', 05:05:26 INFO - 'PAGER': '/bin/cat', 05:05:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:26 INFO - 'PWD': '/builds/slave/test', 05:05:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:26 INFO - 'SHELL': '/bin/bash', 05:05:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:05:26 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:05:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:26 INFO - 'USER': 'cltbld', 05:05:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:26 INFO - 'XPC_FLAGS': '0x0', 05:05:26 INFO - 'XPC_SERVICE_NAME': '0', 05:05:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:27 INFO - Downloading/unpacking psutil>=3.1.1 05:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:30 INFO - Installing collected packages: psutil 05:05:30 INFO - Running setup.py install for psutil 05:05:30 INFO - building 'psutil._psutil_osx' extension 05:05:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:05:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:05:31 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 05:05:31 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 05:05:31 INFO - building 'psutil._psutil_posix' extension 05:05:31 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 05:05:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:05:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:05:31 INFO - ^ 05:05:31 INFO - 1 warning generated. 05:05:31 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 05:05:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:31 INFO - Successfully installed psutil 05:05:31 INFO - Cleaning up... 05:05:31 INFO - Return code: 0 05:05:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e01618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb204cbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, '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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:05:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:05:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:31 INFO - 'HOME': '/Users/cltbld', 05:05:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:31 INFO - 'LOGNAME': 'cltbld', 05:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:31 INFO - 'MOZ_NO_REMOTE': '1', 05:05:31 INFO - 'NO_EM_RESTART': '1', 05:05:31 INFO - 'PAGER': '/bin/cat', 05:05:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:31 INFO - 'PWD': '/builds/slave/test', 05:05:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:31 INFO - 'SHELL': '/bin/bash', 05:05:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:05:31 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:05:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:31 INFO - 'USER': 'cltbld', 05:05:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:31 INFO - 'XPC_FLAGS': '0x0', 05:05:31 INFO - 'XPC_SERVICE_NAME': '0', 05:05:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:05:34 INFO - Installing collected packages: mozsystemmonitor 05:05:34 INFO - Running setup.py install for mozsystemmonitor 05:05:34 INFO - Successfully installed mozsystemmonitor 05:05:34 INFO - Cleaning up... 05:05:34 INFO - Return code: 0 05:05:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e01618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb204cbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, '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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:34 INFO - 'HOME': '/Users/cltbld', 05:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:34 INFO - 'LOGNAME': 'cltbld', 05:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:34 INFO - 'MOZ_NO_REMOTE': '1', 05:05:34 INFO - 'NO_EM_RESTART': '1', 05:05:34 INFO - 'PAGER': '/bin/cat', 05:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:34 INFO - 'PWD': '/builds/slave/test', 05:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:34 INFO - 'SHELL': '/bin/bash', 05:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:05:34 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:34 INFO - 'USER': 'cltbld', 05:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:34 INFO - 'XPC_FLAGS': '0x0', 05:05:34 INFO - 'XPC_SERVICE_NAME': '0', 05:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:34 INFO - Downloading/unpacking jsonschema==2.5.1 05:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:05:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:05:37 INFO - warning: no files found matching '*.txt' 05:05:37 INFO - no previously-included directories found matching 'build' 05:05:37 INFO - no previously-included directories found matching 'dist' 05:05:37 INFO - no previously-included directories found matching '.git*' 05:05:37 INFO - Installing collected packages: jsonschema, functools32 05:05:37 INFO - Running setup.py install for functools32 05:05:37 INFO - warning: no files found matching '*.txt' 05:05:37 INFO - no previously-included directories found matching 'build' 05:05:37 INFO - no previously-included directories found matching 'dist' 05:05:37 INFO - no previously-included directories found matching '.git*' 05:05:37 INFO - Successfully installed jsonschema functools32 05:05:37 INFO - Cleaning up... 05:05:37 INFO - Return code: 0 05:05:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e01618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb204cbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, '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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:37 INFO - 'HOME': '/Users/cltbld', 05:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:37 INFO - 'LOGNAME': 'cltbld', 05:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:37 INFO - 'MOZ_NO_REMOTE': '1', 05:05:37 INFO - 'NO_EM_RESTART': '1', 05:05:37 INFO - 'PAGER': '/bin/cat', 05:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:37 INFO - 'PWD': '/builds/slave/test', 05:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:37 INFO - 'SHELL': '/bin/bash', 05:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:05:37 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:37 INFO - 'USER': 'cltbld', 05:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:37 INFO - 'XPC_FLAGS': '0x0', 05:05:37 INFO - 'XPC_SERVICE_NAME': '0', 05:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:05:38 INFO - Cleaning up... 05:05:38 INFO - Return code: 0 05:05:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:38 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 0x103d6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e01618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb204cbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, '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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:38 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 05:05:38 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 05:05:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:38 INFO - 'HOME': '/Users/cltbld', 05:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:38 INFO - 'LOGNAME': 'cltbld', 05:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:38 INFO - 'MOZ_NO_REMOTE': '1', 05:05:38 INFO - 'NO_EM_RESTART': '1', 05:05:38 INFO - 'PAGER': '/bin/cat', 05:05:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:38 INFO - 'PWD': '/builds/slave/test', 05:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:38 INFO - 'SHELL': '/bin/bash', 05:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:05:38 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:38 INFO - 'USER': 'cltbld', 05:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:38 INFO - 'XPC_FLAGS': '0x0', 05:05:38 INFO - 'XPC_SERVICE_NAME': '0', 05:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:42 INFO - Downloading docopt-0.6.1.tar.gz 05:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:42 INFO - Running setup.py install for blobuploader 05:05:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:42 INFO - Running setup.py install for requests 05:05:42 INFO - Running setup.py install for docopt 05:05:42 INFO - Successfully installed blobuploader requests docopt 05:05:42 INFO - Cleaning up... 05:05:43 INFO - Return code: 0 05:05:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:43 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')]} 05:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:43 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')]} 05:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:43 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 0x103d6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e01618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb204cbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, '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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:43 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 05:05:43 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 05:05:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:05:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:43 INFO - 'HOME': '/Users/cltbld', 05:05:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:43 INFO - 'LOGNAME': 'cltbld', 05:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:43 INFO - 'MOZ_NO_REMOTE': '1', 05:05:43 INFO - 'NO_EM_RESTART': '1', 05:05:43 INFO - 'PAGER': '/bin/cat', 05:05:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:43 INFO - 'PWD': '/builds/slave/test', 05:05:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:43 INFO - 'SHELL': '/bin/bash', 05:05:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:05:43 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:05:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:43 INFO - 'USER': 'cltbld', 05:05:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:43 INFO - 'XPC_FLAGS': '0x0', 05:05:43 INFO - 'XPC_SERVICE_NAME': '0', 05:05:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-3GVwS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-ENSAKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Dtx_uZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-zH1wyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-xyc3XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-NnBJsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-fiOaXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:44 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-6vrRYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:44 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-9Yxgzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:44 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-WSGxT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:44 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-j1PbXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:44 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-6hj4sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:44 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-AsOzji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:44 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-FZyCWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:44 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-LP8XGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:44 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-RKvtiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:44 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-GPDK3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:45 INFO - Running setup.py install for manifestparser 05:05:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Running setup.py install for mozcrash 05:05:45 INFO - Running setup.py install for mozdebug 05:05:45 INFO - Running setup.py install for mozdevice 05:05:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Running setup.py install for mozfile 05:05:45 INFO - Running setup.py install for mozhttpd 05:05:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:45 INFO - Running setup.py install for mozinfo 05:05:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Running setup.py install for mozInstall 05:05:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Running setup.py install for mozleak 05:05:46 INFO - Running setup.py install for mozlog 05:05:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Running setup.py install for moznetwork 05:05:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Running setup.py install for mozprocess 05:05:46 INFO - Running setup.py install for mozprofile 05:05:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Running setup.py install for mozrunner 05:05:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Running setup.py install for mozscreenshot 05:05:47 INFO - Running setup.py install for moztest 05:05:47 INFO - Running setup.py install for mozversion 05:05:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:47 INFO - Cleaning up... 05:05:47 INFO - Return code: 0 05:05:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e01618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb204cbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, '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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:05:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:05:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:47 INFO - 'HOME': '/Users/cltbld', 05:05:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:47 INFO - 'LOGNAME': 'cltbld', 05:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:47 INFO - 'MOZ_NO_REMOTE': '1', 05:05:47 INFO - 'NO_EM_RESTART': '1', 05:05:47 INFO - 'PAGER': '/bin/cat', 05:05:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:47 INFO - 'PWD': '/builds/slave/test', 05:05:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:47 INFO - 'SHELL': '/bin/bash', 05:05:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:05:47 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:05:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:47 INFO - 'USER': 'cltbld', 05:05:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:47 INFO - 'XPC_FLAGS': '0x0', 05:05:47 INFO - 'XPC_SERVICE_NAME': '0', 05:05:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:47 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-P_NcEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:48 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)) 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:48 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Dtyqfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:48 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)) 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:48 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-szwJa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:48 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)) 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:48 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-KON_6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:48 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)) 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:48 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-1ZWyi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:48 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-z6mGoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:48 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-thCZQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:48 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-KwkrLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:48 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-mcQXxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:48 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-YKCBgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:48 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-dxmrse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:49 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)) 05:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:49 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-8AEkVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:49 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)) 05:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:49 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-znTGrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:49 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)) 05:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:49 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-4ge4nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:49 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-VcM3Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:49 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-ZjpZm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:49 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-MxVpeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:52 INFO - Downloading blessings-1.6.tar.gz 05:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:52 INFO - Installing collected packages: blessings 05:05:52 INFO - Running setup.py install for blessings 05:05:52 INFO - Successfully installed blessings 05:05:52 INFO - Cleaning up... 05:05:52 INFO - Return code: 0 05:05:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:52 INFO - Reading from file tmpfile_stdout 05:05:52 INFO - Current package versions: 05:05:52 INFO - blessings == 1.6 05:05:52 INFO - blobuploader == 1.2.4 05:05:52 INFO - docopt == 0.6.1 05:05:52 INFO - functools32 == 3.2.3-2 05:05:52 INFO - jsonschema == 2.5.1 05:05:52 INFO - manifestparser == 1.1 05:05:52 INFO - mozInstall == 1.12 05:05:52 INFO - mozcrash == 0.17 05:05:52 INFO - mozdebug == 0.1 05:05:52 INFO - mozdevice == 0.48 05:05:52 INFO - mozfile == 1.2 05:05:52 INFO - mozhttpd == 0.7 05:05:52 INFO - mozinfo == 0.9 05:05:52 INFO - mozleak == 0.1 05:05:52 INFO - mozlog == 3.3 05:05:52 INFO - moznetwork == 0.27 05:05:52 INFO - mozprocess == 0.23 05:05:52 INFO - mozprofile == 0.28 05:05:52 INFO - mozrunner == 6.12 05:05:52 INFO - mozscreenshot == 0.1 05:05:52 INFO - mozsystemmonitor == 0.3 05:05:52 INFO - moztest == 0.7 05:05:52 INFO - mozversion == 1.4 05:05:52 INFO - psutil == 3.1.1 05:05:52 INFO - requests == 1.2.3 05:05:52 INFO - wsgiref == 0.1.2 05:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e01618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb204cbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, '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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:05:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:05:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:52 INFO - 'HOME': '/Users/cltbld', 05:05:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:52 INFO - 'LOGNAME': 'cltbld', 05:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:52 INFO - 'MOZ_NO_REMOTE': '1', 05:05:52 INFO - 'NO_EM_RESTART': '1', 05:05:52 INFO - 'PAGER': '/bin/cat', 05:05:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:52 INFO - 'PWD': '/builds/slave/test', 05:05:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:52 INFO - 'SHELL': '/bin/bash', 05:05:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:05:52 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:05:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:52 INFO - 'USER': 'cltbld', 05:05:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:52 INFO - 'XPC_FLAGS': '0x0', 05:05:52 INFO - 'XPC_SERVICE_NAME': '0', 05:05:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:53 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)) 05:05:53 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)) 05:05:53 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)) 05:05:53 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)) 05:05:53 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)) 05:05:53 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)) 05:05:53 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)) 05:05:53 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)) 05:05:53 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)) 05:05:53 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)) 05:05:53 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)) 05:05:53 INFO - Cleaning up... 05:05:53 INFO - Return code: 0 05:05:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:53 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')]} 05:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:53 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')]} 05:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:53 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 0x103d6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e01618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb204cbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, '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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 05:05:53 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 05:05:53 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 05:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:53 INFO - 'HOME': '/Users/cltbld', 05:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:53 INFO - 'LOGNAME': 'cltbld', 05:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:53 INFO - 'MOZ_NO_REMOTE': '1', 05:05:53 INFO - 'NO_EM_RESTART': '1', 05:05:53 INFO - 'PAGER': '/bin/cat', 05:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:53 INFO - 'PWD': '/builds/slave/test', 05:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:53 INFO - 'SHELL': '/bin/bash', 05:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:05:53 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:53 INFO - 'USER': 'cltbld', 05:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:53 INFO - 'XPC_FLAGS': '0x0', 05:05:53 INFO - 'XPC_SERVICE_NAME': '0', 05:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:53 INFO - Cleaning up... 05:05:53 INFO - Return code: 0 05:05:53 INFO - Running post-action listener: _resource_record_post_action 05:05:53 INFO - Running post-action listener: _start_resource_monitoring 05:05:53 INFO - Starting resource monitoring. 05:05:53 INFO - [mozharness: 2016-08-23 12:05:53.346769Z] Finished create-virtualenv step (success) 05:05:53 INFO - [mozharness: 2016-08-23 12:05:53.347809Z] Running install step. 05:05:53 INFO - Running pre-action listener: _resource_record_pre_action 05:05:53 INFO - Running main action method: install 05:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:53 INFO - Reading from file tmpfile_stdout 05:05:53 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:53 INFO - Reading from file tmpfile_stdout 05:05:53 INFO - Output received: 05:05:53 INFO - Usage: mozinstall [options] installer 05:05:53 INFO - Options: 05:05:53 INFO - -h, --help show this help message and exit 05:05:53 INFO - -d DEST, --destination=DEST 05:05:53 INFO - Directory to install application into. [default: 05:05:53 INFO - "/builds/slave/test"] 05:05:53 INFO - --app=APP Application being installed. [default: firefox] 05:05:53 INFO - mkdir: /builds/slave/test/build/application 05:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:06:27 INFO - Reading from file tmpfile_stdout 05:06:27 INFO - Output received: 05:06:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:06:27 INFO - Running post-action listener: _resource_record_post_action 05:06:27 INFO - [mozharness: 2016-08-23 12:06:27.943547Z] Finished install step (success) 05:06:27 INFO - [mozharness: 2016-08-23 12:06:27.943742Z] Running run-tests step. 05:06:27 INFO - Running pre-action listener: _resource_record_pre_action 05:06:27 INFO - Running main action method: run_tests 05:06:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:06:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:06:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:06:27 INFO - 2016-08-23 05:06:27.958 screenresolution[2296:24852] starting screenresolution argv=screenresolution get 05:06:27 INFO - 2016-08-23 05:06:27.961 screenresolution[2296:24852] Display 0: 1600x1200x32@60 05:06:27 INFO - 2016-08-23 05:06:27.966 screenresolution[2297:24854] starting screenresolution argv=screenresolution list 05:06:27 INFO - Available Modes on Display 0 05:06:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:06:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:06:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:06:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:06:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:06:28 INFO - Intel Iris: 05:06:28 INFO - Chipset Model: Intel Iris 05:06:28 INFO - Type: GPU 05:06:28 INFO - Bus: Built-In 05:06:28 INFO - VRAM (Dynamic, Max): 1536 MB 05:06:28 INFO - Vendor: Intel (0x8086) 05:06:28 INFO - Device ID: 0x0a2e 05:06:28 INFO - Revision ID: 0x0009 05:06:28 INFO - Displays: 05:06:28 INFO - Display: 05:06:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:06:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:06:28 INFO - Display Serial Number: 1600x1200 60 05:06:28 INFO - Main Display: Yes 05:06:28 INFO - Mirror: Off 05:06:28 INFO - Online: Yes 05:06:28 INFO - Rotation: Supported 05:06:28 INFO - Return code: 0 05:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:28 INFO - Python 2.7.3 05:06:28 INFO - Return code: 0 05:06:28 INFO - grabbing minidump binary from tooltool 05:06:28 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')]} 05:06:28 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 0x103cd0d30>, '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 0x103a35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cc8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:28 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 05:06:28 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 05:06:28 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 05:06:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:28 INFO - Return code: 0 05:06:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:06:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:06:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0232', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0232 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:06:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NK6Z5ZltT7/Render', 05:06:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:28 INFO - 'HOME': '/Users/cltbld', 05:06:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:28 INFO - 'LOGNAME': 'cltbld', 05:06:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:28 INFO - 'MOZ_NO_REMOTE': '1', 05:06:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:28 INFO - 'NO_EM_RESTART': '1', 05:06:28 INFO - 'PAGER': '/bin/cat', 05:06:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:28 INFO - 'PWD': '/builds/slave/test', 05:06:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:28 INFO - 'SHELL': '/bin/bash', 05:06:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J5TN31oc1Q/Listeners', 05:06:28 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 05:06:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:28 INFO - 'USER': 'cltbld', 05:06:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:28 INFO - 'XPC_FLAGS': '0x0', 05:06:28 INFO - 'XPC_SERVICE_NAME': '0', 05:06:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0232', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:06:28 INFO - mozversion application_buildid: 20160823033146 05:06:28 INFO - mozversion application_changeset: c01a9c030fd094e73d45bf88639fc320127b9a3e 05:06:28 INFO - mozversion application_display_name: Nightly 05:06:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:28 INFO - mozversion application_name: Firefox 05:06:28 INFO - mozversion application_remotingname: firefox 05:06:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 05:06:28 INFO - mozversion application_vendor: Mozilla 05:06:28 INFO - mozversion application_version: 51.0a1 05:06:28 INFO - mozversion platform_buildid: 20160823033146 05:06:28 INFO - mozversion platform_changeset: c01a9c030fd094e73d45bf88639fc320127b9a3e 05:06:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 05:06:28 INFO - mozversion platform_version: 51.0a1 05:06:28 INFO - using testdate: 1471953988 05:06:28 INFO - actual date: 1471953988 05:06:28 INFO - starting webserver on 'localhost:55554' 05:06:28 INFO - SUITE-START | Running 2 tests 05:06:28 INFO - TEST-START | dromaeo_css 05:06:28 INFO - operating with platform_type : mac_ 05:06:28 INFO - Initialising browser for dromaeo_css test... 05:06:28 INFO - TEST-INFO | started process 2307 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpBg8Y5l/profile http://localhost:55554/getInfo.html) 05:06:31 INFO - PROCESS | 2307 | __metrics Screen width/height:1600/1200 05:06:31 INFO - PROCESS | 2307 | colorDepth:24 05:06:31 INFO - PROCESS | 2307 | Browser inner width/height: 1024/689 05:06:31 INFO - PROCESS | 2307 | __metrics 05:06:31 ERROR - PROCESS | 2307 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 05:06:32 INFO - TEST-INFO | 2307: exit 0 05:06:32 INFO - Browser initialized. 05:06:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:32 INFO - TEST-INFO | started process 2310 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpBg8Y5l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:44 INFO - PROCESS | 2310 | RSS: Main: 239620096 05:06:44 INFO - PROCESS | 2310 | 05:07:33 INFO - PROCESS | 2310 | 1471954053821 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] 05:09:45 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:55554/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55554/tests/dromaeo/cssquery-ext.html) 05:09:47 INFO - PROCESS | 2310 | RSS: Main: 255627264 05:09:47 INFO - PROCESS | 2310 | 05:12:49 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:55554/tests/dromaeo/cssquery-ext.html (next: http://localhost:55554/tests/dromaeo/cssquery-jquery.html) 05:12:50 INFO - PROCESS | 2310 | RSS: Main: 267550720 05:12:50 INFO - PROCESS | 2310 | 05:15:52 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:55554/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55554/tests/dromaeo/cssquery-mootools.html) 05:15:53 INFO - PROCESS | 2310 | RSS: Main: 272257024 05:15:53 INFO - PROCESS | 2310 | 05:18:54 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:55554/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55554/tests/dromaeo/cssquery-prototype.html) 05:18:55 INFO - PROCESS | 2310 | RSS: Main: 271876096 05:18:55 INFO - PROCESS | 2310 | 05:21:58 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:55554/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55554/tests/dromaeo/cssquery-yui.html) 05:21:59 INFO - PROCESS | 2310 | RSS: Main: 277250048 05:21:59 INFO - PROCESS | 2310 | 05:25:01 INFO - PROCESS | 2310 | Cycle 1(1): loaded http://localhost:55554/tests/dromaeo/cssquery-yui.html (next: http://localhost:55554/tests/dromaeo/cssquery-dojo.html) 05:25:02 INFO - PROCESS | 2310 | RSS: Main: 280944640 05:25:02 INFO - PROCESS | 2310 | 05:25:02 INFO - PROCESS | 2310 | __start_tp_report 05:25:02 INFO - PROCESS | 2310 | _x_x_mozilla_page_load 05:25:02 INFO - PROCESS | 2310 | _x_x_mozilla_page_load_details 05:25:02 INFO - PROCESS | 2310 | |i|pagename|runs| 05:25:02 INFO - PROCESS | 2310 | |0;dojo.html;3185.1400121967067;3300.1584595928034;3311.039798458447;3321.2527181384185;3343;5568.693721845297;5609.831705048845;5630.352509461413;5636.943630563698;5756.280464941882;4613.331066995283;5586.441355864412;5599.664020158793;5616.438356164372;5627.7467513961865;5055.266986286986;5149;5157.200633901752;5228.215767634847;5228.424873263938;5156.278121063054;5232;5244.082285600024;5255.816046438375;5272.103742363788;5018.899622007576;5066.569341605968;5116.2069879168785;5159.1229490986625;5171.276021357013;5122.5133612307145;5124.205748109049;5141.614378921596;5158.793648254065;5171.482851714836;5092.821751238689;5102.336696229467;5103.923441148386;5151.995360904625;5161.7161056141895;5463.426340234298;5505.972470137664;5573.247611572427;5577.2191893135;5617.129344951539;6174.845628859314;6189.504839612865;6215.12988181655;6239.625622462621;6244.718987645567;6215.067739839015;6292.276388215322;6297.4962003039645;6308.400701933309;6331.176946996907;5572.749226284867;5679.261695979496;5696.401877802854;5699.230603868425;5766.192733017339;6288.6855657217875;6312.684365781693;6313.40022697843;6320.462760665303;6344.270408902943;6111.755529778759;6120.816375508742;6135.969320153371;6146.6004709693725;6155.630662160284;6042.6978651067275;6144.600600960924;6152.16945712332;6154.3845615438095;6154.79981403622;6187.628742275478;6199.3490683477585;6200.038993955944;6217.658028808369;6223.471004964629;5117.565006974449;6206.472449841724;6223.8797016537455;6231.065340199007;6278.089676996901;3664.1755604988666;4055.8174882130374;4089.754614723126;4444.28891377378;4555.088982203572;3896.8246428910766;4299.699021068558;4370.7159034662645;4374.693771436033;4410.6030457259;4561.726296422159;5712.086066229466;5729.541636669056;5732.16883551891;5743.8564035899435;4953.281774142729;6153.5692501525355;6155.630662160195;6189.566730328834;6235.688215589203;4779.928301075487;5688.772449102073;5717.571182161271;5717.971410142923;5763.567732420085;5372.113601255827;5378.220158077057;5403.405625381205;5410.404855465896;5411.269478620336;6224.097505861715;6242.75028998844;6253.96873015632;6284.3087260402235;6305.306416294204;4623.329617205553;6289.182406287154;6289.96855015722;6296.370362963667;6311.431971122621;6269.49844012487;6277.591956522811;6284.402981716729;6314.936850631435;6321.1782468278825;5966.373530779206;5982.162497250475;5988.311344195473;5990.7903223386975;6190.164327815687;6068.8786224276155;6164.137020817179;6188.81433556994;6240.53196010292;6246.437820596168;5966.284045914518;5967.254093238345;6032.487238584769;6042.244719410074;6073.696315184135;5872.794452194153;5888.676122813286;6010.278766548042;6024.969875150597;6037.969810150921;5817.76728930838;5884.205632239764;5904.055351143968;5958.463738263577;5969.462748352669;6048.697565121638;6079.118527813531;6124.54065945047;6126.908096378469;6174.567780255339;5747.252857128547;5788.102844059177;5792.391798861059;5846.41535846412;5935.643861368331 05:25:02 INFO - PROCESS | 2310 | |1;ext.html;489.24167540312516;514.8301060649986;518.3805352603638;526.6524094097894;538.6848693514294;38694;39907.2018559629;41168.38247426291;41198.58801411989;41242;41894.581054189446;42539.57460425395;42591.99999999992;42605.78697106518;42697;8811.603477843513;9617.182539484134;10865.51105200264;11929.58246461374;12259.20315179515;9523.57143928525;9676.903230967671;10282.868884422707;11237.988581027706;12211.26732396059;9953.502324883762;10015.59937602495;12017.158798884082;12158.270503769758;12176.147669663127;9694.563744631438;12043.217190882564;12053.578124765634;12070.336131512764;12124.454399551953;12022.879771202264;12065.517379304818;12118.515259389615;12137.93931030348;12183.32991685457;40484;40819.7959010206;40874.591254087674;40921.97695057618;41082.58917410817;3377.983110084434;3458.1528573424507;3459.9827000865084;3482.703970162539;3868.613138686137;30749.231269218224;30802.845985769927;31883.681163188303;31943.680563194303;32089.03732888017;3245.8377081146086;3383.204946837491;3399.2181798186307;3445.707114895237;3448.70685991691;322807;341525;359187;362427;364167;48947.75526122418;56955.14567281494;58217.12674309889;58765;58805;60951;60958.695206523684;61605.69197154075;61688.363629091065;61736.53053877885;14881.70236595262;15934.203289835461;16184.676306473804;16541.421050263183;16576.502704918872;12701.682457938625;12857.614271571867;12870.613881583567;12913.741725165632;12920.741585168433;16192.838071619368;16239.188040597923;16255.59361015984;16279.348826046826;16298.42955496552;5115.514026167508;6220.253569571681;6303;6313.579444624923;6325.462335701425;873.6287077991955;908.4776253654176;966.4346357380871;1024.8462730590322;1154.7805916875766;28157.43685126286;30445.847770761004;30577.388452231276;31061.378772424425;31280.21799455032;1014.7412409835445;1045.984310235347;1046.2257929132388;1047.9004494573003;1161.924474909128;12801.807972880415;15303;15453.381864725285;16006;16041.598960026093;557777;595289.0235548795;607436;609580;858334;59243;59726.70136649289;59817.700911495165;60019.699901500215;60093.69953150206;1181.7650555169869;1337.3647517429142;1398.161103337989;1398.7622104242303;1402.621292251107;27796.86101569479;27980.160595182177;28453.865960053492;28467;28703.995360162295;51799.48200517947;52060.21909671434;52131.95736085181;52175.47824521706;52194.21708674297;571548;579507;581022;582707;582898;25921.481570368866;26356.604650930636;27159;27263.182104536896;27927.581086283317;48597;48876.75561622169;48898.26652600285;49582.752086240784;49950.75024624999;40106;40535.391969121076;40711.18577628372;40760;42177.78911105425;40010.79994600009;40208.59791402166;40743.38884916788;41554.168916620896;41636;37804.81097594494;38137.80931095327;38746.80626596849;39144.6085539141;39161.41257881191;34460.82769586136;34878.476822848184;35436.82281588575;35760.28479430345;35767.821160894026;22093;23881.641775373035;24051.55690658566;25631.743682562937;26505.80723867392 05:25:02 INFO - PROCESS | 2310 | |2;jquery.html;371.38906498809445;372.5529364762285;378.92610940866535;381.7041792610728;398.5456579499371;16923.984560926354;17345.566360840952;18097.728534072;20875.895620521896;21206.681899771498;19875.900620496912;20331.28840490583;20616.587668246626;20697.896510517465;20950.371488855322;6016.947034269007;6101.932161871677;6134.774789058298;6134.9079763803575;6149.077638354238;4207.368894665809;5983.611065280765;6142.723577439004;6149.16986206863;6154.476869466078;5959.970200148993;6708.631025293607;6729.562578432411;6850;6866.622335771555;5684.801031963882;5806.303243610751;6723.125993620823;6801.625910574917;6820.556663816861;5696.743646535874;5866.941330586725;5871.911921321183;5873.383294754075;5892.941070589325;20289.5942081159;23959.640605390934;25088.49823003548;26291.73708262912;26540;2303.6199027160665;2387.2838148555365;2527.2544599343237;2997.085888803914;3033.2226742880052;8932.285417166611;10244.436555989418;10245.385276883411;10416;10472.371657700562;1859.3492277702696;1900.819422154907;1926.5087402712359;1948.162290215207;1956.9412917612494;118073;121225.54485048106;127236;132491;133167;11288.0969522438;11356.26184298018;11525.711857203469;11559;11700.824487632692;14129.505467308594;14365.353559089866;14385.6403589909;14391.568252952427;14414.85585144135;6959.826004349932;8510.063892971892;8627.525486098324;8657.917760279965;8757.868631970525;8656.826863462695;8677.349198810114;8677.826443471222;8706.47761134334;8835.558222089;4442.756028312077;4491.8427855025575;4512.706674066175;4528.094381123722;4572.268437050123;1496.2593516209547;1862.7299041638887;1908.9140988655545;1928.4889504281377;1934.9032548372525;803.7227156630953;907.9409838360485;915.391264808908;930.1117432851611;947.3984020147257;18889.622207556047;21781.599516558686;21784.89107554452;22814.42963925915;23565.528689426115;883.2845395229884;913.977150571241;925.9398139120935;960.846264597661;969.9806003879883;10549.9472502637;11238.887611123948;11333.433328333715;11508.712282192844;11520.135989800798;558601;605004.9749751223;613133;621627.8918605378;625186;138183;139956;144191;144606;146008;983.4345251480428;1003.7239759066315;1014.9847752283722;1034.2915103154364;1035.1615191694752;15397.153156576496;18987.43037708871;19246.23015079381;19313.4205973821;19338.709919351502;54646.726766365915;57742.71128644498;57873;58038;58307;72675.63662181655;83957;85678.57160714157;85770;86214;7875.960620196863;8349.290310323691;8370.497770133812;8499.362547808816;8596.269317107866;11100.888991109985;13235.801462978256;13426.932865336;13564.321783910962;13800.447982080605;9586.90413095888;11491.827622585835;11567.595134170264;11815.527378904748;11961.043116550481;11397.202195846212;11498.54005839757;11517.07863370945;11693.707657308636;11859.525618975144;11682.415879205835;11721.589744358907;11833.34916579562;11904.523819047141;11971.341576213044;7886.487378320391;8186.2632363087605;8198.836023279382;8371.288440482384;8468.068512463748;9251;11624.94187529057;11685.532578696757;11734.119941004288;11746.412679366169 05:25:02 INFO - PROCESS | 2310 | |3;mootools.html;1438.6331485471203;1503.6466430388853;1719.6818588561116;1856.4894653970148;1880.8777429467093;8035.236652518001;8519.829603407929;8690.565471726404;9051.954740226289;9053.818923621524;8677.305815534757;8853.601587928542;8865.601047952841;8887;8893.199612034916;2323.361075704182;2368.6328619064075;2376.0139542090096;2379.5121999990047;2383.1420688552107;2343.2618725101624;2361.9645705314433;2398.8080953523677;2398.9040438382444;2403.9182367934413;2355.846869953456;2365.9645105323434;2372.5136347048815;2379.095943541452;2380.4881950380664;2106.3049193766096;2346.765323467657;2359.1507057459385;2364.5861974154627;2371.8339716219784;2344.3787396339985;2355.2580937004786;2361.1853910400882;2362.444825466014;2367.2898130560934;8845.115488451167;8984.640614375417;8988.056254093291;8998.820023599557;9031.096890310982;5303.549198318147;5367.46325367464;5447.945520544784;5451.781928722847;5479.205515200313;3581.910452238689;3688.612695666943;3709.2581483703366;3720.8325625346924;3741.681957033655;936.5036530638772;1098.203802243375;1101.432762127505;1102.0247081333077;1128.8137457319533;11447.771044579062;11553.017993470565;11579.53681852725;11610.767784644344;11610.941945290304;4717.787699553528;4723.601552593623;4792.736399497991;4870.366852309177;4880.438749543777;10035.09684128432;10147.238957078249;10148.137408320228;10159.390436573829;10169.288149829441;5439.075357189287;5446.591505637093;5456.263404440429;5458.4541545845095;5464.207689884945;4443.933340999887;4795.400574928134;4908.288298196741;4929.950700492949;4950.3069570260195;3909.980450097788;3968.8809335719975;4025.8590949316635;4074.6536544394057;4102.425660407545;1187.804012337972;1190.9344986025678;1285.3830161522521;1290.4386591832583;1301.7136230029378;760.7979392559743;831.6091437024588;850.8598478039333;860.9268212202034;944.2068662323682;5250.711210883438;5770.16332631766;6027.336992930774;6104.145419641254;6177.567570270128;450.0795872440801;457.9015511665008;974.9658761943298;1049.1344640671477;1102.6802227354137;3804.6385593368586;4001.4397984282223;4034.717569770147;4039.414284928669;4075;10634.042936135631;10802.405867677353;10872.967068128515;10877.945610271898;10881.183911206692;9844.114029737215;10838.67483975482;10858.67423977282;10869.021788039114;11142.997130258154;6284.717187726564;6936.618485983218;8277.296429803535;8309;8321.292690121407;4982.451930287593;5744.281964754406;5792.768289268382;5868.38381969887;5939.871424429344;8611.526366049928;8978.371513993958;9594.848618165865;9710.22318214527;10171.033751793568;8999.910000899907;9053.460911644905;9370.953145234504;10037.548310325907;10389.013043760831;6975.860482790417;7572.924270757222;7707.344875685405;7877.7636670899965;8173.223543763333;8255.628496717782;8442.95778521128;8458.661653534036;8468;8479;7338.486305958531;7394.926050739424;7560.130584982798;7570.470067095471;7656.157822639617;5498.697571633438;7371.48399612022;7422;7489.887651685338;7513.924860751323;6999.12510936133;7035.507514474142;7100.112485939258;7133.964330178316;7134.821629459305;4987.977464619817;5036.496350365081;5062.392512898476;5066.695998240118;5093.159628661229;4970.992549507496;4984.6261530384645;5115.2582875483595;5247.16045432729;5252.632315737862 05:25:02 INFO - PROCESS | 2310 | |4;prototype.html;303.5734792616374;310.15482809344525;311.85342888842246;315.8878598097674;316.09123769163654;4630.953690463094;5092.439831618523;5407.810281738021;5634.605577609569;5644.943550564493;5228.764705588248;5552.666839989603;5568.415316391771;5639.8590035249035;5645.633033852797;3332.6500717424747;4128.938065928998;4188.769617671027;4188.853390131346;4219.2700992593045;3862.80685965702;3964.6035396460265;3971.3518889660754;4230.43473914652;4232.217039847638;3831.616838316174;3942.9156981830083;4231.132617813341;4250.2137104635585;4312.05134870328;3666.7460545054155;4045.644709022481;4128.174365126956;4208.158368326347;4261.76560289184;3042.4371491273964;3055.9541606875914;3643.344198044351;3655.141041855162;3655.670989610921;5404.189371594253;5432.320959880015;5448.128299472065;5450.863728406822;5455.263539422167;4077.9601201693376;4295.6778241632;4616.8153273869;4911.4106307243;4941.135301322254;5778.5377169826315;5861.765529378819;5863.648181109147;5890.322612899528;5918.319393269786;3287.4411350070545;3673.834677439495;3751.8499260029566;3881.3789793633164;4035.455213546192;5406;5709;6152.846178845564;6207.565470417073;6215.098810672427;3200.8719651214155;3332.3668502984356;3397.4224381855142;3834.079820842978;4000.239954408653;3235.498497732855;4022.456968309299;4028.9798551007057;4057.6753859691153;4084.4077608746566;3987.840486380512;4045.130296986162;4363.432753742057;4794.544518270759;4799.808007679723;4941.332920055746;5326.721586819213;5469.890602187934;5845.561582881301;5889.882202355929;1247.6257122863105;1349.9932500337436;1373.5535950816025;1376.7384197002536;1378.4968486502555;752.8870669399524;792.5918152151646;825.7357645553366;831.8918540589806;843.8270154618289;4484.573965473275;5524.917126243109;5562;5567.359753628303;5575.860603484945;5374.838754837361;6102.511799056154;6121.387861213932;6130.724117414727;6144.723487443076;4693.647976401783;5254.054270231319;5283.867903302448;5463.289772329572;5556.277553958286;2841.4601225767037;3180.7137357637926;3194.329190869897;3195.201199700075;3195.504696772004;6066.514678825772;6292.276388215322;6305.96847015762;6326.652034138075;6349.55553111287;5210.374755029421;5866.568057686216;5954.732037058343;6207.441330280297;6229.065640153923;5728.48443640066;5811.27359080115;5873.119032145127;6335.366463353628;6380.234371875405;5820.243368362086;6016.939830601813;6060.454559089703;6089.847753806191;6127.632342059491;5800.651960882361;5981.641101533922;5998.580099393001;6031.517478601789;6085.604435711664;5859.648421094748;6237.658903335805;6335.4931605472375;6376;6394.200724909387;3956.742811717229;3960.1881614269582;3960.980195099006;3968.960310396859;3972.5630180679523;5374.694562843901;5501.889962200814;5515.669059856422;6034.2155519782145;6092.025275955826;4963.627727920348;5007.795011192912;5382.569394448356;5880.764769409347;5910.202122713378;5846.473817356458;5864.237649105589;5868.471837534642;5878.676672783038;5908.970455147697;5019.52314530119;5118.948810511847;5143.6399452037995;5358.33020872391;5538.806141785019;4614.054118905549;5014.724190169576;5135.6405051646025;5833.533317334518;5891.204687367151;4892.559669629751;5043.940772437829;5766.481016708516;5794.420557944172;5836.124581312837 05:25:02 INFO - PROCESS | 2310 | |5;yui.html;716.7144145840972;770.5415277909643;778.9805254868628;793.2424534569486;822.4612878564541;15491.147986860718;16118.516444506655;16182.838171618281;16216.945898516587;16218.75671864923;14738.926305368484;14817.259137043131;14842.703145937076;14872.925635371836;14889.702205955875;676.8646270745846;832.5587438657521;836.0427310729211;871.333429926107;876.6011464783509;867.0202670981813;868.5917618719192;869.256785448442;872.310874409216;873.52829472085;905.4160066756938;924.3160061554469;925.1257561604286;925.676013395313;928.3037721708719;893.8793262909554;919.595378033663;920.3281604428771;920.7329874336434;927.1516562345412;679.5888487465111;682.8463595690979;685.7291369908858;686.8282929267683;687.4637782529635;14992.250387480692;15019.474318398912;15026.474073407488;15050.473233436776;15095.018823776529;14719.558413247512;14748.262586870613;14820.851791482162;14875.47935822241;14892.776608350776;12063.577774777841;12191.695207619792;12387.75224495514;12412.62762117138;12541.184822986477;3811.904702382435;3825.5218097737784;3981.6615587675083;4038.2125485530332;4041.070553772649;122207.3889630555;124828;126309.26371258454;126760.73239267581;128400.35799821034;11362.886371136183;11522.596709115141;11555.306681599131;11582.015528680156;11914.821277680841;19110.71333929992;19154.425367239004;23812;23857.761422385553;23896.88051559731;7123.358897699129;7984.201579842085;8134.227248411392;8212.63043163059;8252.174782521699;3647.76289541179;3826.253880493277;4082.7754473503646;4330.935035974463;4450.599446049871;3578.6779189873037;3731.645493678096;3768.7361884668358;3770.5098337215986;3775.7356985011334;615.6398506873439;662.3211208511218;673.1249375811426;679.864027194563;689.152342618582;569.8546870548066;574.3481148896033;578.6441338576745;585.7569108819878;607.8449995251183;8305.543195124204;9445.338826282094;9704.320697551244;9756.414615123116;10034.147097496794;520.8515573061659;647.6405594894784;671.1677519875417;676.8781619308571;713.9535930164523;4394.758288294174;4706.835260765925;4720.553766838729;4777.689450185727;4800.423949126127;98645;109388.90611093787;143026;152486.23756881146;162731;98988;133169;136355.40979016895;136596;137488;119033.809661904;119076;119191;122010;122542;9118;9203.953980230055;9225.861612075958;9269.768255793659;9331.72004839856;63295;63769;64201;64607;66393;76112;83361;86132.56933715292;90122;100773.48066298402;11794.351310677996;11910.821337679768;12147.08469967184;12173.39133043362;12341.259524428562;11379.146564007899;13543.729125417634;13722.862771372158;13723.451061957809;13845.100068495516;12489.375531223584;13152;13283.86716132865;13375.53185638498;13385.19688818674;12090.214136081127;12599.811002834782;12799.040071994452;12965.740685186054;12979.026573007251;11909.138200103971;12272.079594030662;12299.508019679113;12323.445444955178;12702.237865728086;10510.867286323244;10725.141988641046;10758.354498730101;10834.458277086273;11123.94438027837;9090.318226133199;9533.379325514818;10006.599736010769;10814.729631759268;10843.67468975932 05:25:02 INFO - PROCESS | 2310 | __end_tp_report 05:25:02 INFO - PROCESS | 2310 | __start_cc_report 05:25:02 INFO - PROCESS | 2310 | _x_x_mozilla_cycle_collect,418 05:25:02 INFO - PROCESS | 2310 | __end_cc_report 05:25:02 INFO - PROCESS | 2310 | __startTimestamp1471955102184__endTimestamp 05:25:02 INFO - PROCESS | 2310 | 05:25:02 INFO - PROCESS | 2310 | ------- Summary: start ------- 05:25:02 INFO - PROCESS | 2310 | Number of tests: 6 05:25:02 INFO - PROCESS | 2310 | 05:25:02 INFO - PROCESS | 2310 | [#0] dojo.html Cycles:165 Average:5635.71 Median:5846.42 stddev:713.42 (12.2%) stddev-sans-first:689.22 05:25:02 INFO - PROCESS | 2310 | Values: 3185.1 3300.2 3311.0 3321.3 3343.0 5568.7 5609.8 5630.4 5636.9 5756.3 4613.3 5586.4 5599.7 5616.4 5627.7 5055.3 5149.0 5157.2 5228.2 5228.4 5156.3 5232.0 5244.1 5255.8 5272.1 5018.9 5066.6 5116.2 5159.1 5171.3 5122.5 5124.2 5141.6 5158.8 5171.5 5092.8 5102.3 5103.9 5152.0 5161.7 5463.4 5506.0 5573.2 5577.2 5617.1 6174.8 6189.5 6215.1 6239.6 6244.7 6215.1 6292.3 6297.5 6308.4 6331.2 5572.7 5679.3 5696.4 5699.2 5766.2 6288.7 6312.7 6313.4 6320.5 6344.3 6111.8 6120.8 6136.0 6146.6 6155.6 6042.7 6144.6 6152.2 6154.4 6154.8 6187.6 6199.3 6200.0 6217.7 6223.5 5117.6 6206.5 6223.9 6231.1 6278.1 3664.2 4055.8 4089.8 4444.3 4555.1 3896.8 4299.7 4370.7 4374.7 4410.6 4561.7 5712.1 5729.5 5732.2 5743.9 4953.3 6153.6 6155.6 6189.6 6235.7 4779.9 5688.8 5717.6 5718.0 5763.6 5372.1 5378.2 5403.4 5410.4 5411.3 6224.1 6242.8 6254.0 6284.3 6305.3 4623.3 6289.2 6290.0 6296.4 6311.4 6269.5 6277.6 6284.4 6314.9 6321.2 5966.4 5982.2 5988.3 5990.8 6190.2 6068.9 6164.1 6188.8 6240.5 6246.4 5966.3 5967.3 6032.5 6042.2 6073.7 5872.8 5888.7 6010.3 6025.0 6038.0 5817.8 5884.2 5904.1 5958.5 5969.5 6048.7 6079.1 6124.5 6126.9 6174.6 5747.3 5788.1 5792.4 5846.4 5935.6 05:25:02 INFO - PROCESS | 2310 | 05:25:02 INFO - PROCESS | 2310 | [#1] ext.html Cycles:180 Average:66892.01 Median:35764.05 stddev:145569.31 (407.0%) stddev-sans-first:145892.29 05:25:02 INFO - PROCESS | 2310 | Values: 489.2 514.8 518.4 526.7 538.7 38694.0 39907.2 41168.4 41198.6 41242.0 41894.6 42539.6 42592.0 42605.8 42697.0 8811.6 9617.2 10865.5 11929.6 12259.2 9523.6 9676.9 10282.9 11238.0 12211.3 9953.5 10015.6 12017.2 12158.3 12176.1 9694.6 12043.2 12053.6 12070.3 12124.5 12022.9 12065.5 12118.5 12137.9 12183.3 40484.0 40819.8 40874.6 40922.0 41082.6 3378.0 3458.2 3460.0 3482.7 3868.6 30749.2 30802.8 31883.7 31943.7 32089.0 3245.8 3383.2 3399.2 3445.7 3448.7 322807.0 341525.0 359187.0 362427.0 364167.0 48947.8 56955.1 58217.1 58765.0 58805.0 60951.0 60958.7 61605.7 61688.4 61736.5 14881.7 15934.2 16184.7 16541.4 16576.5 12701.7 12857.6 12870.6 12913.7 12920.7 16192.8 16239.2 16255.6 16279.3 16298.4 5115.5 6220.3 6303.0 6313.6 6325.5 873.6 908.5 966.4 1024.8 1154.8 28157.4 30445.8 30577.4 31061.4 31280.2 1014.7 1046.0 1046.2 1047.9 1161.9 12801.8 15303.0 15453.4 16006.0 16041.6 557777.0 595289.0 607436.0 609580.0 858334.0 59243.0 59726.7 59817.7 60019.7 60093.7 1181.8 1337.4 1398.2 1398.8 1402.6 27796.9 27980.2 28453.9 28467.0 28704.0 51799.5 52060.2 52132.0 52175.5 52194.2 571548.0 579507.0 581022.0 582707.0 582898.0 25921.5 26356.6 27159.0 27263.2 27927.6 48597.0 48876.8 48898.3 49582.8 49950.8 40106.0 40535.4 40711.2 40760.0 42177.8 40010.8 40208.6 40743.4 41554.2 41636.0 37804.8 38137.8 38746.8 39144.6 39161.4 34460.8 34878.5 35436.8 35760.3 35767.8 22093.0 23881.6 24051.6 25631.7 26505.8 05:25:02 INFO - PROCESS | 2310 | 05:25:02 INFO - PROCESS | 2310 | [#2] jquery.html Cycles:180 Average:36177.24 Median:13807.88 stddev:101615.13 (735.9%) stddev-sans-first:101864.62 05:25:02 INFO - PROCESS | 2310 | Values: 371.4 372.6 378.9 381.7 398.5 16924.0 17345.6 18097.7 20875.9 21206.7 19875.9 20331.3 20616.6 20697.9 20950.4 6016.9 6101.9 6134.8 6134.9 6149.1 4207.4 5983.6 6142.7 6149.2 6154.5 5960.0 6708.6 6729.6 6850.0 6866.6 5684.8 5806.3 6723.1 6801.6 6820.6 5696.7 5866.9 5871.9 5873.4 5892.9 20289.6 23959.6 25088.5 26291.7 26540.0 2303.6 2387.3 2527.3 2997.1 3033.2 8932.3 10244.4 10245.4 10416.0 10472.4 1859.3 1900.8 1926.5 1948.2 1956.9 118073.0 121225.5 127236.0 132491.0 133167.0 11288.1 11356.3 11525.7 11559.0 11700.8 14129.5 14365.4 14385.6 14391.6 14414.9 6959.8 8510.1 8627.5 8657.9 8757.9 8656.8 8677.3 8677.8 8706.5 8835.6 4442.8 4491.8 4512.7 4528.1 4572.3 1496.3 1862.7 1908.9 1928.5 1934.9 803.7 907.9 915.4 930.1 947.4 18889.6 21781.6 21784.9 22814.4 23565.5 883.3 914.0 925.9 960.8 970.0 10549.9 11238.9 11333.4 11508.7 11520.1 558601.0 605005.0 613133.0 621627.9 625186.0 138183.0 139956.0 144191.0 144606.0 146008.0 983.4 1003.7 1015.0 1034.3 1035.2 15397.2 18987.4 19246.2 19313.4 19338.7 54646.7 57742.7 57873.0 58038.0 58307.0 72675.6 83957.0 85678.6 85770.0 86214.0 7876.0 8349.3 8370.5 8499.4 8596.3 11100.9 13235.8 13426.9 13564.3 13800.4 9586.9 11491.8 11567.6 11815.5 11961.0 11397.2 11498.5 11517.1 11693.7 11859.5 11682.4 11721.6 11833.3 11904.5 11971.3 7886.5 8186.3 8198.8 8371.3 8468.1 9251.0 11624.9 11685.5 11734.1 11746.4 05:25:02 INFO - PROCESS | 2310 | 05:25:02 INFO - PROCESS | 2310 | [#3] mootools.html Cycles:180 Average:5703.63 Median:4976.72 stddev:3176.95 (63.8%) stddev-sans-first:3169.69 05:25:02 INFO - PROCESS | 2310 | Values: 1438.6 1503.6 1719.7 1856.5 1880.9 8035.2 8519.8 8690.6 9052.0 9053.8 8677.3 8853.6 8865.6 8887.0 8893.2 2323.4 2368.6 2376.0 2379.5 2383.1 2343.3 2362.0 2398.8 2398.9 2403.9 2355.8 2366.0 2372.5 2379.1 2380.5 2106.3 2346.8 2359.2 2364.6 2371.8 2344.4 2355.3 2361.2 2362.4 2367.3 8845.1 8984.6 8988.1 8998.8 9031.1 5303.5 5367.5 5447.9 5451.8 5479.2 3581.9 3688.6 3709.3 3720.8 3741.7 936.5 1098.2 1101.4 1102.0 1128.8 11447.8 11553.0 11579.5 11610.8 11610.9 4717.8 4723.6 4792.7 4870.4 4880.4 10035.1 10147.2 10148.1 10159.4 10169.3 5439.1 5446.6 5456.3 5458.5 5464.2 4443.9 4795.4 4908.3 4930.0 4950.3 3910.0 3968.9 4025.9 4074.7 4102.4 1187.8 1190.9 1285.4 1290.4 1301.7 760.8 831.6 850.9 860.9 944.2 5250.7 5770.2 6027.3 6104.1 6177.6 450.1 457.9 975.0 1049.1 1102.7 3804.6 4001.4 4034.7 4039.4 4075.0 10634.0 10802.4 10873.0 10877.9 10881.2 9844.1 10838.7 10858.7 10869.0 11143.0 6284.7 6936.6 8277.3 8309.0 8321.3 4982.5 5744.3 5792.8 5868.4 5939.9 8611.5 8978.4 9594.8 9710.2 10171.0 8999.9 9053.5 9371.0 10037.5 10389.0 6975.9 7572.9 7707.3 7877.8 8173.2 8255.6 8443.0 8458.7 8468.0 8479.0 7338.5 7394.9 7560.1 7570.5 7656.2 5498.7 7371.5 7422.0 7489.9 7513.9 6999.1 7035.5 7100.1 7134.0 7134.8 4988.0 5036.5 5062.4 5066.7 5093.2 4971.0 4984.6 5115.3 5247.2 5252.6 05:25:02 INFO - PROCESS | 2310 | 05:25:02 INFO - PROCESS | 2310 | [#4] prototype.html Cycles:180 Average:4691.14 Median:5366.51 stddev:1500.29 (28.0%) stddev-sans-first:1467.91 05:25:02 INFO - PROCESS | 2310 | Values: 303.6 310.2 311.9 315.9 316.1 4631.0 5092.4 5407.8 5634.6 5644.9 5228.8 5552.7 5568.4 5639.9 5645.6 3332.7 4128.9 4188.8 4188.9 4219.3 3862.8 3964.6 3971.4 4230.4 4232.2 3831.6 3942.9 4231.1 4250.2 4312.1 3666.7 4045.6 4128.2 4208.2 4261.8 3042.4 3056.0 3643.3 3655.1 3655.7 5404.2 5432.3 5448.1 5450.9 5455.3 4078.0 4295.7 4616.8 4911.4 4941.1 5778.5 5861.8 5863.6 5890.3 5918.3 3287.4 3673.8 3751.8 3881.4 4035.5 5406.0 5709.0 6152.8 6207.6 6215.1 3200.9 3332.4 3397.4 3834.1 4000.2 3235.5 4022.5 4029.0 4057.7 4084.4 3987.8 4045.1 4363.4 4794.5 4799.8 4941.3 5326.7 5469.9 5845.6 5889.9 1247.6 1350.0 1373.6 1376.7 1378.5 752.9 792.6 825.7 831.9 843.8 4484.6 5524.9 5562.0 5567.4 5575.9 5374.8 6102.5 6121.4 6130.7 6144.7 4693.6 5254.1 5283.9 5463.3 5556.3 2841.5 3180.7 3194.3 3195.2 3195.5 6066.5 6292.3 6306.0 6326.7 6349.6 5210.4 5866.6 5954.7 6207.4 6229.1 5728.5 5811.3 5873.1 6335.4 6380.2 5820.2 6016.9 6060.5 6089.8 6127.6 5800.7 5981.6 5998.6 6031.5 6085.6 5859.6 6237.7 6335.5 6376.0 6394.2 3956.7 3960.2 3961.0 3969.0 3972.6 5374.7 5501.9 5515.7 6034.2 6092.0 4963.6 5007.8 5382.6 5880.8 5910.2 5846.5 5864.2 5868.5 5878.7 5909.0 5019.5 5118.9 5143.6 5358.3 5538.8 4614.1 5014.7 5135.6 5833.5 5891.2 4892.6 5043.9 5766.5 5794.4 5836.1 05:25:02 INFO - PROCESS | 2310 | 05:25:02 INFO - PROCESS | 2310 | [#5] yui.html Cycles:180 Average:25011.19 Median:3750.19 stddev:40170.01 (1071.1%) stddev-sans-first:40241.28 05:25:02 INFO - PROCESS | 2310 | Values: 716.7 770.5 779.0 793.2 822.5 15491.1 16118.5 16182.8 16216.9 16218.8 14738.9 14817.3 14842.7 14872.9 14889.7 676.9 832.6 836.0 871.3 876.6 867.0 868.6 869.3 872.3 873.5 905.4 924.3 925.1 925.7 928.3 893.9 919.6 920.3 920.7 927.2 679.6 682.8 685.7 686.8 687.5 14992.3 15019.5 15026.5 15050.5 15095.0 14719.6 14748.3 14820.9 14875.5 14892.8 12063.6 12191.7 12387.8 12412.6 12541.2 3811.9 3825.5 3981.7 4038.2 4041.1 122207.4 124828.0 126309.3 126760.7 128400.4 11362.9 11522.6 11555.3 11582.0 11914.8 19110.7 19154.4 23812.0 23857.8 23896.9 7123.4 7984.2 8134.2 8212.6 8252.2 3647.8 3826.3 4082.8 4330.9 4450.6 3578.7 3731.6 3768.7 3770.5 3775.7 615.6 662.3 673.1 679.9 689.2 569.9 574.3 578.6 585.8 607.8 8305.5 9445.3 9704.3 9756.4 10034.1 520.9 647.6 671.2 676.9 714.0 4394.8 4706.8 4720.6 4777.7 4800.4 98645.0 109388.9 143026.0 152486.2 162731.0 98988.0 133169.0 136355.4 136596.0 137488.0 119033.8 119076.0 119191.0 122010.0 122542.0 9118.0 9204.0 9225.9 9269.8 9331.7 63295.0 63769.0 64201.0 64607.0 66393.0 76112.0 83361.0 86132.6 90122.0 100773.5 11794.4 11910.8 12147.1 12173.4 12341.3 11379.1 13543.7 13722.9 13723.5 13845.1 12489.4 13152.0 13283.9 13375.5 13385.2 12090.2 12599.8 12799.0 12965.7 12979.0 11909.1 12272.1 12299.5 12323.4 12702.2 10510.9 10725.1 10758.4 10834.5 11123.9 9090.3 9533.4 10006.6 10814.7 10843.7 05:25:02 INFO - PROCESS | 2310 | -------- Summary: end -------- 05:25:02 INFO - PROCESS | 2310 | 05:25:02 INFO - TEST-INFO | 2310: exit 0 05:25:02 INFO - TEST-OK | dromaeo_css | took 1114237ms 05:25:02 INFO - TEST-START | kraken 05:25:02 INFO - operating with platform_type : mac_ 05:25:02 INFO - Initialising browser for kraken test... 05:25:02 INFO - TEST-INFO | started process 2316 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpqmWJB3/profile http://localhost:55554/getInfo.html) 05:25:05 INFO - PROCESS | 2316 | __metrics Screen width/height:1600/1200 05:25:05 INFO - PROCESS | 2316 | colorDepth:24 05:25:05 INFO - PROCESS | 2316 | Browser inner width/height: 1024/689 05:25:05 INFO - PROCESS | 2316 | __metrics 05:25:05 ERROR - PROCESS | 2316 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 05:25:06 INFO - TEST-INFO | 2316: exit 0 05:25:06 INFO - Browser initialized. 05:25:06 INFO - Running cycle 1/1 for kraken test... 05:25:06 INFO - TEST-INFO | started process 2318 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpqmWJB3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:18 INFO - PROCESS | 2318 | RSS: Main: 239742976 05:25:18 INFO - PROCESS | 2318 | 05:25:21 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55554/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:22 INFO - PROCESS | 2318 | RSS: Main: 252534784 05:25:22 INFO - PROCESS | 2318 | 05:25:24 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55554/tests/kraken/driver.html?testName=audio-dft) 05:25:25 INFO - PROCESS | 2318 | RSS: Main: 261156864 05:25:25 INFO - PROCESS | 2318 | 05:25:28 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55554/tests/kraken/driver.html?testName=audio-fft) 05:25:29 INFO - PROCESS | 2318 | RSS: Main: 264085504 05:25:29 INFO - PROCESS | 2318 | 05:25:31 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55554/tests/kraken/driver.html?testName=audio-oscillator) 05:25:31 INFO - PROCESS | 2318 | RSS: Main: 265482240 05:25:31 INFO - PROCESS | 2318 | 05:25:34 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55554/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:25:34 INFO - PROCESS | 2318 | RSS: Main: 267042816 05:25:34 INFO - PROCESS | 2318 | 05:25:37 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55554/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:38 INFO - PROCESS | 2318 | RSS: Main: 267124736 05:25:38 INFO - PROCESS | 2318 | 05:25:41 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55554/tests/kraken/driver.html?testName=imaging-desaturate) 05:25:41 INFO - PROCESS | 2318 | RSS: Main: 267304960 05:25:41 INFO - PROCESS | 2318 | 05:25:44 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55554/tests/kraken/driver.html?testName=json-parse-financial) 05:25:45 INFO - PROCESS | 2318 | RSS: Main: 267419648 05:25:45 INFO - PROCESS | 2318 | 05:25:47 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55554/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:25:47 INFO - PROCESS | 2318 | RSS: Main: 267395072 05:25:47 INFO - PROCESS | 2318 | 05:25:49 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55554/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:25:50 INFO - PROCESS | 2318 | RSS: Main: 267743232 05:25:50 INFO - PROCESS | 2318 | 05:25:52 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55554/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:25:53 INFO - PROCESS | 2318 | RSS: Main: 268001280 05:25:53 INFO - PROCESS | 2318 | 05:25:56 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:56 INFO - PROCESS | 2318 | RSS: Main: 267980800 05:25:56 INFO - PROCESS | 2318 | 05:25:59 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:00 INFO - PROCESS | 2318 | RSS: Main: 267952128 05:26:00 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:55554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55554/tests/kraken/driver.html?testName=ai-astar) 05:26:02 INFO - PROCESS | 2318 | RSS: Main: 269926400 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | __start_tp_report 05:26:02 INFO - PROCESS | 2318 | _x_x_mozilla_page_load 05:26:02 INFO - PROCESS | 2318 | _x_x_mozilla_page_load_details 05:26:02 INFO - PROCESS | 2318 | |i|pagename|runs| 05:26:02 INFO - PROCESS | 2318 | |0;ai-astar;106;119;111;120;117;117;120;119;118;119 05:26:02 INFO - PROCESS | 2318 | |1;audio-beat-detection;145;110;140;193;118;128;130;109;158;109 05:26:02 INFO - PROCESS | 2318 | |2;audio-dft;196;200;213;259;250;201;196;197;196;193 05:26:02 INFO - PROCESS | 2318 | |3;audio-fft;66;83;76;143;58;59;59;54;157;84 05:26:02 INFO - PROCESS | 2318 | |4;audio-oscillator;70;74;129;86;107;113;107;89;58;128 05:26:02 INFO - PROCESS | 2318 | |5;imaging-gaussian-blur;88;78;131;88;104;86;117;89;89;85 05:26:02 INFO - PROCESS | 2318 | |6;imaging-darkroom;95;151;97;103;94;95;95;123;129;152 05:26:02 INFO - PROCESS | 2318 | |7;imaging-desaturate;140;149;92;91;90;93;90;135;92;118 05:26:02 INFO - PROCESS | 2318 | |8;json-parse-financial;56;58;60;58;59;59;58;58;56;57 05:26:02 INFO - PROCESS | 2318 | |9;json-stringify-tinderbox;68;69;68;76;73;74;74;69;71;71 05:26:02 INFO - PROCESS | 2318 | |10;stanford-crypto-aes;86;87;86;89;89;90;92;86;91;88 05:26:02 INFO - PROCESS | 2318 | |11;stanford-crypto-ccm;140;136;138;137;134;140;137;187;227;147 05:26:02 INFO - PROCESS | 2318 | |12;stanford-crypto-pbkdf2;177;177;179;205;257;201;175;173;176;172 05:26:02 INFO - PROCESS | 2318 | |13;stanford-crypto-sha256-iterative;69;69;68;70;90;90;92;72;66;72 05:26:02 INFO - PROCESS | 2318 | __end_tp_report 05:26:02 INFO - PROCESS | 2318 | __start_cc_report 05:26:02 INFO - PROCESS | 2318 | _x_x_mozilla_cycle_collect,1065 05:26:02 INFO - PROCESS | 2318 | __end_cc_report 05:26:02 INFO - PROCESS | 2318 | __startTimestamp1471955162537__endTimestamp 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | ------- Summary: start ------- 05:26:02 INFO - PROCESS | 2318 | Number of tests: 14 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#0] ai-astar Cycles:10 Average:116.60 Median:119.00 stddev:4.55 (3.8%) stddev-sans-first:2.77 05:26:02 INFO - PROCESS | 2318 | Values: 106.0 119.0 111.0 120.0 117.0 117.0 120.0 119.0 118.0 119.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:135.00 stddev:26.56 (19.7%) stddev-sans-first:27.87 05:26:02 INFO - PROCESS | 2318 | Values: 145.0 110.0 140.0 193.0 118.0 128.0 130.0 109.0 158.0 109.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#2] audio-dft Cycles:10 Average:210.10 Median:200.50 stddev:24.12 (12.0%) stddev-sans-first:25.04 05:26:02 INFO - PROCESS | 2318 | Values: 196.0 200.0 213.0 259.0 250.0 201.0 196.0 197.0 196.0 193.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#3] audio-fft Cycles:10 Average:83.90 Median:62.50 stddev:36.55 (58.5%) stddev-sans-first:38.19 05:26:02 INFO - PROCESS | 2318 | Values: 66.0 83.0 76.0 143.0 58.0 59.0 59.0 54.0 157.0 84.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:64.00 stddev:24.49 (38.3%) stddev-sans-first:24.08 05:26:02 INFO - PROCESS | 2318 | Values: 70.0 74.0 129.0 86.0 107.0 113.0 107.0 89.0 58.0 128.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:87.00 stddev:16.66 (19.2%) stddev-sans-first:17.45 05:26:02 INFO - PROCESS | 2318 | Values: 88.0 78.0 131.0 88.0 104.0 86.0 117.0 89.0 89.0 85.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:94.50 stddev:23.59 (25.0%) stddev-sans-first:24.06 05:26:02 INFO - PROCESS | 2318 | Values: 95.0 151.0 97.0 103.0 94.0 95.0 95.0 123.0 129.0 152.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#7] imaging-desaturate Cycles:10 Average:109.00 Median:90.50 stddev:24.03 (26.6%) stddev-sans-first:22.72 05:26:02 INFO - PROCESS | 2318 | Values: 140.0 149.0 92.0 91.0 90.0 93.0 90.0 135.0 92.0 118.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:1.29 (2.2%) stddev-sans-first:1.17 05:26:02 INFO - PROCESS | 2318 | Values: 56.0 58.0 60.0 58.0 59.0 59.0 58.0 58.0 56.0 57.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.00 stddev:2.83 (3.9%) stddev-sans-first:2.74 05:26:02 INFO - PROCESS | 2318 | Values: 68.0 69.0 68.0 76.0 73.0 74.0 74.0 69.0 71.0 71.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:89.00 stddev:2.17 (2.4%) stddev-sans-first:2.12 05:26:02 INFO - PROCESS | 2318 | Values: 86.0 87.0 86.0 89.0 89.0 90.0 92.0 86.0 91.0 88.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#11] stanford-crypto-ccm Cycles:10 Average:152.30 Median:140.00 stddev:30.53 (21.8%) stddev-sans-first:32.05 05:26:02 INFO - PROCESS | 2318 | Values: 140.0 136.0 138.0 137.0 134.0 140.0 137.0 187.0 227.0 147.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.20 Median:178.00 stddev:26.50 (14.9%) stddev-sans-first:27.74 05:26:02 INFO - PROCESS | 2318 | Values: 177.0 177.0 179.0 205.0 257.0 201.0 175.0 173.0 176.0 172.0 05:26:02 INFO - PROCESS | 2318 | 05:26:02 INFO - PROCESS | 2318 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:72.00 stddev:10.42 (14.5%) stddev-sans-first:10.76 05:26:02 INFO - PROCESS | 2318 | Values: 69.0 69.0 68.0 70.0 90.0 90.0 92.0 72.0 66.0 72.0 05:26:02 INFO - PROCESS | 2318 | -------- Summary: end -------- 05:26:02 INFO - PROCESS | 2318 | 05:26:03 INFO - TEST-INFO | 2318: exit 0 05:26:03 INFO - TEST-OK | kraken | took 60568ms 05:26:03 INFO - SUITE-END | took 1174s 05:26:03 INFO - Completed test suite (00:19:35) 05:26:03 INFO - javascript benchmark 05:26:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7413.173773121608, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.1400121967067, 3300.1584595928034, 3311.039798458447, 3321.2527181384185, 3343.0, 5568.693721845297, 5609.831705048845, 5630.352509461413, 5636.943630563698, 5756.280464941882, 4613.331066995283, 5586.441355864412, 5599.664020158793, 5616.438356164372, 5627.7467513961865, 5055.266986286986, 5149.0, 5157.200633901752, 5228.215767634847, 5228.424873263938, 5156.278121063054, 5232.0, 5244.082285600024, 5255.816046438375, 5272.103742363788, 5018.899622007576, 5066.569341605968, 5116.2069879168785, 5159.1229490986625, 5171.276021357013, 5122.5133612307145, 5124.205748109049, 5141.614378921596, 5158.793648254065, 5171.482851714836, 5092.821751238689, 5102.336696229467, 5103.923441148386, 5151.995360904625, 5161.7161056141895, 5463.426340234298, 5505.972470137664, 5573.247611572427, 5577.2191893135, 5617.129344951539, 6174.845628859314, 6189.504839612865, 6215.12988181655, 6239.625622462621, 6244.718987645567, 6215.067739839015, 6292.276388215322, 6297.4962003039645, 6308.400701933309, 6331.176946996907, 5572.749226284867, 5679.261695979496, 5696.401877802854, 5699.230603868425, 5766.192733017339, 6288.6855657217875, 6312.684365781693, 6313.40022697843, 6320.462760665303, 6344.270408902943, 6111.755529778759, 6120.816375508742, 6135.969320153371, 6146.6004709693725, 6155.630662160284, 6042.6978651067275, 6144.600600960924, 6152.16945712332, 6154.3845615438095, 6154.79981403622, 6187.628742275478, 6199.3490683477585, 6200.038993955944, 6217.658028808369, 6223.471004964629, 5117.565006974449, 6206.472449841724, 6223.8797016537455, 6231.065340199007, 6278.089676996901, 3664.1755604988666, 4055.8174882130374, 4089.754614723126, 4444.28891377378, 4555.088982203572, 3896.8246428910766, 4299.699021068558, 4370.7159034662645, 4374.693771436033, 4410.6030457259, 4561.726296422159, 5712.086066229466, 5729.541636669056, 5732.16883551891, 5743.8564035899435, 4953.281774142729, 6153.5692501525355, 6155.630662160195, 6189.566730328834, 6235.688215589203, 4779.928301075487, 5688.772449102073, 5717.571182161271, 5717.971410142923, 5763.567732420085, 5372.113601255827, 5378.220158077057, 5403.405625381205, 5410.404855465896, 5411.269478620336, 6224.097505861715, 6242.75028998844, 6253.96873015632, 6284.3087260402235, 6305.306416294204, 4623.329617205553, 6289.182406287154, 6289.96855015722, 6296.370362963667, 6311.431971122621, 6269.49844012487, 6277.591956522811, 6284.402981716729, 6314.936850631435, 6321.1782468278825, 5966.373530779206, 5982.162497250475, 5988.311344195473, 5990.7903223386975, 6190.164327815687, 6068.8786224276155, 6164.137020817179, 6188.81433556994, 6240.53196010292, 6246.437820596168, 5966.284045914518, 5967.254093238345, 6032.487238584769, 6042.244719410074, 6073.696315184135, 5872.794452194153, 5888.676122813286, 6010.278766548042, 6024.969875150597, 6037.969810150921, 5817.76728930838, 5884.205632239764, 5904.055351143968, 5958.463738263577, 5969.462748352669, 6048.697565121638, 6079.118527813531, 6124.54065945047, 6126.908096378469, 6174.567780255339, 5747.252857128547, 5788.102844059177, 5792.391798861059, 5846.41535846412, 5935.643861368331], "value": 5587.549780194518, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.24167540312516, 514.8301060649986, 518.3805352603638, 526.6524094097894, 538.6848693514294, 38694.0, 39907.2018559629, 41168.38247426291, 41198.58801411989, 41242.0, 41894.581054189446, 42539.57460425395, 42591.99999999992, 42605.78697106518, 42697.0, 8811.603477843513, 9617.182539484134, 10865.51105200264, 11929.58246461374, 12259.20315179515, 9523.57143928525, 9676.903230967671, 10282.868884422707, 11237.988581027706, 12211.26732396059, 9953.502324883762, 10015.59937602495, 12017.158798884082, 12158.270503769758, 12176.147669663127, 9694.563744631438, 12043.217190882564, 12053.578124765634, 12070.336131512764, 12124.454399551953, 12022.879771202264, 12065.517379304818, 12118.515259389615, 12137.93931030348, 12183.32991685457, 40484.0, 40819.7959010206, 40874.591254087674, 40921.97695057618, 41082.58917410817, 3377.983110084434, 3458.1528573424507, 3459.9827000865084, 3482.703970162539, 3868.613138686137, 30749.231269218224, 30802.845985769927, 31883.681163188303, 31943.680563194303, 32089.03732888017, 3245.8377081146086, 3383.204946837491, 3399.2181798186307, 3445.707114895237, 3448.70685991691, 322807.0, 341525.0, 359187.0, 362427.0, 364167.0, 48947.75526122418, 56955.14567281494, 58217.12674309889, 58765.0, 58805.0, 60951.0, 60958.695206523684, 61605.69197154075, 61688.363629091065, 61736.53053877885, 14881.70236595262, 15934.203289835461, 16184.676306473804, 16541.421050263183, 16576.502704918872, 12701.682457938625, 12857.614271571867, 12870.613881583567, 12913.741725165632, 12920.741585168433, 16192.838071619368, 16239.188040597923, 16255.59361015984, 16279.348826046826, 16298.42955496552, 5115.514026167508, 6220.253569571681, 6303.0, 6313.579444624923, 6325.462335701425, 873.6287077991955, 908.4776253654176, 966.4346357380871, 1024.8462730590322, 1154.7805916875766, 28157.43685126286, 30445.847770761004, 30577.388452231276, 31061.378772424425, 31280.21799455032, 1014.7412409835445, 1045.984310235347, 1046.2257929132388, 1047.9004494573003, 1161.924474909128, 12801.807972880415, 15303.0, 15453.381864725285, 16006.0, 16041.598960026093, 557777.0, 595289.0235548795, 607436.0, 609580.0, 858334.0, 59243.0, 59726.70136649289, 59817.700911495165, 60019.699901500215, 60093.69953150206, 1181.7650555169869, 1337.3647517429142, 1398.161103337989, 1398.7622104242303, 1402.621292251107, 27796.86101569479, 27980.160595182177, 28453.865960053492, 28467.0, 28703.995360162295, 51799.48200517947, 52060.21909671434, 52131.95736085181, 52175.47824521706, 52194.21708674297, 571548.0, 579507.0, 581022.0, 582707.0, 582898.0, 25921.481570368866, 26356.604650930636, 27159.0, 27263.182104536896, 27927.581086283317, 48597.0, 48876.75561622169, 48898.26652600285, 49582.752086240784, 49950.75024624999, 40106.0, 40535.391969121076, 40711.18577628372, 40760.0, 42177.78911105425, 40010.79994600009, 40208.59791402166, 40743.38884916788, 41554.168916620896, 41636.0, 37804.81097594494, 38137.80931095327, 38746.80626596849, 39144.6085539141, 39161.41257881191, 34460.82769586136, 34878.476822848184, 35436.82281588575, 35760.28479430345, 35767.821160894026, 22093.0, 23881.641775373035, 24051.55690658566, 25631.743682562937, 26505.80723867392], "value": 20175.75105070681, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.38906498809445, 372.5529364762285, 378.92610940866535, 381.7041792610728, 398.5456579499371, 16923.984560926354, 17345.566360840952, 18097.728534072, 20875.895620521896, 21206.681899771498, 19875.900620496912, 20331.28840490583, 20616.587668246626, 20697.896510517465, 20950.371488855322, 6016.947034269007, 6101.932161871677, 6134.774789058298, 6134.9079763803575, 6149.077638354238, 4207.368894665809, 5983.611065280765, 6142.723577439004, 6149.16986206863, 6154.476869466078, 5959.970200148993, 6708.631025293607, 6729.562578432411, 6850.0, 6866.622335771555, 5684.801031963882, 5806.303243610751, 6723.125993620823, 6801.625910574917, 6820.556663816861, 5696.743646535874, 5866.941330586725, 5871.911921321183, 5873.383294754075, 5892.941070589325, 20289.5942081159, 23959.640605390934, 25088.49823003548, 26291.73708262912, 26540.0, 2303.6199027160665, 2387.2838148555365, 2527.2544599343237, 2997.085888803914, 3033.2226742880052, 8932.285417166611, 10244.436555989418, 10245.385276883411, 10416.0, 10472.371657700562, 1859.3492277702696, 1900.819422154907, 1926.5087402712359, 1948.162290215207, 1956.9412917612494, 118073.0, 121225.54485048106, 127236.0, 132491.0, 133167.0, 11288.0969522438, 11356.26184298018, 11525.711857203469, 11559.0, 11700.824487632692, 14129.505467308594, 14365.353559089866, 14385.6403589909, 14391.568252952427, 14414.85585144135, 6959.826004349932, 8510.063892971892, 8627.525486098324, 8657.917760279965, 8757.868631970525, 8656.826863462695, 8677.349198810114, 8677.826443471222, 8706.47761134334, 8835.558222089, 4442.756028312077, 4491.8427855025575, 4512.706674066175, 4528.094381123722, 4572.268437050123, 1496.2593516209547, 1862.7299041638887, 1908.9140988655545, 1928.4889504281377, 1934.9032548372525, 803.7227156630953, 907.9409838360485, 915.391264808908, 930.1117432851611, 947.3984020147257, 18889.622207556047, 21781.599516558686, 21784.89107554452, 22814.42963925915, 23565.528689426115, 883.2845395229884, 913.977150571241, 925.9398139120935, 960.846264597661, 969.9806003879883, 10549.9472502637, 11238.887611123948, 11333.433328333715, 11508.712282192844, 11520.135989800798, 558601.0, 605004.9749751223, 613133.0, 621627.8918605378, 625186.0, 138183.0, 139956.0, 144191.0, 144606.0, 146008.0, 983.4345251480428, 1003.7239759066315, 1014.9847752283722, 1034.2915103154364, 1035.1615191694752, 15397.153156576496, 18987.43037708871, 19246.23015079381, 19313.4205973821, 19338.709919351502, 54646.726766365915, 57742.71128644498, 57873.0, 58038.0, 58307.0, 72675.63662181655, 83957.0, 85678.57160714157, 85770.0, 86214.0, 7875.960620196863, 8349.290310323691, 8370.497770133812, 8499.362547808816, 8596.269317107866, 11100.888991109985, 13235.801462978256, 13426.932865336, 13564.321783910962, 13800.447982080605, 9586.90413095888, 11491.827622585835, 11567.595134170264, 11815.527378904748, 11961.043116550481, 11397.202195846212, 11498.54005839757, 11517.07863370945, 11693.707657308636, 11859.525618975144, 11682.415879205835, 11721.589744358907, 11833.34916579562, 11904.523819047141, 11971.341576213044, 7886.487378320391, 8186.2632363087605, 8198.836023279382, 8371.288440482384, 8468.068512463748, 9251.0, 11624.94187529057, 11685.532578696757, 11734.119941004288, 11746.412679366169], "value": 9799.134501066772, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.6331485471203, 1503.6466430388853, 1719.6818588561116, 1856.4894653970148, 1880.8777429467093, 8035.236652518001, 8519.829603407929, 8690.565471726404, 9051.954740226289, 9053.818923621524, 8677.305815534757, 8853.601587928542, 8865.601047952841, 8887.0, 8893.199612034916, 2323.361075704182, 2368.6328619064075, 2376.0139542090096, 2379.5121999990047, 2383.1420688552107, 2343.2618725101624, 2361.9645705314433, 2398.8080953523677, 2398.9040438382444, 2403.9182367934413, 2355.846869953456, 2365.9645105323434, 2372.5136347048815, 2379.095943541452, 2380.4881950380664, 2106.3049193766096, 2346.765323467657, 2359.1507057459385, 2364.5861974154627, 2371.8339716219784, 2344.3787396339985, 2355.2580937004786, 2361.1853910400882, 2362.444825466014, 2367.2898130560934, 8845.115488451167, 8984.640614375417, 8988.056254093291, 8998.820023599557, 9031.096890310982, 5303.549198318147, 5367.46325367464, 5447.945520544784, 5451.781928722847, 5479.205515200313, 3581.910452238689, 3688.612695666943, 3709.2581483703366, 3720.8325625346924, 3741.681957033655, 936.5036530638772, 1098.203802243375, 1101.432762127505, 1102.0247081333077, 1128.8137457319533, 11447.771044579062, 11553.017993470565, 11579.53681852725, 11610.767784644344, 11610.941945290304, 4717.787699553528, 4723.601552593623, 4792.736399497991, 4870.366852309177, 4880.438749543777, 10035.09684128432, 10147.238957078249, 10148.137408320228, 10159.390436573829, 10169.288149829441, 5439.075357189287, 5446.591505637093, 5456.263404440429, 5458.4541545845095, 5464.207689884945, 4443.933340999887, 4795.400574928134, 4908.288298196741, 4929.950700492949, 4950.3069570260195, 3909.980450097788, 3968.8809335719975, 4025.8590949316635, 4074.6536544394057, 4102.425660407545, 1187.804012337972, 1190.9344986025678, 1285.3830161522521, 1290.4386591832583, 1301.7136230029378, 760.7979392559743, 831.6091437024588, 850.8598478039333, 860.9268212202034, 944.2068662323682, 5250.711210883438, 5770.16332631766, 6027.336992930774, 6104.145419641254, 6177.567570270128, 450.0795872440801, 457.9015511665008, 974.9658761943298, 1049.1344640671477, 1102.6802227354137, 3804.6385593368586, 4001.4397984282223, 4034.717569770147, 4039.414284928669, 4075.0, 10634.042936135631, 10802.405867677353, 10872.967068128515, 10877.945610271898, 10881.183911206692, 9844.114029737215, 10838.67483975482, 10858.67423977282, 10869.021788039114, 11142.997130258154, 6284.717187726564, 6936.618485983218, 8277.296429803535, 8309.0, 8321.292690121407, 4982.451930287593, 5744.281964754406, 5792.768289268382, 5868.38381969887, 5939.871424429344, 8611.526366049928, 8978.371513993958, 9594.848618165865, 9710.22318214527, 10171.033751793568, 8999.910000899907, 9053.460911644905, 9370.953145234504, 10037.548310325907, 10389.013043760831, 6975.860482790417, 7572.924270757222, 7707.344875685405, 7877.7636670899965, 8173.223543763333, 8255.628496717782, 8442.95778521128, 8458.661653534036, 8468.0, 8479.0, 7338.486305958531, 7394.926050739424, 7560.130584982798, 7570.470067095471, 7656.157822639617, 5498.697571633438, 7371.48399612022, 7422.0, 7489.887651685338, 7513.924860751323, 6999.12510936133, 7035.507514474142, 7100.112485939258, 7133.964330178316, 7134.821629459305, 4987.977464619817, 5036.496350365081, 5062.392512898476, 5066.695998240118, 5093.159628661229, 4970.992549507496, 4984.6261530384645, 5115.2582875483595, 5247.16045432729, 5252.632315737862], "value": 4576.961592978143, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.5734792616374, 310.15482809344525, 311.85342888842246, 315.8878598097674, 316.09123769163654, 4630.953690463094, 5092.439831618523, 5407.810281738021, 5634.605577609569, 5644.943550564493, 5228.764705588248, 5552.666839989603, 5568.415316391771, 5639.8590035249035, 5645.633033852797, 3332.6500717424747, 4128.938065928998, 4188.769617671027, 4188.853390131346, 4219.2700992593045, 3862.80685965702, 3964.6035396460265, 3971.3518889660754, 4230.43473914652, 4232.217039847638, 3831.616838316174, 3942.9156981830083, 4231.132617813341, 4250.2137104635585, 4312.05134870328, 3666.7460545054155, 4045.644709022481, 4128.174365126956, 4208.158368326347, 4261.76560289184, 3042.4371491273964, 3055.9541606875914, 3643.344198044351, 3655.141041855162, 3655.670989610921, 5404.189371594253, 5432.320959880015, 5448.128299472065, 5450.863728406822, 5455.263539422167, 4077.9601201693376, 4295.6778241632, 4616.8153273869, 4911.4106307243, 4941.135301322254, 5778.5377169826315, 5861.765529378819, 5863.648181109147, 5890.322612899528, 5918.319393269786, 3287.4411350070545, 3673.834677439495, 3751.8499260029566, 3881.3789793633164, 4035.455213546192, 5406.0, 5709.0, 6152.846178845564, 6207.565470417073, 6215.098810672427, 3200.8719651214155, 3332.3668502984356, 3397.4224381855142, 3834.079820842978, 4000.239954408653, 3235.498497732855, 4022.456968309299, 4028.9798551007057, 4057.6753859691153, 4084.4077608746566, 3987.840486380512, 4045.130296986162, 4363.432753742057, 4794.544518270759, 4799.808007679723, 4941.332920055746, 5326.721586819213, 5469.890602187934, 5845.561582881301, 5889.882202355929, 1247.6257122863105, 1349.9932500337436, 1373.5535950816025, 1376.7384197002536, 1378.4968486502555, 752.8870669399524, 792.5918152151646, 825.7357645553366, 831.8918540589806, 843.8270154618289, 4484.573965473275, 5524.917126243109, 5562.0, 5567.359753628303, 5575.860603484945, 5374.838754837361, 6102.511799056154, 6121.387861213932, 6130.724117414727, 6144.723487443076, 4693.647976401783, 5254.054270231319, 5283.867903302448, 5463.289772329572, 5556.277553958286, 2841.4601225767037, 3180.7137357637926, 3194.329190869897, 3195.201199700075, 3195.504696772004, 6066.514678825772, 6292.276388215322, 6305.96847015762, 6326.652034138075, 6349.55553111287, 5210.374755029421, 5866.568057686216, 5954.732037058343, 6207.441330280297, 6229.065640153923, 5728.48443640066, 5811.27359080115, 5873.119032145127, 6335.366463353628, 6380.234371875405, 5820.243368362086, 6016.939830601813, 6060.454559089703, 6089.847753806191, 6127.632342059491, 5800.651960882361, 5981.641101533922, 5998.580099393001, 6031.517478601789, 6085.604435711664, 5859.648421094748, 6237.658903335805, 6335.4931605472375, 6376.0, 6394.200724909387, 3956.742811717229, 3960.1881614269582, 3960.980195099006, 3968.960310396859, 3972.5630180679523, 5374.694562843901, 5501.889962200814, 5515.669059856422, 6034.2155519782145, 6092.025275955826, 4963.627727920348, 5007.795011192912, 5382.569394448356, 5880.764769409347, 5910.202122713378, 5846.473817356458, 5864.237649105589, 5868.471837534642, 5878.676672783038, 5908.970455147697, 5019.52314530119, 5118.948810511847, 5143.6399452037995, 5358.33020872391, 5538.806141785019, 4614.054118905549, 5014.724190169576, 5135.6405051646025, 5833.533317334518, 5891.204687367151, 4892.559669629751, 5043.940772437829, 5766.481016708516, 5794.420557944172, 5836.124581312837], "value": 4204.074066488567, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7144145840972, 770.5415277909643, 778.9805254868628, 793.2424534569486, 822.4612878564541, 15491.147986860718, 16118.516444506655, 16182.838171618281, 16216.945898516587, 16218.75671864923, 14738.926305368484, 14817.259137043131, 14842.703145937076, 14872.925635371836, 14889.702205955875, 676.8646270745846, 832.5587438657521, 836.0427310729211, 871.333429926107, 876.6011464783509, 867.0202670981813, 868.5917618719192, 869.256785448442, 872.310874409216, 873.52829472085, 905.4160066756938, 924.3160061554469, 925.1257561604286, 925.676013395313, 928.3037721708719, 893.8793262909554, 919.595378033663, 920.3281604428771, 920.7329874336434, 927.1516562345412, 679.5888487465111, 682.8463595690979, 685.7291369908858, 686.8282929267683, 687.4637782529635, 14992.250387480692, 15019.474318398912, 15026.474073407488, 15050.473233436776, 15095.018823776529, 14719.558413247512, 14748.262586870613, 14820.851791482162, 14875.47935822241, 14892.776608350776, 12063.577774777841, 12191.695207619792, 12387.75224495514, 12412.62762117138, 12541.184822986477, 3811.904702382435, 3825.5218097737784, 3981.6615587675083, 4038.2125485530332, 4041.070553772649, 122207.3889630555, 124828.0, 126309.26371258454, 126760.73239267581, 128400.35799821034, 11362.886371136183, 11522.596709115141, 11555.306681599131, 11582.015528680156, 11914.821277680841, 19110.71333929992, 19154.425367239004, 23812.0, 23857.761422385553, 23896.88051559731, 7123.358897699129, 7984.201579842085, 8134.227248411392, 8212.63043163059, 8252.174782521699, 3647.76289541179, 3826.253880493277, 4082.7754473503646, 4330.935035974463, 4450.599446049871, 3578.6779189873037, 3731.645493678096, 3768.7361884668358, 3770.5098337215986, 3775.7356985011334, 615.6398506873439, 662.3211208511218, 673.1249375811426, 679.864027194563, 689.152342618582, 569.8546870548066, 574.3481148896033, 578.6441338576745, 585.7569108819878, 607.8449995251183, 8305.543195124204, 9445.338826282094, 9704.320697551244, 9756.414615123116, 10034.147097496794, 520.8515573061659, 647.6405594894784, 671.1677519875417, 676.8781619308571, 713.9535930164523, 4394.758288294174, 4706.835260765925, 4720.553766838729, 4777.689450185727, 4800.423949126127, 98645.0, 109388.90611093787, 143026.0, 152486.23756881146, 162731.0, 98988.0, 133169.0, 136355.40979016895, 136596.0, 137488.0, 119033.809661904, 119076.0, 119191.0, 122010.0, 122542.0, 9118.0, 9203.953980230055, 9225.861612075958, 9269.768255793659, 9331.72004839856, 63295.0, 63769.0, 64201.0, 64607.0, 66393.0, 76112.0, 83361.0, 86132.56933715292, 90122.0, 100773.48066298402, 11794.351310677996, 11910.821337679768, 12147.08469967184, 12173.39133043362, 12341.259524428562, 11379.146564007899, 13543.729125417634, 13722.862771372158, 13723.451061957809, 13845.100068495516, 12489.375531223584, 13152.0, 13283.86716132865, 13375.53185638498, 13385.19688818674, 12090.214136081127, 12599.811002834782, 12799.040071994452, 12965.740685186054, 12979.026573007251, 11909.138200103971, 12272.079594030662, 12299.508019679113, 12323.445444955178, 12702.237865728086, 10510.867286323244, 10725.141988641046, 10758.354498730101, 10834.458277086273, 11123.94438027837, 9090.318226133199, 9533.379325514818, 10006.599736010769, 10814.729631759268, 10843.67468975932], "value": 7807.15407989145, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 111.0, 120.0, 117.0, 117.0, 120.0, 119.0, 118.0, 119.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 140.0, 193.0, 118.0, 128.0, 130.0, 109.0, 158.0, 109.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 200.0, 213.0, 259.0, 250.0, 201.0, 196.0, 197.0, 196.0, 193.0], "value": 210.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 83.0, 76.0, 143.0, 58.0, 59.0, 59.0, 54.0, 157.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 129.0, 86.0, 107.0, 113.0, 107.0, 89.0, 58.0, 128.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 78.0, 131.0, 88.0, 104.0, 86.0, 117.0, 89.0, 89.0, 85.0], "value": 95.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 151.0, 97.0, 103.0, 94.0, 95.0, 95.0, 123.0, 129.0, 152.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 149.0, 92.0, 91.0, 90.0, 93.0, 90.0, 135.0, 92.0, 118.0], "value": 109.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 60.0, 58.0, 59.0, 59.0, 58.0, 58.0, 56.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 76.0, 73.0, 74.0, 74.0, 69.0, 71.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 89.0, 89.0, 90.0, 92.0, 86.0, 91.0, 88.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 138.0, 137.0, 134.0, 140.0, 137.0, 187.0, 227.0, 147.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 179.0, 205.0, 257.0, 201.0, 175.0, 173.0, 176.0, 172.0], "value": 189.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 70.0, 90.0, 90.0, 92.0, 72.0, 66.0, 72.0], "value": 75.8, "unit": "score"}]}]} 05:26:03 INFO - Return code: 0 05:26:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:26:03 ERROR - # TBPL SUCCESS # 05:26:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:03 INFO - 2016-08-23 05:26:03.862 screenresolution[2323:27685] starting screenresolution argv=screenresolution get 05:26:03 INFO - 2016-08-23 05:26:03.865 screenresolution[2323:27685] Display 0: 1600x1200x32@60 05:26:03 INFO - 2016-08-23 05:26:03.871 screenresolution[2324:27688] starting screenresolution argv=screenresolution list 05:26:03 INFO - Available Modes on Display 0 05:26:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:04 INFO - Intel Iris: 05:26:04 INFO - Chipset Model: Intel Iris 05:26:04 INFO - Type: GPU 05:26:04 INFO - Bus: Built-In 05:26:04 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:04 INFO - Vendor: Intel (0x8086) 05:26:04 INFO - Device ID: 0x0a2e 05:26:04 INFO - Revision ID: 0x0009 05:26:04 INFO - Displays: 05:26:04 INFO - Display: 05:26:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:04 INFO - Display Serial Number: 1600x1200 60 05:26:04 INFO - Main Display: Yes 05:26:04 INFO - Mirror: Off 05:26:04 INFO - Online: Yes 05:26:04 INFO - Rotation: Supported 05:26:04 INFO - Return code: 0 05:26:04 INFO - Running post-action listener: _resource_record_post_action 05:26:04 INFO - [mozharness: 2016-08-23 12:26:04.106905Z] Finished run-tests step (success) 05:26:04 INFO - Running post-run listener: _resource_record_post_run 05:26:04 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 495616; Write bytes: 710976512; Read time: 6; Write time: 2025 05:26:04 INFO - TinderboxPrint: CPU usage
54.5% 05:26:04 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 6 05:26:04 INFO - TinderboxPrint: I/O write bytes / time
710,976,512 / 2,025 05:26:04 INFO - TinderboxPrint: CPU idle
2,203.8 (45.5%) 05:26:04 INFO - TinderboxPrint: CPU system
984.0 (20.3%) 05:26:04 INFO - TinderboxPrint: CPU user
1,654.0 (34.2%) 05:26:04 INFO - TinderboxPrint: Swap in / out
407,138,304 / 0 05:26:04 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395416064; Write bytes: 390747648; Read time: 29581; Write time: 798 05:26:04 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 495616; Write bytes: 300236288; Read time: 6; Write time: 1178 05:26:04 INFO - Running post-run listener: _upload_blobber_files 05:26:04 INFO - Blob upload gear active. 05:26:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:04 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 05:26:04 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:26:04 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:26:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:06 INFO - (blobuploader) - INFO - Done attempting. 05:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:07 INFO - (blobuploader) - INFO - Done attempting. 05:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:10 INFO - (blobuploader) - INFO - Done attempting. 05:26:10 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:10 INFO - Return code: 0 05:26:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0e262346445e5af31442ed2f4df1c136599d0ae519e7d4da2ffa93c437fa14733735ea6e13f58b559faf784a23a5ed021d2d300f187ee77bccd38d8b08d81d6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f425d7c478d8a256b498e6e28495d734151caff177ecbfa2afc327a57e78f0e174e25bb9e4bac7947f3d3df78fea7702e20be1248640d0eb8dcdb1984a3a252", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f5625920e7afba85aecb5451fb6dd441624a27cd09ca8e4a2dd3da05e0ecb6a4799a457ca1a6211ca86db3988c5a9953bd893a3bbcb6a24a3aca8d5970484d25"} 05:26:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:10 INFO - Contents: 05:26:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0e262346445e5af31442ed2f4df1c136599d0ae519e7d4da2ffa93c437fa14733735ea6e13f58b559faf784a23a5ed021d2d300f187ee77bccd38d8b08d81d6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f425d7c478d8a256b498e6e28495d734151caff177ecbfa2afc327a57e78f0e174e25bb9e4bac7947f3d3df78fea7702e20be1248640d0eb8dcdb1984a3a252", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f5625920e7afba85aecb5451fb6dd441624a27cd09ca8e4a2dd3da05e0ecb6a4799a457ca1a6211ca86db3988c5a9953bd893a3bbcb6a24a3aca8d5970484d25"} 05:26:10 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:10 INFO - Copying logs to upload dir... 05:26:10 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.214366 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-23 05:26:10.364403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 05:26:10.367985) ========= 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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0e262346445e5af31442ed2f4df1c136599d0ae519e7d4da2ffa93c437fa14733735ea6e13f58b559faf784a23a5ed021d2d300f187ee77bccd38d8b08d81d6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f425d7c478d8a256b498e6e28495d734151caff177ecbfa2afc327a57e78f0e174e25bb9e4bac7947f3d3df78fea7702e20be1248640d0eb8dcdb1984a3a252", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f5625920e7afba85aecb5451fb6dd441624a27cd09ca8e4a2dd3da05e0ecb6a4799a457ca1a6211ca86db3988c5a9953bd893a3bbcb6a24a3aca8d5970484d25"} build_url:https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010893 build_url: 'https://queue.taskcluster.net/v1/task/DM4DjKKHSP2v4TGppf7NfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0e262346445e5af31442ed2f4df1c136599d0ae519e7d4da2ffa93c437fa14733735ea6e13f58b559faf784a23a5ed021d2d300f187ee77bccd38d8b08d81d6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f425d7c478d8a256b498e6e28495d734151caff177ecbfa2afc327a57e78f0e174e25bb9e4bac7947f3d3df78fea7702e20be1248640d0eb8dcdb1984a3a252", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f5625920e7afba85aecb5451fb6dd441624a27cd09ca8e4a2dd3da05e0ecb6a4799a457ca1a6211ca86db3988c5a9953bd893a3bbcb6a24a3aca8d5970484d25"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 05:26:10.400987) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:26:10.401333) ========= 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.NK6Z5ZltT7/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.J5TN31oc1Q/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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.004616 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:26:10.450547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 05:26:10.450872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 05:26:10.451210) ========= ========= Total master_lag: 4.05 =========