builder: graphics_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0244 starttime: 1484938611.29 results: success (0) buildid: 20170120074826 builduid: ac66c0c11d03409d99c14f4dcf2ee6d0 revision: 3a66923ddb35a1b46659ade1db9eeb6c9049eaf0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:51.292709) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:51.293779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:51.294115) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:51.318943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:51.319337) ========= 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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-20 10:56:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2017-01-20 10:56:51 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116089 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:51.460606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:51.460963) ========= 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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.019212 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:51.509492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-20 10:56:51.509880) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 3a66923ddb35a1b46659ade1db9eeb6c9049eaf0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 3a66923ddb35a1b46659ade1db9eeb6c9049eaf0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nN0Z2Av8Ae/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.7cBpocovnW/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-20 10:56:51,614 truncating revision to first 12 chars 2017-01-20 10:56:51,614 Setting DEBUG logging. 2017-01-20 10:56:51,614 attempt 1/10 2017-01-20 10:56:51,614 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/3a66923ddb35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 10:56:52,998 unpacking tar archive at: graphics-3a66923ddb35/testing/mozharness/ program finished with exit code 0 elapsedTime=1.668444 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-20 10:56:53.200570) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:53.200940) ========= script_repo_revision: 3a66923ddb35a1b46659ade1db9eeb6c9049eaf0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:53.201384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:53.201695) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 10:56:53.219670) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-20 10:56:53.219986) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nN0Z2Av8Ae/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.7cBpocovnW/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:56:53 INFO - MultiFileLogger online at 20170120 10:56:53 in /builds/slave/test 10:56:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 10:56:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:56:53 INFO - {'append_to_log': False, 10:56:53 INFO - 'base_work_dir': '/builds/slave/test', 10:56:53 INFO - 'blob_upload_branch': 'Graphics', 10:56:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:56:53 INFO - 'branch': 'Graphics', 10:56:53 INFO - 'buildbot_json_path': 'buildprops.json', 10:56:53 INFO - 'config_files': ('talos/mac_config.py',), 10:56:53 INFO - 'default_actions': ('clobber', 10:56:53 INFO - 'read-buildbot-config', 10:56:53 INFO - 'download-and-extract', 10:56:53 INFO - 'populate-webroot', 10:56:53 INFO - 'create-virtualenv', 10:56:53 INFO - 'install', 10:56:53 INFO - 'run-tests'), 10:56:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:56:53 INFO - 'download_minidump_stackwalk': True, 10:56:53 INFO - 'download_symbols': 'ondemand', 10:56:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:56:53 INFO - 'tooltool.py': '/tools/tooltool.py', 10:56:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:56:53 INFO - '/tools/misc-python/virtualenv.py')}, 10:56:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:56:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:56:53 INFO - 'installer_path': 'installer.exe', 10:56:53 INFO - 'log_level': 'info', 10:56:53 INFO - 'log_name': 'talos', 10:56:53 INFO - 'log_to_console': True, 10:56:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:56:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:56:53 INFO - 'opt_config_files': (), 10:56:53 INFO - 'pip_index': False, 10:56:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:56:53 INFO - 'cmd': ('bash', 10:56:53 INFO - '-c', 10:56:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:56:53 INFO - 'enabled': True, 10:56:53 INFO - 'halt_on_failure': False, 10:56:53 INFO - 'name': 'check_screen_resolution'},), 10:56:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:56:53 INFO - 'cmd': ('bash', 10:56:53 INFO - '-c', 10:56:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:56:53 INFO - 'enabled': True, 10:56:53 INFO - 'halt_on_failure': False, 10:56:53 INFO - 'name': 'check_screen_resolution'},), 10:56:53 INFO - 'run_cmd_checks_enabled': True, 10:56:53 INFO - 'sps_profile': False, 10:56:53 INFO - 'sps_profile_interval': 0, 10:56:53 INFO - 'suite': 'dromaeojs-e10s', 10:56:53 INFO - 'system_bits': '32', 10:56:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:56:53 INFO - 'title': 't-yosemite-r7-0244', 10:56:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:56:53 INFO - 'use_talos_json': True, 10:56:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:56:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:56:53 INFO - 'work_dir': 'build'} 10:56:53 INFO - [mozharness: 2017-01-20 18:56:53.436936Z] Running clobber step. 10:56:53 INFO - Running pre-action listener: _resource_record_pre_action 10:56:53 INFO - Running main action method: clobber 10:56:53 INFO - rmtree: /builds/slave/test/build 10:56:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:56:54 INFO - Running post-action listener: _resource_record_post_action 10:56:54 INFO - [mozharness: 2017-01-20 18:56:54.940700Z] Finished clobber step (success) 10:56:54 INFO - [mozharness: 2017-01-20 18:56:54.940796Z] Running read-buildbot-config step. 10:56:54 INFO - Running pre-action listener: _resource_record_pre_action 10:56:54 INFO - Running main action method: read_buildbot_config 10:56:54 INFO - Using buildbot properties: 10:56:54 INFO - { 10:56:54 INFO - "project": "", 10:56:54 INFO - "product": "firefox", 10:56:54 INFO - "script_repo_revision": "default", 10:56:54 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs-e10s", 10:56:54 INFO - "repository": "", 10:56:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs-e10s", 10:56:54 INFO - "buildid": "20170120074826", 10:56:54 INFO - "pgo_build": "False", 10:56:54 INFO - "basedir": "/builds/slave/test", 10:56:54 INFO - "buildnumber": 11, 10:56:54 INFO - "slavename": "t-yosemite-r7-0244", 10:56:54 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:56:54 INFO - "platform": "yosemite_r7", 10:56:54 INFO - "scheduler": "tests-graphics-macosx64-talos-8-3600", 10:56:54 INFO - "branch": "graphics", 10:56:54 INFO - "repo_path": "projects/graphics", 10:56:54 INFO - "revision": "3a66923ddb35a1b46659ade1db9eeb6c9049eaf0", 10:56:54 INFO - "stage_platform": "macosx64", 10:56:54 INFO - "builduid": "ac66c0c11d03409d99c14f4dcf2ee6d0", 10:56:54 INFO - "slavebuilddir": "test" 10:56:54 INFO - } 10:56:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 10:56:54 INFO - Running post-action listener: _resource_record_post_action 10:56:54 INFO - [mozharness: 2017-01-20 18:56:54.944762Z] Finished read-buildbot-config step (success) 10:56:54 INFO - [mozharness: 2017-01-20 18:56:54.944942Z] Running download-and-extract step. 10:56:54 INFO - Running pre-action listener: _resource_record_pre_action 10:56:54 INFO - Running main action method: download_and_extract 10:56:54 INFO - mkdir: /builds/slave/test/build/tests 10:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:54 INFO - trying https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 10:56:54 INFO - Downloading https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 10:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 10:56:56 INFO - Downloaded 1199 bytes. 10:56:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 10:56:56 INFO - Using the following test package requirements: 10:56:56 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 10:56:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 10:56:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 10:56:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:56:56 INFO - u'jsshell-mac.zip'], 10:56:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 10:56:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 10:56:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 10:56:56 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 10:56:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 10:56:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:56:56 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 10:56:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:56:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 10:56:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:56:56 INFO - Fetch https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 10:56:57 INFO - Expected file size: 16345365 10:56:57 INFO - Obtained file size: 16345365 10:57:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:57:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 10:57:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:57:03 INFO - Fetch https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 10:57:04 INFO - Expected file size: 16345365 10:57:04 INFO - Obtained file size: 16345365 10:57:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 10:57:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:57:10 INFO - Fetch https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 10:57:12 INFO - Expected file size: 14403476 10:57:12 INFO - Obtained file size: 14403476 10:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:12 INFO - trying https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:57:12 INFO - Downloading https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 10:57:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 10:57:14 INFO - Downloaded 69995976 bytes. 10:57:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:57:14 INFO - mkdir: /builds/slave/test/properties 10:57:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:57:14 INFO - Writing to file /builds/slave/test/properties/build_url 10:57:14 INFO - Contents: 10:57:14 INFO - build_url:https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:57:15 INFO - Running post-action listener: _resource_record_post_action 10:57:15 INFO - Running post-action listener: set_extra_try_arguments 10:57:15 INFO - [mozharness: 2017-01-20 18:57:15.299911Z] Finished download-and-extract step (success) 10:57:15 INFO - [mozharness: 2017-01-20 18:57:15.300050Z] Running populate-webroot step. 10:57:15 INFO - Running pre-action listener: _resource_record_pre_action 10:57:15 INFO - Running main action method: populate_webroot 10:57:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:57:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:57:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:57:15 INFO - '--tppagecycles', 10:57:15 INFO - '7'], 10:57:15 INFO - 'tests': ['tsvgm']}}, 10:57:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:57:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:57:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:57:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:57:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:57:15 INFO - 'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:57:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:57:15 INFO - 'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['damp', 'tps']}, 10:57:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:57:15 INFO - 'tests': ['damp', 'tps']}, 10:57:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['dromaeo_dom']}, 10:57:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:57:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['basic_compositor_video']}, 10:57:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:57:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['a11yr', 10:57:15 INFO - 'ts_paint', 10:57:15 INFO - 'tpaint', 10:57:15 INFO - 'sessionrestore', 10:57:15 INFO - 'sessionrestore_no_auto_restore', 10:57:15 INFO - 'tabpaint']}, 10:57:15 INFO - 'other-e10s': {'tests': ['a11yr', 10:57:15 INFO - 'ts_paint', 10:57:15 INFO - 'tpaint', 10:57:15 INFO - 'sessionrestore', 10:57:15 INFO - 'sessionrestore_no_auto_restore', 10:57:15 INFO - 'tabpaint']}, 10:57:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:57:15 INFO - 'ts_paint', 10:57:15 INFO - 'tpaint', 10:57:15 INFO - 'sessionrestore', 10:57:15 INFO - 'sessionrestore_no_auto_restore', 10:57:15 INFO - 'tabpaint']}, 10:57:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:57:15 INFO - 'ts_paint', 10:57:15 INFO - 'tpaint', 10:57:15 INFO - 'sessionrestore', 10:57:15 INFO - 'sessionrestore_no_auto_restore', 10:57:15 INFO - 'tabpaint']}, 10:57:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['a11yr', 10:57:15 INFO - 'ts_paint', 10:57:15 INFO - 'tpaint', 10:57:15 INFO - 'sessionrestore', 10:57:15 INFO - 'sessionrestore_no_auto_restore', 10:57:15 INFO - 'tabpaint']}, 10:57:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['a11yr', 10:57:15 INFO - 'ts_paint', 10:57:15 INFO - 'tpaint', 10:57:15 INFO - 'sessionrestore', 10:57:15 INFO - 'sessionrestore_no_auto_restore', 10:57:15 INFO - 'tabpaint']}, 10:57:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['tsvgx', 10:57:15 INFO - 'tsvgr_opacity', 10:57:15 INFO - 'tart', 10:57:15 INFO - 'tscrollx', 10:57:15 INFO - 'cart', 10:57:15 INFO - 'tsvg_static']}, 10:57:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:57:15 INFO - 'tsvgr_opacity', 10:57:15 INFO - 'tart', 10:57:15 INFO - 'tscrollx', 10:57:15 INFO - 'cart', 10:57:15 INFO - 'tsvg_static']}, 10:57:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:57:15 INFO - 'talos_options': ['--disable-e10s'], 10:57:15 INFO - 'tests': ['tp5o']}, 10:57:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:57:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:57:15 INFO - 'talos_options': ['--disable-e10s', 10:57:15 INFO - '--xperf_path', 10:57:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:15 INFO - 'tests': ['tp5n']}, 10:57:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:57:15 INFO - 'talos_options': ['--xperf_path', 10:57:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:15 INFO - 'tests': ['tp5n']}}, 10:57:15 INFO - 'talos.zip': {'path': '', 10:57:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:57:15 INFO - Running post-action listener: _resource_record_post_action 10:57:15 INFO - [mozharness: 2017-01-20 18:57:15.317965Z] Finished populate-webroot step (success) 10:57:15 INFO - [mozharness: 2017-01-20 18:57:15.318056Z] Running create-virtualenv step. 10:57:15 INFO - Running pre-action listener: _resource_record_pre_action 10:57:15 INFO - Running main action method: create_virtualenv 10:57:15 INFO - Creating virtualenv /builds/slave/test/build/venv 10:57:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:57:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:57:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:57:15 INFO - Using real prefix '/tools/python27' 10:57:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:57:16 INFO - Installing distribute.............................................................................................................................................................................................done. 10:57:18 INFO - Installing pip.................done. 10:57:18 INFO - Return code: 0 10:57:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:57:19 INFO - Reading from file tmpfile_stdout 10:57:19 INFO - Output received: 10:57:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:57:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:57: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')]} 10:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:19 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 0x10c493b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c496768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80b5e5490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, '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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:57:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:57:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:19 INFO - 'HOME': '/Users/cltbld', 10:57:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:19 INFO - 'LOGNAME': 'cltbld', 10:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:19 INFO - 'MOZ_NO_REMOTE': '1', 10:57:19 INFO - 'NO_EM_RESTART': '1', 10:57:19 INFO - 'PAGER': '/bin/cat', 10:57:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:19 INFO - 'PWD': '/builds/slave/test', 10:57:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:19 INFO - 'SHELL': '/bin/bash', 10:57:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:57:19 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:57:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:19 INFO - 'USER': 'cltbld', 10:57:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:19 INFO - 'XPC_FLAGS': '0x0', 10:57:19 INFO - 'XPC_SERVICE_NAME': '0', 10:57:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:57:19 INFO - Cleaning up... 10:57:19 INFO - Return code: 0 10:57:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:57: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')]} 10:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:19 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 0x10c493b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c496768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80b5e5490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, '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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:57:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:57:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:19 INFO - 'HOME': '/Users/cltbld', 10:57:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:19 INFO - 'LOGNAME': 'cltbld', 10:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:19 INFO - 'MOZ_NO_REMOTE': '1', 10:57:19 INFO - 'NO_EM_RESTART': '1', 10:57:19 INFO - 'PAGER': '/bin/cat', 10:57:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:19 INFO - 'PWD': '/builds/slave/test', 10:57:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:19 INFO - 'SHELL': '/bin/bash', 10:57:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:57:19 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:57:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:19 INFO - 'USER': 'cltbld', 10:57:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:19 INFO - 'XPC_FLAGS': '0x0', 10:57:19 INFO - 'XPC_SERVICE_NAME': '0', 10:57:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:19 INFO - Downloading/unpacking psutil>=3.1.1 10:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:57:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:23 INFO - Installing collected packages: psutil 10:57:23 INFO - Running setup.py install for psutil 10:57:23 INFO - building 'psutil._psutil_osx' extension 10:57:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:57:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:57:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:57:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:57:23 INFO - building 'psutil._psutil_posix' extension 10:57:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:57:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:57:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:57:23 INFO - ^ 10:57:24 INFO - 1 warning generated. 10:57:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:24 INFO - Successfully installed psutil 10:57:24 INFO - Cleaning up... 10:57:24 INFO - Return code: 0 10:57:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:24 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 0x10c493b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c496768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80b5e5490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, '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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:24 INFO - 'HOME': '/Users/cltbld', 10:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:24 INFO - 'LOGNAME': 'cltbld', 10:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:24 INFO - 'MOZ_NO_REMOTE': '1', 10:57:24 INFO - 'NO_EM_RESTART': '1', 10:57:24 INFO - 'PAGER': '/bin/cat', 10:57:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:24 INFO - 'PWD': '/builds/slave/test', 10:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:24 INFO - 'SHELL': '/bin/bash', 10:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:57:24 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:24 INFO - 'USER': 'cltbld', 10:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:24 INFO - 'XPC_FLAGS': '0x0', 10:57:24 INFO - 'XPC_SERVICE_NAME': '0', 10:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:57:27 INFO - Installing collected packages: mozsystemmonitor 10:57:27 INFO - Running setup.py install for mozsystemmonitor 10:57:27 INFO - Successfully installed mozsystemmonitor 10:57:27 INFO - Cleaning up... 10:57:27 INFO - Return code: 0 10:57:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c493b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c496768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80b5e5490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, '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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:27 INFO - 'HOME': '/Users/cltbld', 10:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:27 INFO - 'LOGNAME': 'cltbld', 10:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:27 INFO - 'MOZ_NO_REMOTE': '1', 10:57:27 INFO - 'NO_EM_RESTART': '1', 10:57:27 INFO - 'PAGER': '/bin/cat', 10:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:27 INFO - 'PWD': '/builds/slave/test', 10:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:27 INFO - 'SHELL': '/bin/bash', 10:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:57:27 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:27 INFO - 'USER': 'cltbld', 10:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:27 INFO - 'XPC_FLAGS': '0x0', 10:57:27 INFO - 'XPC_SERVICE_NAME': '0', 10:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:27 INFO - Downloading/unpacking jsonschema==2.5.1 10:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:57:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:30 INFO - Downloading functools32-3.2.3-2.tar.gz 10:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:57:30 INFO - warning: no files found matching '*.txt' 10:57:30 INFO - no previously-included directories found matching 'build' 10:57:30 INFO - no previously-included directories found matching 'dist' 10:57:30 INFO - no previously-included directories found matching '.git*' 10:57:30 INFO - Installing collected packages: jsonschema, functools32 10:57:30 INFO - Running setup.py install for functools32 10:57:30 INFO - warning: no files found matching '*.txt' 10:57:30 INFO - no previously-included directories found matching 'build' 10:57:30 INFO - no previously-included directories found matching 'dist' 10:57:30 INFO - no previously-included directories found matching '.git*' 10:57:31 INFO - Successfully installed jsonschema functools32 10:57:31 INFO - Cleaning up... 10:57:31 INFO - Return code: 0 10:57:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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', '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 0x10c493b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c496768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80b5e5490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, '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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:57: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 functools32==3.2.3-2 10:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:31 INFO - 'HOME': '/Users/cltbld', 10:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:31 INFO - 'LOGNAME': 'cltbld', 10:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:31 INFO - 'MOZ_NO_REMOTE': '1', 10:57:31 INFO - 'NO_EM_RESTART': '1', 10:57:31 INFO - 'PAGER': '/bin/cat', 10:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:31 INFO - 'PWD': '/builds/slave/test', 10:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:31 INFO - 'SHELL': '/bin/bash', 10:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:57:31 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:31 INFO - 'USER': 'cltbld', 10:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:31 INFO - 'XPC_FLAGS': '0x0', 10:57:31 INFO - 'XPC_SERVICE_NAME': '0', 10:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:57:31 INFO - Cleaning up... 10:57:31 INFO - Return code: 0 10:57:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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', '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 0x10c493b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c496768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80b5e5490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, '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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:57: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 blobuploader==1.2.4 10:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:31 INFO - 'HOME': '/Users/cltbld', 10:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:31 INFO - 'LOGNAME': 'cltbld', 10:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:31 INFO - 'MOZ_NO_REMOTE': '1', 10:57:31 INFO - 'NO_EM_RESTART': '1', 10:57:31 INFO - 'PAGER': '/bin/cat', 10:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:31 INFO - 'PWD': '/builds/slave/test', 10:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:31 INFO - 'SHELL': '/bin/bash', 10:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:57:31 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:31 INFO - 'USER': 'cltbld', 10:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:31 INFO - 'XPC_FLAGS': '0x0', 10:57:31 INFO - 'XPC_SERVICE_NAME': '0', 10:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:31 INFO - Downloading/unpacking blobuploader==1.2.4 10:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:34 INFO - Downloading blobuploader-1.2.4.tar.gz 10:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:57:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:57:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:35 INFO - Downloading docopt-0.6.1.tar.gz 10:57:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:57:35 INFO - Installing collected packages: blobuploader, requests, docopt 10:57:35 INFO - Running setup.py install for blobuploader 10:57:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:57:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:57:35 INFO - Running setup.py install for requests 10:57:36 INFO - Running setup.py install for docopt 10:57:36 INFO - Successfully installed blobuploader requests docopt 10:57:36 INFO - Cleaning up... 10:57:36 INFO - Return code: 0 10:57:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:36 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 0x10c493b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c496768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80b5e5490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, '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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:57:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:57:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:36 INFO - 'HOME': '/Users/cltbld', 10:57:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:36 INFO - 'LOGNAME': 'cltbld', 10:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:36 INFO - 'MOZ_NO_REMOTE': '1', 10:57:36 INFO - 'NO_EM_RESTART': '1', 10:57:36 INFO - 'PAGER': '/bin/cat', 10:57:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:36 INFO - 'PWD': '/builds/slave/test', 10:57:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:36 INFO - 'SHELL': '/bin/bash', 10:57:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:57:36 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:57:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:36 INFO - 'USER': 'cltbld', 10:57:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:36 INFO - 'XPC_FLAGS': '0x0', 10:57:36 INFO - 'XPC_SERVICE_NAME': '0', 10:57:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:36 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-w6IcLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:36 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-SeXnFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:36 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-6ewM3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:36 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-AaoyGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:37 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-77TTZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:37 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-NLulbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:37 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-Ao7AmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:37 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-aICnxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:37 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-M2hkw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:37 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-EIT688-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:37 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-baD_7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:37 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-DgwFe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:37 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-EAOTK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:38 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-gJHq9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:38 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-R8mXQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:38 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-fhLhSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:38 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-OBit9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:57:38 INFO - Running setup.py install for manifestparser 10:57:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:57:38 INFO - Running setup.py install for mozcrash 10:57:38 INFO - Running setup.py install for mozdebug 10:57:38 INFO - Running setup.py install for mozdevice 10:57:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:57:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:57:39 INFO - Running setup.py install for mozfile 10:57:39 INFO - Running setup.py install for mozhttpd 10:57:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:57:39 INFO - Running setup.py install for mozinfo 10:57:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:57:39 INFO - Running setup.py install for mozInstall 10:57:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:57:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:57:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:57:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:57:39 INFO - Running setup.py install for mozleak 10:57:39 INFO - Running setup.py install for mozlog 10:57:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:57:39 INFO - Running setup.py install for moznetwork 10:57:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:57:40 INFO - Running setup.py install for mozprocess 10:57:40 INFO - Running setup.py install for mozprofile 10:57:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:57:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:57:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:57:40 INFO - Running setup.py install for mozrunner 10:57:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:57:40 INFO - Running setup.py install for mozscreenshot 10:57:40 INFO - Running setup.py install for moztest 10:57:40 INFO - Running setup.py install for mozversion 10:57:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:57:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:57:40 INFO - Cleaning up... 10:57:40 INFO - Return code: 0 10:57:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:40 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 0x10c493b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c496768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80b5e5490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, '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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:40 INFO - 'HOME': '/Users/cltbld', 10:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:40 INFO - 'LOGNAME': 'cltbld', 10:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:40 INFO - 'MOZ_NO_REMOTE': '1', 10:57:40 INFO - 'NO_EM_RESTART': '1', 10:57:40 INFO - 'PAGER': '/bin/cat', 10:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:40 INFO - 'PWD': '/builds/slave/test', 10:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:40 INFO - 'SHELL': '/bin/bash', 10:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:57:40 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:40 INFO - 'USER': 'cltbld', 10:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:40 INFO - 'XPC_FLAGS': '0x0', 10:57:40 INFO - 'XPC_SERVICE_NAME': '0', 10:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-a_BJiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-74FDRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-8gHznc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-rK2rV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-qYVaEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-xr9NeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-wc6K1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:41 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-P78q6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:42 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-pH9NBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:42 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-4GgQUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:42 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-x6YaYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:42 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-FeSXLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:42 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-CGNCo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:42 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-KWRAtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:42 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-YQXeij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:42 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-vNqYWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:42 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-B_uBie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:57:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:57:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:57:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:57:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:57:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:57:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:45 INFO - Downloading blessings-1.6.tar.gz 10:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:45 INFO - Installing collected packages: blessings 10:57:45 INFO - Running setup.py install for blessings 10:57:45 INFO - Successfully installed blessings 10:57:45 INFO - Cleaning up... 10:57:45 INFO - Return code: 0 10:57:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:57:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:46 INFO - Reading from file tmpfile_stdout 10:57:46 INFO - Current package versions: 10:57:46 INFO - blessings == 1.6 10:57:46 INFO - blobuploader == 1.2.4 10:57:46 INFO - docopt == 0.6.1 10:57:46 INFO - functools32 == 3.2.3-2 10:57:46 INFO - jsonschema == 2.5.1 10:57:46 INFO - manifestparser == 1.1 10:57:46 INFO - mozInstall == 1.12 10:57:46 INFO - mozcrash == 1.0 10:57:46 INFO - mozdebug == 0.1 10:57:46 INFO - mozdevice == 0.49 10:57:46 INFO - mozfile == 1.2 10:57:46 INFO - mozhttpd == 0.7 10:57:46 INFO - mozinfo == 0.9 10:57:46 INFO - mozleak == 0.1 10:57:46 INFO - mozlog == 3.4 10:57:46 INFO - moznetwork == 0.27 10:57:46 INFO - mozprocess == 0.24 10:57:46 INFO - mozprofile == 0.28 10:57:46 INFO - mozrunner == 6.13 10:57:46 INFO - mozscreenshot == 0.1 10:57:46 INFO - mozsystemmonitor == 0.3 10:57:46 INFO - moztest == 0.8 10:57:46 INFO - mozversion == 1.4 10:57:46 INFO - psutil == 3.1.1 10:57:46 INFO - requests == 1.2.3 10:57:46 INFO - wsgiref == 0.1.2 10:57:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:46 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 0x10c493b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c496768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80b5e5490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, '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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:57:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:57:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:46 INFO - 'HOME': '/Users/cltbld', 10:57:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:46 INFO - 'LOGNAME': 'cltbld', 10:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:46 INFO - 'MOZ_NO_REMOTE': '1', 10:57:46 INFO - 'NO_EM_RESTART': '1', 10:57:46 INFO - 'PAGER': '/bin/cat', 10:57:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:46 INFO - 'PWD': '/builds/slave/test', 10:57:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:46 INFO - 'SHELL': '/bin/bash', 10:57:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:57:46 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:57:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:46 INFO - 'USER': 'cltbld', 10:57:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:46 INFO - 'XPC_FLAGS': '0x0', 10:57:46 INFO - 'XPC_SERVICE_NAME': '0', 10:57:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:57:46 INFO - Cleaning up... 10:57:46 INFO - Return code: 0 10:57:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:46 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 0x10c493b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c496768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc80b5e5490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, '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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:57:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:57:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:46 INFO - 'HOME': '/Users/cltbld', 10:57:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:46 INFO - 'LOGNAME': 'cltbld', 10:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:46 INFO - 'MOZ_NO_REMOTE': '1', 10:57:46 INFO - 'NO_EM_RESTART': '1', 10:57:46 INFO - 'PAGER': '/bin/cat', 10:57:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:46 INFO - 'PWD': '/builds/slave/test', 10:57:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:46 INFO - 'SHELL': '/bin/bash', 10:57:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:57:46 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:57:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:46 INFO - 'USER': 'cltbld', 10:57:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:46 INFO - 'XPC_FLAGS': '0x0', 10:57:46 INFO - 'XPC_SERVICE_NAME': '0', 10:57:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:57:46 INFO - Cleaning up... 10:57:46 INFO - Return code: 0 10:57:46 INFO - Running post-action listener: _resource_record_post_action 10:57:46 INFO - Running post-action listener: _start_resource_monitoring 10:57:46 INFO - Starting resource monitoring. 10:57:46 INFO - [mozharness: 2017-01-20 18:57:46.776853Z] Finished create-virtualenv step (success) 10:57:46 INFO - [mozharness: 2017-01-20 18:57:46.777760Z] Running install step. 10:57:46 INFO - Running pre-action listener: _resource_record_pre_action 10:57:46 INFO - Running main action method: install 10:57:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:47 INFO - Reading from file tmpfile_stdout 10:57:47 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:57:47 INFO - Reading from file tmpfile_stdout 10:57:47 INFO - Output received: 10:57:47 INFO - Usage: mozinstall [options] installer 10:57:47 INFO - Options: 10:57:47 INFO - -h, --help show this help message and exit 10:57:47 INFO - -d DEST, --destination=DEST 10:57:47 INFO - Directory to install application into. [default: 10:57:47 INFO - "/builds/slave/test"] 10:57:47 INFO - --app=APP Application being installed. [default: firefox] 10:57:47 INFO - mkdir: /builds/slave/test/build/application 10:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:58:09 INFO - Reading from file tmpfile_stdout 10:58:09 INFO - Output received: 10:58:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:58:09 INFO - Running post-action listener: _resource_record_post_action 10:58:09 INFO - [mozharness: 2017-01-20 18:58:09.087684Z] Finished install step (success) 10:58:09 INFO - [mozharness: 2017-01-20 18:58:09.087839Z] Running run-tests step. 10:58:09 INFO - Running pre-action listener: _resource_record_pre_action 10:58:09 INFO - Running main action method: run_tests 10:58:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:58:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:58:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:58:09 INFO - 2017-01-20 10:58:09.102 screenresolution[1890:13518] starting screenresolution argv=screenresolution get 10:58:09 INFO - 2017-01-20 10:58:09.105 screenresolution[1890:13518] Display 0: 1600x1200x32@60 10:58:09 INFO - 2017-01-20 10:58:09.110 screenresolution[1891:13521] starting screenresolution argv=screenresolution list 10:58:09 INFO - Available Modes on Display 0 10:58:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:58:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:58:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:58:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:58:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:58:09 INFO - Intel Iris: 10:58:09 INFO - Chipset Model: Intel Iris 10:58:09 INFO - Type: GPU 10:58:09 INFO - Bus: Built-In 10:58:09 INFO - VRAM (Dynamic, Max): 1536 MB 10:58:09 INFO - Vendor: Intel (0x8086) 10:58:09 INFO - Device ID: 0x0a2e 10:58:09 INFO - Revision ID: 0x0009 10:58:09 INFO - Displays: 10:58:09 INFO - Display: 10:58:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:58:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:58:09 INFO - Display Serial Number: 1600x1200 60 10:58:09 INFO - Main Display: Yes 10:58:09 INFO - Mirror: Off 10:58:09 INFO - Online: Yes 10:58:09 INFO - Rotation: Supported 10:58:09 INFO - Return code: 0 10:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:58:09 INFO - Python 2.7.3 10:58:09 INFO - Return code: 0 10:58:09 INFO - grabbing minidump binary from tooltool 10:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:09 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 0x10c271d30>, '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 0x10c198db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c266be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:58:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:58:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:58:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:58:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:58:09 INFO - Return code: 0 10:58:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:58:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:58:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:58:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:58:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0244 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nN0Z2Av8Ae/Render', 10:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:58:09 INFO - 'HOME': '/Users/cltbld', 10:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:58:09 INFO - 'LOGNAME': 'cltbld', 10:58:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:58:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:09 INFO - 'MOZ_NO_REMOTE': '1', 10:58:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:58:09 INFO - 'NO_EM_RESTART': '1', 10:58:09 INFO - 'PAGER': '/bin/cat', 10:58:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:09 INFO - 'PWD': '/builds/slave/test', 10:58:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:58:09 INFO - 'SHELL': '/bin/bash', 10:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7cBpocovnW/Listeners', 10:58:09 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 10:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:58:09 INFO - 'USER': 'cltbld', 10:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:09 INFO - 'XPC_FLAGS': '0x0', 10:58:09 INFO - 'XPC_SERVICE_NAME': '0', 10:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:58:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:58:09 INFO - mozversion application_buildid: 20170120074826 10:58:09 INFO - mozversion application_changeset: 3a66923ddb35a1b46659ade1db9eeb6c9049eaf0 10:58:09 INFO - mozversion application_display_name: Nightly 10:58:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:58:09 INFO - mozversion application_name: Firefox 10:58:09 INFO - mozversion application_remotingname: firefox 10:58:09 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 10:58:09 INFO - mozversion application_vendor: Mozilla 10:58:09 INFO - mozversion application_version: 53.0a1 10:58:09 INFO - mozversion platform_buildid: 20170120074826 10:58:09 INFO - mozversion platform_changeset: 3a66923ddb35a1b46659ade1db9eeb6c9049eaf0 10:58:09 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 10:58:09 INFO - mozversion platform_version: 53.0a1 10:58:09 INFO - using testdate: 1484938689 10:58:09 INFO - actual date: 1484938689 10:58:09 INFO - starting webserver on 'localhost:50862' 10:58:09 INFO - SUITE-START | Running 2 tests 10:58:09 INFO - TEST-START | dromaeo_css 10:58:09 INFO - operating with platform_type : mac_ 10:58:09 INFO - Initialising browser for dromaeo_css test... 10:58:09 INFO - TEST-INFO | started process 1901 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpNHJCrL/profile http://localhost:50862/getInfo.html) 10:58:12 INFO - PROCESS | 1901 | 2017-01-20 10:58:12.706 plugin-container[1903:13678] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c2f, name = 'com.apple.tsm.portname' 10:58:12 INFO - PROCESS | 1901 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:58:12 INFO - PROCESS | 1901 | 2017-01-20 10:58:12.709 plugin-container[1903:13678] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9503, name = 'com.apple.CFPasteboardClient' 10:58:12 INFO - PROCESS | 1901 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:58:12 INFO - PROCESS | 1901 | 2017-01-20 10:58:12.709 plugin-container[1903:13678] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:58:12 INFO - PROCESS | 1901 | __metrics Screen width/height:1600/1200 10:58:12 INFO - PROCESS | 1901 | colorDepth:24 10:58:12 INFO - PROCESS | 1901 | Browser inner width/height: 1024/689 10:58:12 INFO - PROCESS | 1901 | __metrics 10:58:12 ERROR - PROCESS | 1901 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 10:58:12 INFO - PROCESS | 1901 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 10:58:13 INFO - TEST-INFO | 1901: exit 0 10:58:13 INFO - Browser initialized. 10:58:13 INFO - Running cycle 1/1 for dromaeo_css test... 10:58:13 INFO - TEST-INFO | started process 1904 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpNHJCrL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:16 INFO - PROCESS | 1904 | 2017-01-20 10:58:16.140 plugin-container[1905:13795] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 10:58:16 INFO - PROCESS | 1904 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:58:16 INFO - PROCESS | 1904 | 2017-01-20 10:58:16.140 plugin-container[1905:13795] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1f, name = 'com.apple.CFPasteboardClient' 10:58:16 INFO - PROCESS | 1904 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:58:16 INFO - PROCESS | 1904 | 2017-01-20 10:58:16.140 plugin-container[1905:13795] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:58:25 INFO - PROCESS | 1904 | RSS: Main: 232194048 10:58:25 INFO - PROCESS | 1904 | 11:01:27 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:50862/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50862/tests/dromaeo/cssquery-ext.html) 11:01:30 INFO - PROCESS | 1904 | RSS: Main: 261517312 11:01:30 INFO - PROCESS | 1904 | 11:03:13 INFO - PROCESS | 1904 | ************************* 11:03:13 INFO - PROCESS | 1904 | A coding exception was thrown and uncaught in a Task. 11:03:13 INFO - PROCESS | 1904 | 11:03:13 ERROR - PROCESS | 1904 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:03:13 INFO - PROCESS | 1904 | Full stack: 11:03:13 INFO - PROCESS | 1904 | ************************* 11:04:32 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:50862/tests/dromaeo/cssquery-ext.html (next: http://localhost:50862/tests/dromaeo/cssquery-jquery.html) 11:04:33 INFO - PROCESS | 1904 | RSS: Main: 262578176 11:04:33 INFO - PROCESS | 1904 | 11:07:35 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:50862/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50862/tests/dromaeo/cssquery-mootools.html) 11:07:35 INFO - PROCESS | 1904 | RSS: Main: 270245888 11:07:35 INFO - PROCESS | 1904 | 11:10:37 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:50862/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50862/tests/dromaeo/cssquery-prototype.html) 11:10:38 INFO - PROCESS | 1904 | RSS: Main: 266903552 11:10:38 INFO - PROCESS | 1904 | 11:13:41 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:50862/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50862/tests/dromaeo/cssquery-yui.html) 11:13:41 INFO - PROCESS | 1904 | RSS: Main: 271921152 11:13:41 INFO - PROCESS | 1904 | 11:16:44 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:50862/tests/dromaeo/cssquery-yui.html (next: http://localhost:50862/tests/dromaeo/cssquery-dojo.html) 11:16:44 INFO - PROCESS | 1904 | RSS: Main: 274358272 11:16:44 INFO - PROCESS | 1904 | 11:16:44 INFO - PROCESS | 1904 | __start_tp_report 11:16:44 INFO - PROCESS | 1904 | _x_x_mozilla_page_load 11:16:44 INFO - PROCESS | 1904 | _x_x_mozilla_page_load_details 11:16:44 INFO - PROCESS | 1904 | |i|pagename|runs| 11:16:44 INFO - PROCESS | 1904 | |0;dojo.html;3286.0470463565553;3305.7024867761897;3315.4860996545513;3347.895194585787;3360.69753722165;4140.482439695038;4459.219636563596;5205.9219111713355;5406.216098665691;5581.274434323537;5513.8345849624575;5553.444655534445;5572.136318870572;5638.802641907534;5641.2384328115695;4975.502449755032;5127;5128.076946149691;5140.177571588547;5200.427952925175;5054.974725126369;5086.745662716868;5154.175331946889;5164.715940623264;5186.974065129669;4610.907781844361;5187.247849061865;5213;5213.244079608455;5223.843284701465;4422.6240769534625;5010.0981823271795;5025.8240961566535;5030.597552195815;5174.24973378858;5073.1122053640465;5088.898222035538;5124.256982737519;5128.307678463397;5157.974210128963;5329.333833270841;5430.15832545956;5573.219749235111;5628.746706398181;5630.577706671975;6033.004554248544;6065.575409721321;6165.08676973374;6219.253689557282;6245.3442388549;6143.911070236141;6156.507479401637;6168.96915515424;6180.938190618126;6251.781187658456;5811.476967072941;5817.970910145422;5820.592558520948;5831.067029275338;5836.9124463133085;6163.445289923929;6231.3145553989025;6242.063690446378;6242.531810114259;6247.937520624736;5889.469947704727;5915.112733089984;5920.585559010828;5933.317668468095;5944.82165535026;6164.137020817089;6169.043798211284;6195.19462469876;6202.937970620326;6206.255249370104;5981.5214782817275;6046.939530604637;6100.389961003864;6117.785877494266;6161.322254551996;5032.823851165192;5083.237514372874;6118.847028824315;6137.815865524041;6163.229596300463;4805.495422980606;4828.879278018007;4844.854654360375;4868.099401610642;4919.508049195052;4313.352997050405;4346.152500262482;4347.087111706577;4376.037271800199;4394.033312671208;5620.3255609326325;5631.831045068655;5634.661920284796;5659.717014149276;5661.603687741818;6018.15745795589;6113.263474096151;6128.778133445034;6133.662648554283;6158.291796443466;5659.518940890071;5660.066089095253;5673.0923052312255;5697.6296540724725;5717;5351.598630102758;5363.785448582091;5385.219143224211;5391.56867450603;5420.186971954159;6158.353372895871;6169.352218017044;6186.566940314135;6229.314775374796;6271.466925311308;5169.870753231199;6255.31191568918;6270.623762574261;6273.52948528853;6294.527910406646;6218.253809542884;6263.0605409187165;6266.780662676784;6272.717727702356;6282.591631543935;5864.091065884794;5989.550783691154;6024.156618073561;6173.506119510518;6186.257649081959;6111.8777624446375;6117.174181485442;6140.596275277906;6145.877082458415;6287.2140982377205;5937.881242375215;6050.2437195350585;6054.939450605438;6066.757329706762;6084.787032453843;6023.45788879003;6033.5173186145885;6033.849153771191;6036.8188954331445;6064.818055458343;4737.38414006177;5558.166275058774;5652.943470565407;5780;5804.187413762161;5166.715830629351;5851.473367396955;6030.276366836008;6037.396260374103;6067.089936509559;5686.914696279642;5712.285964254468;5713.685747283939;5726.570507211893;5872.911906321494 11:16:44 INFO - PROCESS | 1904 | |1;ext.html;440.72674941536235;449.4830944413924;481.3525807788524;497.4428639923284;561.2479277767791;38347;42449.93875153123;42578.65817380043;42666;42716.71849844506;43119.3532097018;43589.346159807625;43636;43814.12371752563;43841.903952401204;8542.615582298811;8673.219410253076;8948.507832069234;9184.08159184083;11427.657170284863;10732.892671073307;11238.381888996102;11529.250598711056;11550.768984620303;11573.247738896946;11531.423428828524;11548.191626586142;11563;11565.884341156565;11610.013148882355;11499.080073594134;11530.192886497949;11546.884531154665;11548;11574.8263776043;11526.481308341145;11562.364069976147;11605.709857253552;11612.36132012739;11621.883781162165;35155.76954806595;39584.60415395838;40367;41438.79280603608;41972;3486.721062315034;4080.6939479539155;4132.91734165315;4172.3532852407925;4274.1451709658195;31695;31909.52135717966;32154.87457938961;32391;32826.83586582076;3236.255661197914;3314.6519615440516;3352.7485438591957;3386.5258863759095;3391.423458012119;475096;479195;483471;485022;485190;59265.703671481366;59387;59494.10758838621;64226.35773642204;65353.40556269451;70011.64994174996;70409;70516.294837052;70684.64657676782;70709.64645176844;16460.67078658444;16643.33426662944;16716.41492547755;16718.164091795363;16776.328946842234;11470.96761291471;11775.999040081517;12452.377381130907;12594;12654.557090501972;19226.327078552462;19264.80735192658;19276.80723192778;19298.517537061685;19309.710354344697;5742.54059675225;6789.287124851919;6858.897116543256;6904.516683832084;6921.619310937846;793.7656943452871;838.3167718309559;858.9184027517376;915.8076803871262;920.3741455810114;29785.702142978727;31066.68933310683;31091.84454077715;31310.68689313123;31413;1065.5258410007627;1065.658989123473;1096.4079397125463;1115.1357697784283;1137.8407023016784;12672.936635316764;15693.686126277638;15985.36058557668;16234.75647865283;16240.269187886573;550148;559755;561584;561938;565126;63423.0486542693;63735.04397434042;63782.68108659427;63844;64027.679861600394;1436.9154868103158;1451.5137428961416;1459.1901494670346;1476.9926150369179;1484.057623409143;30483.847580761954;30566.388672225985;30852.303123327536;31350.05949821509;31466.213344666565;55213.44786552083;55477;55675.443245567025;55722.16416753671;55726.72136639291;470501;497324.5401319055;518088;522133;522348;41874.58125418707;42273.78863105665;43305.350419743096;43310.78344608257;44173.77913110414;47686.04627907353;48448.5155148444;49086.01827963349;49393.50606494033;49902.25146622731;35955.382007810236;37803.62196378111;39982.2003559933;40073.59926400815;41608.791956040026;39217;39611.405828912015;40590.59409405868;41138.651975244225;41326.586734132274;27847.582286266126;35041.64958350384;35319.29361412809;35397.29205415826;35533.82233088818;30826;32452.35095298128;34431.827840860635;35263.47104793379;35564.466533002545;21416.46458838479;24240.63639045451;24434.63348049745;25395.36511587225;25705.10032148866 11:16:44 INFO - PROCESS | 1904 | |2;jquery.html;333.5780237998932;333.6296710651177;372.554797017564;400.98797036088894;413.3923132994499;19099.42701718949;19570.90214548927;20318.593628127466;20729.896350518244;20942.32461403088;17146.31414743409;20703.585928281424;20993.37019889402;21298.57402851942;21508.892455537738;4826.865686563655;5114;5538.584606154534;5635.746391412386;5873.530117590582;5617.859553511154;5789.421057894198;5793.420657934215;5802.738876750535;5807.767689292423;5531.917021244684;5615.719214039302;5745.6552606843725;5762.82711518653;5803.303603567578;5629.831105066834;5692;5700.800471983461;5706.657600543981;5725.198472213893;4830.565249127595;4938.678985865908;5036.395632524121;5048.242763585455;5065.594752419797;25153.119640812667;25287.60918149501;25290.620640690406;25508.617370739456;25559.744402555923;2573.5882258838496;2624.6535667024696;2644.5372059889633;2653.0979466981125;2691.206094202215;5934.465898069195;5967.940320596782;5999.580029397944;9171.266298696088;10295.94852025735;1799.5231263715125;1826.7807863056519;1846.3537761783402;1874.9437516874516;1875.0905810681809;114043;117240.8275917247;141765;143184;143377.56622433852;11689.473973671205;11880.643580692593;11994.760104797855;12090.637280881587;12157.027437804954;15665.138417387154;15725.370985160695;15742.92128539373;15792.526224213292;15795.447159349367;8483.533405662747;8783.472991620523;8786.12138786129;8918.777030574287;8942.195202431813;7471.813204669818;7851.136374998746;8446;8539.871901921477;8707.608157632922;3968.761874287552;4820.373351464287;4843.636727245471;4861.7326047067045;4971.279164521125;1999.660057790179;2051.3845846246068;2053.8151566359097;2061.237342183402;2061.80412860778;764.8126209078812;857.7812657772229;895.54327293081;919.3151102428733;919.7746552094645;20860.58278834445;22050.007749651304;22078.77921220767;22186.667199992015;22249.888750556143;895.9238464730571;903.2909166304551;910.153557191818;920.6961702638114;925.3707478914268;10920.836187457195;11398.943005285086;11516.366599836922;11517.366544840113;11584.42077896102;598803;686998;688080;702245.4887725528;744303;116892;139258.30370848082;142674;155527;168267.15866420834;1039.4958445154093;1062.7130674717937;1098.1215027977587;1100.5212732461246;1102.2835157147758;18561;18888.905555472134;19789;19929.800701992794;20207.393778186677;51640.74179629078;52760.47239527556;53590;53781;53996.73001635124;75565.62217188878;82483.17516824995;82548;84628.57685711532;87994;6842.486813489108;7972.441929064909;8504.829903402022;8605.82788344217;8723.214910658071;9238.861417078615;12147.574834880737;12156.331401772988;12725.93637031809;13245.337733113498;11181.72045698864;11212.66362009141;11504.769904602028;11594.420278986187;11717.648470545897;10665.733356666145;10840.241183117107;10904.400257985886;11185.217034807485;11394.689610694877;11383.317000979967;11552.42237888119;11627.302361858316;11795.997340226177;11849.111316651459;7005.754798582026;7592.962035189788;7627.122880868549;8497.192766687154;8776.824463510822;8285;10136.290459667753;11108.944455277671;11127.499262533043;11458.885411145782 11:16:44 INFO - PROCESS | 1904 | |3;mootools.html;1427.1223197733398;1459.0589070049818;1460.5545308680848;1475.4319586959025;1486.6432056306487;7544.283293087148;7754.1470438251745;8015.39884508662;8500.659973601048;8520.147985201476;7893.447458677881;8143.389245806573;8172.754817355474;8279.172082791732;8281.75154745357;1970.6255811395788;2281.7376001759762;2331.1258278145697;2332.1604222479896;2333.5449587330477;1914.7702275726863;2279.0541925101147;2317.733460652021;2329.336139200328;2333.7549557296493;1923.6729755941453;2122.936311910645;2288.8855557222155;2296.8736719480507;2313.6645186447954;1890;2291.140822191678;2291.4385975436044;2304.6197377432704;2313.236631911482;2259.3560835162066;2306.7923886850094;2320.1183550250967;2327.697399338092;2336.0188720737333;8318.958405207995;8344.8331033379;8349.332053435772;8396.496210227406;8416.705415310496;5043.646944713872;5190.792368305263;5191.039657663345;5206.531412172884;5222.216667499867;3256.56036435083;3331.4003479373705;3472.5832900052155;3514.9648503514895;3520.3135388599235;1243.2664727810545;1266.006185144657;1693.2972816281228;1737.348494314632;1808.9728654070068;8226.341892648634;10705.625303114432;10776.4611769412;10812.405317707522;10969.506372213189;4566.862994110182;4727.149113159596;4729.479757226771;4759.262314341283;4802.27965805125;8692.739217823475;8714.389992700577;8777.29781617469;8779.341549383822;8784.78038049041;5124.103281925648;5153;5156.123459011977;5158.509941555546;5170.302009228782;4615.930761038587;4753.9762301188275;4808.567228949411;4812.205986012339;4827.879303017382;3820.7898565578603;3831.9616803831605;3930.665893399036;3933.665638420709;3965.7818819965178;1278.6675464379143;1305.477808876438;1307.2287350463273;1311.2329287366806;1312.9212247265195;879.4679219072497;880.5817236812463;881.3257857738835;910.8978136454831;915.6612053540233;5484.698341591171;5709.429057094258;5719.942800571941;5758.62568933018;5763.299826551178;802.3060053054066;962.4898803634085;980.6224603527693;986.2947992185622;1030.8351562734063;3682.429223470366;3733.104055026774;3765.943510847285;3885.417187421909;3886.689064874803;9598.66404675833;9919.7024089276;9949.403035817873;9956.95451977532;9990.250731195189;9799.559019844124;9889.357191782512;9911.256655750847;9913.851292230622;9942.204623630092;7304;7710.7686769397005;7721.575313357819;7753.728619498291;7837.960810195913;5429.077056900415;5433.320834895638;5610.410906854885;5771.595988280948;5826.155207494974;7152.392046676091;8976.371653984419;9180.495072770795;9230.215431688113;9234.353595248269;8343.249107580346;8349.66601335964;9016;9230.215431688383;9294.25645948309;6949.583025018313;7137.928620713727;7165.176004759311;7169.7849064528145;7179.784606461814;6372.808815735535;7633.2366763323225;7750.302472777477;7799.727009554638;7816.06207255133;6712.7245823293415;7099.680514376969;7187.425005999403;7241.782746517613;7316.817079573053;6478.6760661967655;6990.335918087977;7091.60996145217;7155.892661610184;7185.5688658678555;5202.297689811827;6380.489560835029;6397.776077837253;6435;6554.410103090745;3945.5659877412886;4275.807588658456;4979.452260251442;5046.394432667957;5064.139096353555;4154.356074808409;4893.853184404474;4978.4025916890205;5109.948900511096;5141.742912854267 11:16:44 INFO - PROCESS | 1904 | |4;prototype.html;340.4892661008489;353.4203905594824;355.78652808314996;363.0397598352358;368.1036675694682;5217.426083130853;5250.193609633024;5424.701641409726;5584.296789479207;5599.7480113394895;4676.789544470498;5097.209932460465;5355.036093503168;5384.523119365087;5402.162664786954;3133.8433078345993;4102.830693252424;4279.293916503789;4309.827606895736;4317.589828966243;3546.85812567497;4176.283108033852;4216.409702641633;4286.271333873249;4303.978480107595;3890.7665540067687;4198.8320467181275;4201.1807697499;4204.789760511978;4213.304804707235;4206.369044643328;4214.810333534983;4246.938265433641;4252.723572967762;4276.2089013532595;3438.432658611326;3787.394016957274;3788.7916164610933;3798.3542797724454;3802.6690658269663;4931.580815630676;5275.419703832576;5303.363596368422;5360.115580929142;5360.303160589137;4098.938515922234;4177.548299469191;4718.4809670936165;4734.976325118352;4768.3085952536685;5766.875459285441;5774.873899589582;5802.373516552155;5807.245058142456;5813.82558523245;3660.981695091534;3892.299386110499;3911.9804400978096;3917.0794863207407;3930.9951924518414;5211.635185537014;5799.594028418012;6046.516278697738;6094.12470023979;6119.112728654365;3946.2304850553865;3963.603639636013;3972.6027397260623;3986.149902819498;3988.7606743594897;3749.887503374903;3956.3867600521967;4006.859759908389;4046.754051501386;4047.3119569673227;4405.449318835145;4605.930911036337;4701.341812146302;4732.266498692708;4765.356676848581;5832.375431056042;5839.868448016444;5850.0932355484965;5877.324107727581;5890.882182356415;1266.4991984498215;1298.8246586710861;1314.566193156256;1317.703516708752;1323.556608536151;752.3567349915853;830.7994947301213;852.1776485691338;866.8266346730679;897.1790811407619;4305.97847010763;4310.590493903074;4510.594046535827;5142.280080788692;5157.4584668610005;5674.546036317085;5695.601307908407;5727.627704199297;5744.454276843693;5749.913751293734;3940.763554186758;4296.720713153635;4679.695819771704;5258.211268309784;5274.549498887836;2589.067935543203;2860.7854410919263;2989.6546554050765;3048.329367539138;3049.6950304969328;5538.252335934678;5774.48029677331;5918.822435326947;5952.464278214895;5967.343592204854;5245.324884308953;5605.271314729059;5881.823545293648;5896.528277737856;5911.704414779244;5049.999999999926;5294.100002999577;5566.638168519034;5885.205497257901;5955.37468565803;5080.614548578518;5095.439501654889;5239.327942749302;5615.5507559395965;5752.424757524214;4802.903941921072;5252.557560734277;5513.373554801263;5837.620554663933;5945.375735547878;5215.5827533797965;5330.9733451332495;5891.970540147272;6071.848203794941;6182.814515564541;3314.1051915982066;3886.113886113886;4066.369712694537;4296.677749168763;4298.3337582673485;5181.983962429147;5690.573207009574;5763.4524720153195;5905.822825315247;5925.614835035709;4879;5058.494150584912;5731.850556041484;5739.397363276796;5817.138515674943;4695.22528782747;4720.575148236675;4798.145103663314;4890.486498917562;5245.475452454724;4493.528179541232;4729.834455794031;5634.408387119293;5643.88712225745;5673;5347.786088556414;5502.559795216293;5737.512311453574;5798.507126894261;5900.7049647518315;4420.425344705168;5296.36796444672;5312.654677445954;5375.709829640936;5625.549956003428 11:16:44 INFO - PROCESS | 1904 | |5;yui.html;724.6847621284738;772.6136931534232;806.4999700185883;807.5760225881415;815.1400272712286;15642.530724078282;15808.604784880385;15920.124393158372;15995.120268385233;16030.038197708116;12257.325847078408;14538.927305363484;14813.92593037036;14816.111033338007;14820.333085011174;694.6110178300169;707.998182571663;851.2891735400948;859.4671303791658;878.3280790195505;873.5937788928147;883.0551310098198;884.0938038510513;884.5267781736773;889.208604342136;929.9767505812375;939.5584075484545;940.8353538130834;945.973618623794;951.3388195204301;727.8580676768032;883.575883575884;903.8508646073456;941.7363138321247;942.7784470649392;667.1194023888469;702.4906942466722;705.8059033765704;708.578395854471;709.574255446733;14986.325615347336;15330.846691533165;15373.461928832437;15759.763603545956;15917.442889498812;14494.492692755703;14743.77884331736;14760.704785904329;14831.703365932728;14839.554813355617;11796.469158887785;11850.585229517012;11902.702432439171;11944.820827687592;12410.81383779244;3760.0599850037493;3764.661180493769;3851.6340947609933;3898.1034362096875;3904.609539046101;102546.97453025449;104456.95543044624;104999.47500262526;105167;106185.46907265569;11077.612283570037;11268.887311126784;11384.316940983568;11453.370064646524;11483.885161148282;23761;23944.88027559851;23961.640575391382;24053.759462405153;24077.63883541748;7830.804229894298;7881.054273487218;7885.921140788633;7898.368130549542;8040.758777236692;4281.486221653421;4286.542575524337;4296.871093867189;4300.3549467580115;4350.086481838786;3597.4603809428795;3685.981570092132;3761.2665530221893;3951.5258169019326;3979.343408337592;650.6584043377264;692.9272426395257;710.8471678589128;713.5255055388212;724.8586525627452;627.7583130494793;683.0300972618893;684.4695361095091;695.3046953046852;726.1830440754152;9959.601615935282;10296.297033051158;10326.277160598836;10488.370697758159;10781.08360789326;677.9084823548758;713.728783062433;722.407625746893;725.6589402980591;739.3161325773746;4749.857504274877;5138.332016837787;5146.228065790161;5147.356580427447;5150.175971844487;106604;106803;108642.28294618079;110709.44645276722;112292.43853780678;80344;96359.0364096364;97449.0255097454;98196;98404.50797745965;83564;84312.73530897041;84819.57590212133;84952;86900.56549717211;10682.32941764559;10682.89317106819;10983.670489885317;11036.724081898017;11175;37546.55574941673;49708.50291497183;50080.499195007586;51837.740811295705;53476;65476;67611;68093.659531704;68841.65579172272;70223.29776702372;12922.935385323013;13016.934915325362;13409.32953352348;13466;13505.527306544223;11134.498947547218;12638.873611264138;12648.466141229164;13497.460101595827;15100;13545.932270338586;13630.386632601754;13692.589222323346;13720.382582784;13740.587782366545;13717.794233086312;13840;13947.29415958285;13949.442022318994;13981.860181398055;13185.60443186706;13229.47082116743;13675;13828.516001939885;13994.962767199304;11066.39134847591;11075.280106793032;11415.486303116213;11801.527938882691;11874.82187767167;9068.727938161866;10108.444035577819;10964.28732132409;11073.778524429628;11143.498542565441 11:16:44 INFO - PROCESS | 1904 | __end_tp_report 11:16:44 INFO - PROCESS | 1904 | __start_cc_report 11:16:44 INFO - PROCESS | 1904 | _x_x_mozilla_cycle_collect,389 11:16:44 INFO - PROCESS | 1904 | __end_cc_report 11:16:44 INFO - PROCESS | 1904 | __startTimestamp1484939804882__endTimestamp 11:16:44 INFO - PROCESS | 1904 | 11:16:44 INFO - PROCESS | 1904 | ------- Summary: start ------- 11:16:44 INFO - PROCESS | 1904 | Number of tests: 6 11:16:44 INFO - PROCESS | 1904 | 11:16:44 INFO - PROCESS | 1904 | [#0] dojo.html Cycles:165 Average:5604.33 Median:5804.19 stddev:663.50 (11.4%) stddev-sans-first:640.13 11:16:44 INFO - PROCESS | 1904 | Values: 3286.0 3305.7 3315.5 3347.9 3360.7 4140.5 4459.2 5205.9 5406.2 5581.3 5513.8 5553.4 5572.1 5638.8 5641.2 4975.5 5127.0 5128.1 5140.2 5200.4 5055.0 5086.7 5154.2 5164.7 5187.0 4610.9 5187.2 5213.0 5213.2 5223.8 4422.6 5010.1 5025.8 5030.6 5174.2 5073.1 5088.9 5124.3 5128.3 5158.0 5329.3 5430.2 5573.2 5628.7 5630.6 6033.0 6065.6 6165.1 6219.3 6245.3 6143.9 6156.5 6169.0 6180.9 6251.8 5811.5 5818.0 5820.6 5831.1 5836.9 6163.4 6231.3 6242.1 6242.5 6247.9 5889.5 5915.1 5920.6 5933.3 5944.8 6164.1 6169.0 6195.2 6202.9 6206.3 5981.5 6046.9 6100.4 6117.8 6161.3 5032.8 5083.2 6118.8 6137.8 6163.2 4805.5 4828.9 4844.9 4868.1 4919.5 4313.4 4346.2 4347.1 4376.0 4394.0 5620.3 5631.8 5634.7 5659.7 5661.6 6018.2 6113.3 6128.8 6133.7 6158.3 5659.5 5660.1 5673.1 5697.6 5717.0 5351.6 5363.8 5385.2 5391.6 5420.2 6158.4 6169.4 6186.6 6229.3 6271.5 5169.9 6255.3 6270.6 6273.5 6294.5 6218.3 6263.1 6266.8 6272.7 6282.6 5864.1 5989.6 6024.2 6173.5 6186.3 6111.9 6117.2 6140.6 6145.9 6287.2 5937.9 6050.2 6054.9 6066.8 6084.8 6023.5 6033.5 6033.8 6036.8 6064.8 4737.4 5558.2 5652.9 5780.0 5804.2 5166.7 5851.5 6030.3 6037.4 6067.1 5686.9 5712.3 5713.7 5726.6 5872.9 11:16:44 INFO - PROCESS | 1904 | 11:16:44 INFO - PROCESS | 1904 | [#1] ext.html Cycles:180 Average:67159.91 Median:38782.00 stddev:137363.65 (354.2%) stddev-sans-first:137657.65 11:16:44 INFO - PROCESS | 1904 | Values: 440.7 449.5 481.4 497.4 561.2 38347.0 42449.9 42578.7 42666.0 42716.7 43119.4 43589.3 43636.0 43814.1 43841.9 8542.6 8673.2 8948.5 9184.1 11427.7 10732.9 11238.4 11529.3 11550.8 11573.2 11531.4 11548.2 11563.0 11565.9 11610.0 11499.1 11530.2 11546.9 11548.0 11574.8 11526.5 11562.4 11605.7 11612.4 11621.9 35155.8 39584.6 40367.0 41438.8 41972.0 3486.7 4080.7 4132.9 4172.4 4274.1 31695.0 31909.5 32154.9 32391.0 32826.8 3236.3 3314.7 3352.7 3386.5 3391.4 475096.0 479195.0 483471.0 485022.0 485190.0 59265.7 59387.0 59494.1 64226.4 65353.4 70011.6 70409.0 70516.3 70684.6 70709.6 16460.7 16643.3 16716.4 16718.2 16776.3 11471.0 11776.0 12452.4 12594.0 12654.6 19226.3 19264.8 19276.8 19298.5 19309.7 5742.5 6789.3 6858.9 6904.5 6921.6 793.8 838.3 858.9 915.8 920.4 29785.7 31066.7 31091.8 31310.7 31413.0 1065.5 1065.7 1096.4 1115.1 1137.8 12672.9 15693.7 15985.4 16234.8 16240.3 550148.0 559755.0 561584.0 561938.0 565126.0 63423.0 63735.0 63782.7 63844.0 64027.7 1436.9 1451.5 1459.2 1477.0 1484.1 30483.8 30566.4 30852.3 31350.1 31466.2 55213.4 55477.0 55675.4 55722.2 55726.7 470501.0 497324.5 518088.0 522133.0 522348.0 41874.6 42273.8 43305.4 43310.8 44173.8 47686.0 48448.5 49086.0 49393.5 49902.3 35955.4 37803.6 39982.2 40073.6 41608.8 39217.0 39611.4 40590.6 41138.7 41326.6 27847.6 35041.6 35319.3 35397.3 35533.8 30826.0 32452.4 34431.8 35263.5 35564.5 21416.5 24240.6 24434.6 25395.4 25705.1 11:16:44 INFO - PROCESS | 1904 | 11:16:44 INFO - PROCESS | 1904 | [#2] jquery.html Cycles:180 Average:38374.60 Median:2634.60 stddev:114537.96 (4347.5%) stddev-sans-first:114823.65 11:16:44 INFO - PROCESS | 1904 | Values: 333.6 333.6 372.6 401.0 413.4 19099.4 19570.9 20318.6 20729.9 20942.3 17146.3 20703.6 20993.4 21298.6 21508.9 4826.9 5114.0 5538.6 5635.7 5873.5 5617.9 5789.4 5793.4 5802.7 5807.8 5531.9 5615.7 5745.7 5762.8 5803.3 5629.8 5692.0 5700.8 5706.7 5725.2 4830.6 4938.7 5036.4 5048.2 5065.6 25153.1 25287.6 25290.6 25508.6 25559.7 2573.6 2624.7 2644.5 2653.1 2691.2 5934.5 5967.9 5999.6 9171.3 10295.9 1799.5 1826.8 1846.4 1874.9 1875.1 114043.0 117240.8 141765.0 143184.0 143377.6 11689.5 11880.6 11994.8 12090.6 12157.0 15665.1 15725.4 15742.9 15792.5 15795.4 8483.5 8783.5 8786.1 8918.8 8942.2 7471.8 7851.1 8446.0 8539.9 8707.6 3968.8 4820.4 4843.6 4861.7 4971.3 1999.7 2051.4 2053.8 2061.2 2061.8 764.8 857.8 895.5 919.3 919.8 20860.6 22050.0 22078.8 22186.7 22249.9 895.9 903.3 910.2 920.7 925.4 10920.8 11398.9 11516.4 11517.4 11584.4 598803.0 686998.0 688080.0 702245.5 744303.0 116892.0 139258.3 142674.0 155527.0 168267.2 1039.5 1062.7 1098.1 1100.5 1102.3 18561.0 18888.9 19789.0 19929.8 20207.4 51640.7 52760.5 53590.0 53781.0 53996.7 75565.6 82483.2 82548.0 84628.6 87994.0 6842.5 7972.4 8504.8 8605.8 8723.2 9238.9 12147.6 12156.3 12725.9 13245.3 11181.7 11212.7 11504.8 11594.4 11717.6 10665.7 10840.2 10904.4 11185.2 11394.7 11383.3 11552.4 11627.3 11796.0 11849.1 7005.8 7593.0 7627.1 8497.2 8776.8 8285.0 10136.3 11108.9 11127.5 11458.9 11:16:44 INFO - PROCESS | 1904 | 11:16:44 INFO - PROCESS | 1904 | [#3] mootools.html Cycles:180 Average:5351.36 Median:5325.65 stddev:2854.64 (53.6%) stddev-sans-first:2847.41 11:16:44 INFO - PROCESS | 1904 | Values: 1427.1 1459.1 1460.6 1475.4 1486.6 7544.3 7754.1 8015.4 8500.7 8520.1 7893.4 8143.4 8172.8 8279.2 8281.8 1970.6 2281.7 2331.1 2332.2 2333.5 1914.8 2279.1 2317.7 2329.3 2333.8 1923.7 2122.9 2288.9 2296.9 2313.7 1890.0 2291.1 2291.4 2304.6 2313.2 2259.4 2306.8 2320.1 2327.7 2336.0 8319.0 8344.8 8349.3 8396.5 8416.7 5043.6 5190.8 5191.0 5206.5 5222.2 3256.6 3331.4 3472.6 3515.0 3520.3 1243.3 1266.0 1693.3 1737.3 1809.0 8226.3 10705.6 10776.5 10812.4 10969.5 4566.9 4727.1 4729.5 4759.3 4802.3 8692.7 8714.4 8777.3 8779.3 8784.8 5124.1 5153.0 5156.1 5158.5 5170.3 4615.9 4754.0 4808.6 4812.2 4827.9 3820.8 3832.0 3930.7 3933.7 3965.8 1278.7 1305.5 1307.2 1311.2 1312.9 879.5 880.6 881.3 910.9 915.7 5484.7 5709.4 5719.9 5758.6 5763.3 802.3 962.5 980.6 986.3 1030.8 3682.4 3733.1 3765.9 3885.4 3886.7 9598.7 9919.7 9949.4 9957.0 9990.3 9799.6 9889.4 9911.3 9913.9 9942.2 7304.0 7710.8 7721.6 7753.7 7838.0 5429.1 5433.3 5610.4 5771.6 5826.2 7152.4 8976.4 9180.5 9230.2 9234.4 8343.2 8349.7 9016.0 9230.2 9294.3 6949.6 7137.9 7165.2 7169.8 7179.8 6372.8 7633.2 7750.3 7799.7 7816.1 6712.7 7099.7 7187.4 7241.8 7316.8 6478.7 6990.3 7091.6 7155.9 7185.6 5202.3 6380.5 6397.8 6435.0 6554.4 3945.6 4275.8 4979.5 5046.4 5064.1 4154.4 4893.9 4978.4 5109.9 5141.7 11:16:44 INFO - PROCESS | 1904 | 11:16:44 INFO - PROCESS | 1904 | [#4] prototype.html Cycles:180 Average:4576.71 Median:5096.32 stddev:1391.72 (27.3%) stddev-sans-first:1358.82 11:16:44 INFO - PROCESS | 1904 | Values: 340.5 353.4 355.8 363.0 368.1 5217.4 5250.2 5424.7 5584.3 5599.7 4676.8 5097.2 5355.0 5384.5 5402.2 3133.8 4102.8 4279.3 4309.8 4317.6 3546.9 4176.3 4216.4 4286.3 4304.0 3890.8 4198.8 4201.2 4204.8 4213.3 4206.4 4214.8 4246.9 4252.7 4276.2 3438.4 3787.4 3788.8 3798.4 3802.7 4931.6 5275.4 5303.4 5360.1 5360.3 4098.9 4177.5 4718.5 4735.0 4768.3 5766.9 5774.9 5802.4 5807.2 5813.8 3661.0 3892.3 3912.0 3917.1 3931.0 5211.6 5799.6 6046.5 6094.1 6119.1 3946.2 3963.6 3972.6 3986.1 3988.8 3749.9 3956.4 4006.9 4046.8 4047.3 4405.4 4605.9 4701.3 4732.3 4765.4 5832.4 5839.9 5850.1 5877.3 5890.9 1266.5 1298.8 1314.6 1317.7 1323.6 752.4 830.8 852.2 866.8 897.2 4306.0 4310.6 4510.6 5142.3 5157.5 5674.5 5695.6 5727.6 5744.5 5749.9 3940.8 4296.7 4679.7 5258.2 5274.5 2589.1 2860.8 2989.7 3048.3 3049.7 5538.3 5774.5 5918.8 5952.5 5967.3 5245.3 5605.3 5881.8 5896.5 5911.7 5050.0 5294.1 5566.6 5885.2 5955.4 5080.6 5095.4 5239.3 5615.6 5752.4 4802.9 5252.6 5513.4 5837.6 5945.4 5215.6 5331.0 5892.0 6071.8 6182.8 3314.1 3886.1 4066.4 4296.7 4298.3 5182.0 5690.6 5763.5 5905.8 5925.6 4879.0 5058.5 5731.9 5739.4 5817.1 4695.2 4720.6 4798.1 4890.5 5245.5 4493.5 4729.8 5634.4 5643.9 5673.0 5347.8 5502.6 5737.5 5798.5 5900.7 4420.4 5296.4 5312.7 5375.7 5625.5 11:16:44 INFO - PROCESS | 1904 | 11:16:44 INFO - PROCESS | 1904 | [#5] yui.html Cycles:180 Average:21098.01 Median:20653.31 stddev:30473.19 (147.5%) stddev-sans-first:30520.28 11:16:44 INFO - PROCESS | 1904 | Values: 724.7 772.6 806.5 807.6 815.1 15642.5 15808.6 15920.1 15995.1 16030.0 12257.3 14538.9 14813.9 14816.1 14820.3 694.6 708.0 851.3 859.5 878.3 873.6 883.1 884.1 884.5 889.2 930.0 939.6 940.8 946.0 951.3 727.9 883.6 903.9 941.7 942.8 667.1 702.5 705.8 708.6 709.6 14986.3 15330.8 15373.5 15759.8 15917.4 14494.5 14743.8 14760.7 14831.7 14839.6 11796.5 11850.6 11902.7 11944.8 12410.8 3760.1 3764.7 3851.6 3898.1 3904.6 102547.0 104457.0 104999.5 105167.0 106185.5 11077.6 11268.9 11384.3 11453.4 11483.9 23761.0 23944.9 23961.6 24053.8 24077.6 7830.8 7881.1 7885.9 7898.4 8040.8 4281.5 4286.5 4296.9 4300.4 4350.1 3597.5 3686.0 3761.3 3951.5 3979.3 650.7 692.9 710.8 713.5 724.9 627.8 683.0 684.5 695.3 726.2 9959.6 10296.3 10326.3 10488.4 10781.1 677.9 713.7 722.4 725.7 739.3 4749.9 5138.3 5146.2 5147.4 5150.2 106604.0 106803.0 108642.3 110709.4 112292.4 80344.0 96359.0 97449.0 98196.0 98404.5 83564.0 84312.7 84819.6 84952.0 86900.6 10682.3 10682.9 10983.7 11036.7 11175.0 37546.6 49708.5 50080.5 51837.7 53476.0 65476.0 67611.0 68093.7 68841.7 70223.3 12922.9 13016.9 13409.3 13466.0 13505.5 11134.5 12638.9 12648.5 13497.5 15100.0 13545.9 13630.4 13692.6 13720.4 13740.6 13717.8 13840.0 13947.3 13949.4 13981.9 13185.6 13229.5 13675.0 13828.5 13995.0 11066.4 11075.3 11415.5 11801.5 11874.8 9068.7 10108.4 10964.3 11073.8 11143.5 11:16:44 INFO - PROCESS | 1904 | -------- Summary: end -------- 11:16:44 INFO - PROCESS | 1904 | 11:16:45 INFO - TEST-INFO | 1904: exit 0 11:16:45 INFO - TEST-OK | dromaeo_css | took 1115831ms 11:16:45 INFO - TEST-START | kraken 11:16:45 INFO - operating with platform_type : mac_ 11:16:45 INFO - Initialising browser for kraken test... 11:16:45 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpW82wxA/profile http://localhost:50862/getInfo.html) 11:16:48 INFO - PROCESS | 1911 | 2017-01-20 11:16:48.312 plugin-container[1912:15813] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 11:16:48 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:16:48 INFO - PROCESS | 1911 | 2017-01-20 11:16:48.315 plugin-container[1912:15813] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 11:16:48 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:16:48 INFO - PROCESS | 1911 | 2017-01-20 11:16:48.315 plugin-container[1912:15813] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:16:48 INFO - PROCESS | 1911 | __metrics Screen width/height:1600/1200 11:16:48 INFO - PROCESS | 1911 | colorDepth:24 11:16:48 INFO - PROCESS | 1911 | Browser inner width/height: 1024/689 11:16:48 INFO - PROCESS | 1911 | __metrics 11:16:48 ERROR - PROCESS | 1911 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 11:16:48 INFO - PROCESS | 1911 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 11:16:49 INFO - TEST-INFO | 1911: exit 0 11:16:49 INFO - Browser initialized. 11:16:49 INFO - Running cycle 1/1 for kraken test... 11:16:49 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpW82wxA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:51 INFO - PROCESS | 1913 | 2017-01-20 11:16:51.612 plugin-container[1914:15932] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 11:16:51 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:16:51 INFO - PROCESS | 1913 | 2017-01-20 11:16:51.613 plugin-container[1914:15932] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 11:16:51 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:16:51 INFO - PROCESS | 1913 | 2017-01-20 11:16:51.613 plugin-container[1914:15932] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:17:01 INFO - PROCESS | 1913 | RSS: Main: 232144896 11:17:01 INFO - PROCESS | 1913 | 11:17:04 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50862/tests/kraken/driver.html?testName=audio-beat-detection) 11:17:05 INFO - PROCESS | 1913 | RSS: Main: 246091776 11:17:05 INFO - PROCESS | 1913 | 11:17:08 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50862/tests/kraken/driver.html?testName=audio-dft) 11:17:08 INFO - PROCESS | 1913 | RSS: Main: 254058496 11:17:08 INFO - PROCESS | 1913 | 11:17:12 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50862/tests/kraken/driver.html?testName=audio-fft) 11:17:12 INFO - PROCESS | 1913 | RSS: Main: 256753664 11:17:12 INFO - PROCESS | 1913 | 11:17:14 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50862/tests/kraken/driver.html?testName=audio-oscillator) 11:17:15 INFO - PROCESS | 1913 | RSS: Main: 257912832 11:17:15 INFO - PROCESS | 1913 | 11:17:17 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50862/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:17:17 INFO - PROCESS | 1913 | RSS: Main: 258138112 11:17:17 INFO - PROCESS | 1913 | 11:17:20 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50862/tests/kraken/driver.html?testName=imaging-darkroom) 11:17:21 INFO - PROCESS | 1913 | RSS: Main: 265039872 11:17:21 INFO - PROCESS | 1913 | 11:17:24 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50862/tests/kraken/driver.html?testName=imaging-desaturate) 11:17:25 INFO - PROCESS | 1913 | RSS: Main: 264343552 11:17:25 INFO - PROCESS | 1913 | 11:17:27 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50862/tests/kraken/driver.html?testName=json-parse-financial) 11:17:28 INFO - PROCESS | 1913 | RSS: Main: 264261632 11:17:28 INFO - PROCESS | 1913 | 11:17:30 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50862/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:17:31 INFO - PROCESS | 1913 | RSS: Main: 263655424 11:17:31 INFO - PROCESS | 1913 | 11:17:32 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50862/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:17:33 INFO - PROCESS | 1913 | RSS: Main: 263663616 11:17:33 INFO - PROCESS | 1913 | 11:17:35 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50862/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:17:36 INFO - PROCESS | 1913 | RSS: Main: 263704576 11:17:36 INFO - PROCESS | 1913 | 11:17:39 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:17:40 INFO - PROCESS | 1913 | RSS: Main: 264036352 11:17:40 INFO - PROCESS | 1913 | 11:17:43 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:44 INFO - PROCESS | 1913 | RSS: Main: 263856128 11:17:44 INFO - PROCESS | 1913 | 11:17:45 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:50862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50862/tests/kraken/driver.html?testName=ai-astar) 11:17:46 INFO - PROCESS | 1913 | RSS: Main: 265887744 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | __start_tp_report 11:17:46 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 11:17:46 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 11:17:46 INFO - PROCESS | 1913 | |i|pagename|runs| 11:17:46 INFO - PROCESS | 1913 | |0;ai-astar;155;172;115;119;129;176;157;118;117;119 11:17:46 INFO - PROCESS | 1913 | |1;audio-beat-detection;145;115;113;151;112;116;130;116;132;113 11:17:46 INFO - PROCESS | 1913 | |2;audio-dft;203;220;196;200;199;196;197;196;192;196 11:17:46 INFO - PROCESS | 1913 | |3;audio-fft;83;59;60;85;59;61;59;61;74;80 11:17:46 INFO - PROCESS | 1913 | |4;audio-oscillator;86;76;95;72;70;71;80;69;70;82 11:17:46 INFO - PROCESS | 1913 | |5;imaging-gaussian-blur;90;91;88;88;89;91;90;94;90;88 11:17:46 INFO - PROCESS | 1913 | |6;imaging-darkroom;105;175;161;98;115;126;107;99;173;145 11:17:46 INFO - PROCESS | 1913 | |7;imaging-desaturate;92;95;91;93;92;91;90;93;93;92 11:17:46 INFO - PROCESS | 1913 | |8;json-parse-financial;60;61;61;61;67;96;97;97;100;89 11:17:46 INFO - PROCESS | 1913 | |9;json-stringify-tinderbox;87;70;77;79;80;70;71;71;73;63 11:17:46 INFO - PROCESS | 1913 | |10;stanford-crypto-aes;87;86;82;83;84;76;108;111;111;82 11:17:46 INFO - PROCESS | 1913 | |11;stanford-crypto-ccm;149;166;139;141;167;158;165;162;204;166 11:17:46 INFO - PROCESS | 1913 | |12;stanford-crypto-pbkdf2;179;181;180;202;247;179;180;168;212;169 11:17:46 INFO - PROCESS | 1913 | |13;stanford-crypto-sha256-iterative;63;83;96;83;71;66;77;71;68;91 11:17:46 INFO - PROCESS | 1913 | __end_tp_report 11:17:46 INFO - PROCESS | 1913 | __start_cc_report 11:17:46 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,922 11:17:46 INFO - PROCESS | 1913 | __end_cc_report 11:17:46 INFO - PROCESS | 1913 | __startTimestamp1484939866157__endTimestamp 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | ------- Summary: start ------- 11:17:46 INFO - PROCESS | 1913 | Number of tests: 14 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#0] ai-astar Cycles:10 Average:137.70 Median:142.00 stddev:24.54 (17.3%) stddev-sans-first:25.22 11:17:46 INFO - PROCESS | 1913 | Values: 155.0 172.0 115.0 119.0 129.0 176.0 157.0 118.0 117.0 119.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:123.00 stddev:14.39 (11.7%) stddev-sans-first:13.17 11:17:46 INFO - PROCESS | 1913 | Values: 145.0 115.0 113.0 151.0 112.0 116.0 130.0 116.0 132.0 113.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#2] audio-dft Cycles:10 Average:199.50 Median:198.00 stddev:7.78 (3.9%) stddev-sans-first:8.15 11:17:46 INFO - PROCESS | 1913 | Values: 203.0 220.0 196.0 200.0 199.0 196.0 197.0 196.0 192.0 196.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#3] audio-fft Cycles:10 Average:68.10 Median:67.50 stddev:11.05 (16.4%) stddev-sans-first:10.32 11:17:46 INFO - PROCESS | 1913 | Values: 83.0 59.0 60.0 85.0 59.0 61.0 59.0 61.0 74.0 80.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.00 stddev:8.58 (11.0%) stddev-sans-first:8.48 11:17:46 INFO - PROCESS | 1913 | Values: 86.0 76.0 95.0 72.0 70.0 71.0 80.0 69.0 70.0 82.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:90.00 stddev:1.85 (2.1%) stddev-sans-first:1.96 11:17:46 INFO - PROCESS | 1913 | Values: 90.0 91.0 88.0 88.0 89.0 91.0 90.0 94.0 90.0 88.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#6] imaging-darkroom Cycles:10 Average:130.40 Median:167.00 stddev:30.62 (18.3%) stddev-sans-first:31.07 11:17:46 INFO - PROCESS | 1913 | Values: 105.0 175.0 161.0 98.0 115.0 126.0 107.0 99.0 173.0 145.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:92.50 stddev:1.40 (1.5%) stddev-sans-first:1.48 11:17:46 INFO - PROCESS | 1913 | Values: 92.0 95.0 91.0 93.0 92.0 91.0 90.0 93.0 93.0 92.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#8] json-parse-financial Cycles:10 Average:78.90 Median:78.00 stddev:18.12 (23.2%) stddev-sans-first:17.88 11:17:46 INFO - PROCESS | 1913 | Values: 60.0 61.0 61.0 61.0 67.0 96.0 97.0 97.0 100.0 89.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#9] json-stringify-tinderbox Cycles:10 Average:74.10 Median:75.00 stddev:6.76 (9.0%) stddev-sans-first:5.32 11:17:46 INFO - PROCESS | 1913 | Values: 87.0 70.0 77.0 79.0 80.0 70.0 71.0 71.0 73.0 63.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:82.50 stddev:13.46 (16.3%) stddev-sans-first:14.20 11:17:46 INFO - PROCESS | 1913 | Values: 87.0 86.0 82.0 83.0 84.0 76.0 108.0 111.0 111.0 82.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#11] stanford-crypto-ccm Cycles:10 Average:161.70 Median:165.50 stddev:18.21 (11.0%) stddev-sans-first:18.72 11:17:46 INFO - PROCESS | 1913 | Values: 149.0 166.0 139.0 141.0 167.0 158.0 165.0 162.0 204.0 166.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.70 Median:180.50 stddev:24.32 (13.5%) stddev-sans-first:25.49 11:17:46 INFO - PROCESS | 1913 | Values: 179.0 181.0 180.0 202.0 247.0 179.0 180.0 168.0 212.0 169.0 11:17:46 INFO - PROCESS | 1913 | 11:17:46 INFO - PROCESS | 1913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.90 Median:80.00 stddev:11.05 (13.8%) stddev-sans-first:10.51 11:17:46 INFO - PROCESS | 1913 | Values: 63.0 83.0 96.0 83.0 71.0 66.0 77.0 71.0 68.0 91.0 11:17:46 INFO - PROCESS | 1913 | -------- Summary: end -------- 11:17:46 INFO - PROCESS | 1913 | 11:17:47 INFO - TEST-INFO | 1913: exit 0 11:17:47 INFO - TEST-OK | kraken | took 61536ms 11:17:47 INFO - SUITE-END | took 1177s 11:17:47 INFO - Completed test suite (00:19:37) 11:17:47 INFO - javascript benchmark 11:17:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7337.413110462494, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3286.0470463565553, 3305.7024867761897, 3315.4860996545513, 3347.895194585787, 3360.69753722165, 4140.482439695038, 4459.219636563596, 5205.9219111713355, 5406.216098665691, 5581.274434323537, 5513.8345849624575, 5553.444655534445, 5572.136318870572, 5638.802641907534, 5641.2384328115695, 4975.502449755032, 5127.0, 5128.076946149691, 5140.177571588547, 5200.427952925175, 5054.974725126369, 5086.745662716868, 5154.175331946889, 5164.715940623264, 5186.974065129669, 4610.907781844361, 5187.247849061865, 5213.0, 5213.244079608455, 5223.843284701465, 4422.6240769534625, 5010.0981823271795, 5025.8240961566535, 5030.597552195815, 5174.24973378858, 5073.1122053640465, 5088.898222035538, 5124.256982737519, 5128.307678463397, 5157.974210128963, 5329.333833270841, 5430.15832545956, 5573.219749235111, 5628.746706398181, 5630.577706671975, 6033.004554248544, 6065.575409721321, 6165.08676973374, 6219.253689557282, 6245.3442388549, 6143.911070236141, 6156.507479401637, 6168.96915515424, 6180.938190618126, 6251.781187658456, 5811.476967072941, 5817.970910145422, 5820.592558520948, 5831.067029275338, 5836.9124463133085, 6163.445289923929, 6231.3145553989025, 6242.063690446378, 6242.531810114259, 6247.937520624736, 5889.469947704727, 5915.112733089984, 5920.585559010828, 5933.317668468095, 5944.82165535026, 6164.137020817089, 6169.043798211284, 6195.19462469876, 6202.937970620326, 6206.255249370104, 5981.5214782817275, 6046.939530604637, 6100.389961003864, 6117.785877494266, 6161.322254551996, 5032.823851165192, 5083.237514372874, 6118.847028824315, 6137.815865524041, 6163.229596300463, 4805.495422980606, 4828.879278018007, 4844.854654360375, 4868.099401610642, 4919.508049195052, 4313.352997050405, 4346.152500262482, 4347.087111706577, 4376.037271800199, 4394.033312671208, 5620.3255609326325, 5631.831045068655, 5634.661920284796, 5659.717014149276, 5661.603687741818, 6018.15745795589, 6113.263474096151, 6128.778133445034, 6133.662648554283, 6158.291796443466, 5659.518940890071, 5660.066089095253, 5673.0923052312255, 5697.6296540724725, 5717.0, 5351.598630102758, 5363.785448582091, 5385.219143224211, 5391.56867450603, 5420.186971954159, 6158.353372895871, 6169.352218017044, 6186.566940314135, 6229.314775374796, 6271.466925311308, 5169.870753231199, 6255.31191568918, 6270.623762574261, 6273.52948528853, 6294.527910406646, 6218.253809542884, 6263.0605409187165, 6266.780662676784, 6272.717727702356, 6282.591631543935, 5864.091065884794, 5989.550783691154, 6024.156618073561, 6173.506119510518, 6186.257649081959, 6111.8777624446375, 6117.174181485442, 6140.596275277906, 6145.877082458415, 6287.2140982377205, 5937.881242375215, 6050.2437195350585, 6054.939450605438, 6066.757329706762, 6084.787032453843, 6023.45788879003, 6033.5173186145885, 6033.849153771191, 6036.8188954331445, 6064.818055458343, 4737.38414006177, 5558.166275058774, 5652.943470565407, 5780.0, 5804.187413762161, 5166.715830629351, 5851.473367396955, 6030.276366836008, 6037.396260374103, 6067.089936509559, 5686.914696279642, 5712.285964254468, 5713.685747283939, 5726.570507211893, 5872.911906321494], "value": 5562.662483090228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.72674941536235, 449.4830944413924, 481.3525807788524, 497.4428639923284, 561.2479277767791, 38347.0, 42449.93875153123, 42578.65817380043, 42666.0, 42716.71849844506, 43119.3532097018, 43589.346159807625, 43636.0, 43814.12371752563, 43841.903952401204, 8542.615582298811, 8673.219410253076, 8948.507832069234, 9184.08159184083, 11427.657170284863, 10732.892671073307, 11238.381888996102, 11529.250598711056, 11550.768984620303, 11573.247738896946, 11531.423428828524, 11548.191626586142, 11563.0, 11565.884341156565, 11610.013148882355, 11499.080073594134, 11530.192886497949, 11546.884531154665, 11548.0, 11574.8263776043, 11526.481308341145, 11562.364069976147, 11605.709857253552, 11612.36132012739, 11621.883781162165, 35155.76954806595, 39584.60415395838, 40367.0, 41438.79280603608, 41972.0, 3486.721062315034, 4080.6939479539155, 4132.91734165315, 4172.3532852407925, 4274.1451709658195, 31695.0, 31909.52135717966, 32154.87457938961, 32391.0, 32826.83586582076, 3236.255661197914, 3314.6519615440516, 3352.7485438591957, 3386.5258863759095, 3391.423458012119, 475096.0, 479195.0, 483471.0, 485022.0, 485190.0, 59265.703671481366, 59387.0, 59494.10758838621, 64226.35773642204, 65353.40556269451, 70011.64994174996, 70409.0, 70516.294837052, 70684.64657676782, 70709.64645176844, 16460.67078658444, 16643.33426662944, 16716.41492547755, 16718.164091795363, 16776.328946842234, 11470.96761291471, 11775.999040081517, 12452.377381130907, 12594.0, 12654.557090501972, 19226.327078552462, 19264.80735192658, 19276.80723192778, 19298.517537061685, 19309.710354344697, 5742.54059675225, 6789.287124851919, 6858.897116543256, 6904.516683832084, 6921.619310937846, 793.7656943452871, 838.3167718309559, 858.9184027517376, 915.8076803871262, 920.3741455810114, 29785.702142978727, 31066.68933310683, 31091.84454077715, 31310.68689313123, 31413.0, 1065.5258410007627, 1065.658989123473, 1096.4079397125463, 1115.1357697784283, 1137.8407023016784, 12672.936635316764, 15693.686126277638, 15985.36058557668, 16234.75647865283, 16240.269187886573, 550148.0, 559755.0, 561584.0, 561938.0, 565126.0, 63423.0486542693, 63735.04397434042, 63782.68108659427, 63844.0, 64027.679861600394, 1436.9154868103158, 1451.5137428961416, 1459.1901494670346, 1476.9926150369179, 1484.057623409143, 30483.847580761954, 30566.388672225985, 30852.303123327536, 31350.05949821509, 31466.213344666565, 55213.44786552083, 55477.0, 55675.443245567025, 55722.16416753671, 55726.72136639291, 470501.0, 497324.5401319055, 518088.0, 522133.0, 522348.0, 41874.58125418707, 42273.78863105665, 43305.350419743096, 43310.78344608257, 44173.77913110414, 47686.04627907353, 48448.5155148444, 49086.01827963349, 49393.50606494033, 49902.25146622731, 35955.382007810236, 37803.62196378111, 39982.2003559933, 40073.59926400815, 41608.791956040026, 39217.0, 39611.405828912015, 40590.59409405868, 41138.651975244225, 41326.586734132274, 27847.582286266126, 35041.64958350384, 35319.29361412809, 35397.29205415826, 35533.82233088818, 30826.0, 32452.35095298128, 34431.827840860635, 35263.47104793379, 35564.466533002545, 21416.46458838479, 24240.63639045451, 24434.63348049745, 25395.36511587225, 25705.10032148866], "value": 20742.196133149824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.5780237998932, 333.6296710651177, 372.554797017564, 400.98797036088894, 413.3923132994499, 19099.42701718949, 19570.90214548927, 20318.593628127466, 20729.896350518244, 20942.32461403088, 17146.31414743409, 20703.585928281424, 20993.37019889402, 21298.57402851942, 21508.892455537738, 4826.865686563655, 5114.0, 5538.584606154534, 5635.746391412386, 5873.530117590582, 5617.859553511154, 5789.421057894198, 5793.420657934215, 5802.738876750535, 5807.767689292423, 5531.917021244684, 5615.719214039302, 5745.6552606843725, 5762.82711518653, 5803.303603567578, 5629.831105066834, 5692.0, 5700.800471983461, 5706.657600543981, 5725.198472213893, 4830.565249127595, 4938.678985865908, 5036.395632524121, 5048.242763585455, 5065.594752419797, 25153.119640812667, 25287.60918149501, 25290.620640690406, 25508.617370739456, 25559.744402555923, 2573.5882258838496, 2624.6535667024696, 2644.5372059889633, 2653.0979466981125, 2691.206094202215, 5934.465898069195, 5967.940320596782, 5999.580029397944, 9171.266298696088, 10295.94852025735, 1799.5231263715125, 1826.7807863056519, 1846.3537761783402, 1874.9437516874516, 1875.0905810681809, 114043.0, 117240.8275917247, 141765.0, 143184.0, 143377.56622433852, 11689.473973671205, 11880.643580692593, 11994.760104797855, 12090.637280881587, 12157.027437804954, 15665.138417387154, 15725.370985160695, 15742.92128539373, 15792.526224213292, 15795.447159349367, 8483.533405662747, 8783.472991620523, 8786.12138786129, 8918.777030574287, 8942.195202431813, 7471.813204669818, 7851.136374998746, 8446.0, 8539.871901921477, 8707.608157632922, 3968.761874287552, 4820.373351464287, 4843.636727245471, 4861.7326047067045, 4971.279164521125, 1999.660057790179, 2051.3845846246068, 2053.8151566359097, 2061.237342183402, 2061.80412860778, 764.8126209078812, 857.7812657772229, 895.54327293081, 919.3151102428733, 919.7746552094645, 20860.58278834445, 22050.007749651304, 22078.77921220767, 22186.667199992015, 22249.888750556143, 895.9238464730571, 903.2909166304551, 910.153557191818, 920.6961702638114, 925.3707478914268, 10920.836187457195, 11398.943005285086, 11516.366599836922, 11517.366544840113, 11584.42077896102, 598803.0, 686998.0, 688080.0, 702245.4887725528, 744303.0, 116892.0, 139258.30370848082, 142674.0, 155527.0, 168267.15866420834, 1039.4958445154093, 1062.7130674717937, 1098.1215027977587, 1100.5212732461246, 1102.2835157147758, 18561.0, 18888.905555472134, 19789.0, 19929.800701992794, 20207.393778186677, 51640.74179629078, 52760.47239527556, 53590.0, 53781.0, 53996.73001635124, 75565.62217188878, 82483.17516824995, 82548.0, 84628.57685711532, 87994.0, 6842.486813489108, 7972.441929064909, 8504.829903402022, 8605.82788344217, 8723.214910658071, 9238.861417078615, 12147.574834880737, 12156.331401772988, 12725.93637031809, 13245.337733113498, 11181.72045698864, 11212.66362009141, 11504.769904602028, 11594.420278986187, 11717.648470545897, 10665.733356666145, 10840.241183117107, 10904.400257985886, 11185.217034807485, 11394.689610694877, 11383.317000979967, 11552.42237888119, 11627.302361858316, 11795.997340226177, 11849.111316651459, 7005.754798582026, 7592.962035189788, 7627.122880868549, 8497.192766687154, 8776.824463510822, 8285.0, 10136.290459667753, 11108.944455277671, 11127.499262533043, 11458.885411145782], "value": 9629.160417559306, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.1223197733398, 1459.0589070049818, 1460.5545308680848, 1475.4319586959025, 1486.6432056306487, 7544.283293087148, 7754.1470438251745, 8015.39884508662, 8500.659973601048, 8520.147985201476, 7893.447458677881, 8143.389245806573, 8172.754817355474, 8279.172082791732, 8281.75154745357, 1970.6255811395788, 2281.7376001759762, 2331.1258278145697, 2332.1604222479896, 2333.5449587330477, 1914.7702275726863, 2279.0541925101147, 2317.733460652021, 2329.336139200328, 2333.7549557296493, 1923.6729755941453, 2122.936311910645, 2288.8855557222155, 2296.8736719480507, 2313.6645186447954, 1890.0, 2291.140822191678, 2291.4385975436044, 2304.6197377432704, 2313.236631911482, 2259.3560835162066, 2306.7923886850094, 2320.1183550250967, 2327.697399338092, 2336.0188720737333, 8318.958405207995, 8344.8331033379, 8349.332053435772, 8396.496210227406, 8416.705415310496, 5043.646944713872, 5190.792368305263, 5191.039657663345, 5206.531412172884, 5222.216667499867, 3256.56036435083, 3331.4003479373705, 3472.5832900052155, 3514.9648503514895, 3520.3135388599235, 1243.2664727810545, 1266.006185144657, 1693.2972816281228, 1737.348494314632, 1808.9728654070068, 8226.341892648634, 10705.625303114432, 10776.4611769412, 10812.405317707522, 10969.506372213189, 4566.862994110182, 4727.149113159596, 4729.479757226771, 4759.262314341283, 4802.27965805125, 8692.739217823475, 8714.389992700577, 8777.29781617469, 8779.341549383822, 8784.78038049041, 5124.103281925648, 5153.0, 5156.123459011977, 5158.509941555546, 5170.302009228782, 4615.930761038587, 4753.9762301188275, 4808.567228949411, 4812.205986012339, 4827.879303017382, 3820.7898565578603, 3831.9616803831605, 3930.665893399036, 3933.665638420709, 3965.7818819965178, 1278.6675464379143, 1305.477808876438, 1307.2287350463273, 1311.2329287366806, 1312.9212247265195, 879.4679219072497, 880.5817236812463, 881.3257857738835, 910.8978136454831, 915.6612053540233, 5484.698341591171, 5709.429057094258, 5719.942800571941, 5758.62568933018, 5763.299826551178, 802.3060053054066, 962.4898803634085, 980.6224603527693, 986.2947992185622, 1030.8351562734063, 3682.429223470366, 3733.104055026774, 3765.943510847285, 3885.417187421909, 3886.689064874803, 9598.66404675833, 9919.7024089276, 9949.403035817873, 9956.95451977532, 9990.250731195189, 9799.559019844124, 9889.357191782512, 9911.256655750847, 9913.851292230622, 9942.204623630092, 7304.0, 7710.7686769397005, 7721.575313357819, 7753.728619498291, 7837.960810195913, 5429.077056900415, 5433.320834895638, 5610.410906854885, 5771.595988280948, 5826.155207494974, 7152.392046676091, 8976.371653984419, 9180.495072770795, 9230.215431688113, 9234.353595248269, 8343.249107580346, 8349.66601335964, 9016.0, 9230.215431688383, 9294.25645948309, 6949.583025018313, 7137.928620713727, 7165.176004759311, 7169.7849064528145, 7179.784606461814, 6372.808815735535, 7633.2366763323225, 7750.302472777477, 7799.727009554638, 7816.06207255133, 6712.7245823293415, 7099.680514376969, 7187.425005999403, 7241.782746517613, 7316.817079573053, 6478.6760661967655, 6990.335918087977, 7091.60996145217, 7155.892661610184, 7185.5688658678555, 5202.297689811827, 6380.489560835029, 6397.776077837253, 6435.0, 6554.410103090745, 3945.5659877412886, 4275.807588658456, 4979.452260251442, 5046.394432667957, 5064.139096353555, 4154.356074808409, 4893.853184404474, 4978.4025916890205, 5109.948900511096, 5141.742912854267], "value": 4400.200120229126, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.4892661008489, 353.4203905594824, 355.78652808314996, 363.0397598352358, 368.1036675694682, 5217.426083130853, 5250.193609633024, 5424.701641409726, 5584.296789479207, 5599.7480113394895, 4676.789544470498, 5097.209932460465, 5355.036093503168, 5384.523119365087, 5402.162664786954, 3133.8433078345993, 4102.830693252424, 4279.293916503789, 4309.827606895736, 4317.589828966243, 3546.85812567497, 4176.283108033852, 4216.409702641633, 4286.271333873249, 4303.978480107595, 3890.7665540067687, 4198.8320467181275, 4201.1807697499, 4204.789760511978, 4213.304804707235, 4206.369044643328, 4214.810333534983, 4246.938265433641, 4252.723572967762, 4276.2089013532595, 3438.432658611326, 3787.394016957274, 3788.7916164610933, 3798.3542797724454, 3802.6690658269663, 4931.580815630676, 5275.419703832576, 5303.363596368422, 5360.115580929142, 5360.303160589137, 4098.938515922234, 4177.548299469191, 4718.4809670936165, 4734.976325118352, 4768.3085952536685, 5766.875459285441, 5774.873899589582, 5802.373516552155, 5807.245058142456, 5813.82558523245, 3660.981695091534, 3892.299386110499, 3911.9804400978096, 3917.0794863207407, 3930.9951924518414, 5211.635185537014, 5799.594028418012, 6046.516278697738, 6094.12470023979, 6119.112728654365, 3946.2304850553865, 3963.603639636013, 3972.6027397260623, 3986.149902819498, 3988.7606743594897, 3749.887503374903, 3956.3867600521967, 4006.859759908389, 4046.754051501386, 4047.3119569673227, 4405.449318835145, 4605.930911036337, 4701.341812146302, 4732.266498692708, 4765.356676848581, 5832.375431056042, 5839.868448016444, 5850.0932355484965, 5877.324107727581, 5890.882182356415, 1266.4991984498215, 1298.8246586710861, 1314.566193156256, 1317.703516708752, 1323.556608536151, 752.3567349915853, 830.7994947301213, 852.1776485691338, 866.8266346730679, 897.1790811407619, 4305.97847010763, 4310.590493903074, 4510.594046535827, 5142.280080788692, 5157.4584668610005, 5674.546036317085, 5695.601307908407, 5727.627704199297, 5744.454276843693, 5749.913751293734, 3940.763554186758, 4296.720713153635, 4679.695819771704, 5258.211268309784, 5274.549498887836, 2589.067935543203, 2860.7854410919263, 2989.6546554050765, 3048.329367539138, 3049.6950304969328, 5538.252335934678, 5774.48029677331, 5918.822435326947, 5952.464278214895, 5967.343592204854, 5245.324884308953, 5605.271314729059, 5881.823545293648, 5896.528277737856, 5911.704414779244, 5049.999999999926, 5294.100002999577, 5566.638168519034, 5885.205497257901, 5955.37468565803, 5080.614548578518, 5095.439501654889, 5239.327942749302, 5615.5507559395965, 5752.424757524214, 4802.903941921072, 5252.557560734277, 5513.373554801263, 5837.620554663933, 5945.375735547878, 5215.5827533797965, 5330.9733451332495, 5891.970540147272, 6071.848203794941, 6182.814515564541, 3314.1051915982066, 3886.113886113886, 4066.369712694537, 4296.677749168763, 4298.3337582673485, 5181.983962429147, 5690.573207009574, 5763.4524720153195, 5905.822825315247, 5925.614835035709, 4879.0, 5058.494150584912, 5731.850556041484, 5739.397363276796, 5817.138515674943, 4695.22528782747, 4720.575148236675, 4798.145103663314, 4890.486498917562, 5245.475452454724, 4493.528179541232, 4729.834455794031, 5634.408387119293, 5643.88712225745, 5673.0, 5347.786088556414, 5502.559795216293, 5737.512311453574, 5798.507126894261, 5900.7049647518315, 4420.425344705168, 5296.36796444672, 5312.654677445954, 5375.709829640936, 5625.549956003428], "value": 4141.373192120682, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.6847621284738, 772.6136931534232, 806.4999700185883, 807.5760225881415, 815.1400272712286, 15642.530724078282, 15808.604784880385, 15920.124393158372, 15995.120268385233, 16030.038197708116, 12257.325847078408, 14538.927305363484, 14813.92593037036, 14816.111033338007, 14820.333085011174, 694.6110178300169, 707.998182571663, 851.2891735400948, 859.4671303791658, 878.3280790195505, 873.5937788928147, 883.0551310098198, 884.0938038510513, 884.5267781736773, 889.208604342136, 929.9767505812375, 939.5584075484545, 940.8353538130834, 945.973618623794, 951.3388195204301, 727.8580676768032, 883.575883575884, 903.8508646073456, 941.7363138321247, 942.7784470649392, 667.1194023888469, 702.4906942466722, 705.8059033765704, 708.578395854471, 709.574255446733, 14986.325615347336, 15330.846691533165, 15373.461928832437, 15759.763603545956, 15917.442889498812, 14494.492692755703, 14743.77884331736, 14760.704785904329, 14831.703365932728, 14839.554813355617, 11796.469158887785, 11850.585229517012, 11902.702432439171, 11944.820827687592, 12410.81383779244, 3760.0599850037493, 3764.661180493769, 3851.6340947609933, 3898.1034362096875, 3904.609539046101, 102546.97453025449, 104456.95543044624, 104999.47500262526, 105167.0, 106185.46907265569, 11077.612283570037, 11268.887311126784, 11384.316940983568, 11453.370064646524, 11483.885161148282, 23761.0, 23944.88027559851, 23961.640575391382, 24053.759462405153, 24077.63883541748, 7830.804229894298, 7881.054273487218, 7885.921140788633, 7898.368130549542, 8040.758777236692, 4281.486221653421, 4286.542575524337, 4296.871093867189, 4300.3549467580115, 4350.086481838786, 3597.4603809428795, 3685.981570092132, 3761.2665530221893, 3951.5258169019326, 3979.343408337592, 650.6584043377264, 692.9272426395257, 710.8471678589128, 713.5255055388212, 724.8586525627452, 627.7583130494793, 683.0300972618893, 684.4695361095091, 695.3046953046852, 726.1830440754152, 9959.601615935282, 10296.297033051158, 10326.277160598836, 10488.370697758159, 10781.08360789326, 677.9084823548758, 713.728783062433, 722.407625746893, 725.6589402980591, 739.3161325773746, 4749.857504274877, 5138.332016837787, 5146.228065790161, 5147.356580427447, 5150.175971844487, 106604.0, 106803.0, 108642.28294618079, 110709.44645276722, 112292.43853780678, 80344.0, 96359.0364096364, 97449.0255097454, 98196.0, 98404.50797745965, 83564.0, 84312.73530897041, 84819.57590212133, 84952.0, 86900.56549717211, 10682.32941764559, 10682.89317106819, 10983.670489885317, 11036.724081898017, 11175.0, 37546.55574941673, 49708.50291497183, 50080.499195007586, 51837.740811295705, 53476.0, 65476.0, 67611.0, 68093.659531704, 68841.65579172272, 70223.29776702372, 12922.935385323013, 13016.934915325362, 13409.32953352348, 13466.0, 13505.527306544223, 11134.498947547218, 12638.873611264138, 12648.466141229164, 13497.460101595827, 15100.0, 13545.932270338586, 13630.386632601754, 13692.589222323346, 13720.382582784, 13740.587782366545, 13717.794233086312, 13840.0, 13947.29415958285, 13949.442022318994, 13981.860181398055, 13185.60443186706, 13229.47082116743, 13675.0, 13828.516001939885, 13994.962767199304, 11066.39134847591, 11075.280106793032, 11415.486303116213, 11801.527938882691, 11874.82187767167, 9068.727938161866, 10108.444035577819, 10964.28732132409, 11073.778524429628, 11143.498542565441], "value": 7706.661413821979, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 172.0, 115.0, 119.0, 129.0, 176.0, 157.0, 118.0, 117.0, 119.0], "value": 137.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 113.0, 151.0, 112.0, 116.0, 130.0, 116.0, 132.0, 113.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 220.0, 196.0, 200.0, 199.0, 196.0, 197.0, 196.0, 192.0, 196.0], "value": 199.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 60.0, 85.0, 59.0, 61.0, 59.0, 61.0, 74.0, 80.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 76.0, 95.0, 72.0, 70.0, 71.0, 80.0, 69.0, 70.0, 82.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 88.0, 88.0, 89.0, 91.0, 90.0, 94.0, 90.0, 88.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 175.0, 161.0, 98.0, 115.0, 126.0, 107.0, 99.0, 173.0, 145.0], "value": 130.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 91.0, 93.0, 92.0, 91.0, 90.0, 93.0, 93.0, 92.0], "value": 92.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 67.0, 96.0, 97.0, 97.0, 100.0, 89.0], "value": 78.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 77.0, 79.0, 80.0, 70.0, 71.0, 71.0, 73.0, 63.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 82.0, 83.0, 84.0, 76.0, 108.0, 111.0, 111.0, 82.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 166.0, 139.0, 141.0, 167.0, 158.0, 165.0, 162.0, 204.0, 166.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 181.0, 180.0, 202.0, 247.0, 179.0, 180.0, 168.0, 212.0, 169.0], "value": 189.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 83.0, 96.0, 83.0, 71.0, 66.0, 77.0, 71.0, 68.0, 91.0], "value": 76.9, "unit": "score"}]}]} 11:17:47 INFO - Return code: 0 11:17:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:17:47 ERROR - # TBPL SUCCESS # 11:17:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:17:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:17:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:17:47 INFO - 2017-01-20 11:17:47.436 screenresolution[1918:16330] starting screenresolution argv=screenresolution get 11:17:47 INFO - 2017-01-20 11:17:47.439 screenresolution[1918:16330] Display 0: 1600x1200x32@60 11:17:47 INFO - 2017-01-20 11:17:47.445 screenresolution[1919:16333] starting screenresolution argv=screenresolution list 11:17:47 INFO - Available Modes on Display 0 11:17:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:17:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:17:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:17:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:17:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:17:47 INFO - Intel Iris: 11:17:47 INFO - Chipset Model: Intel Iris 11:17:47 INFO - Type: GPU 11:17:47 INFO - Bus: Built-In 11:17:47 INFO - VRAM (Dynamic, Max): 1536 MB 11:17:47 INFO - Vendor: Intel (0x8086) 11:17:47 INFO - Device ID: 0x0a2e 11:17:47 INFO - Revision ID: 0x0009 11:17:47 INFO - Displays: 11:17:47 INFO - Display: 11:17:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:17:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:17:47 INFO - Display Serial Number: 1600x1200 60 11:17:47 INFO - Main Display: Yes 11:17:47 INFO - Mirror: Off 11:17:47 INFO - Online: Yes 11:17:47 INFO - Rotation: Supported 11:17:47 INFO - Return code: 0 11:17:47 INFO - Running post-action listener: _resource_record_post_action 11:17:47 INFO - [mozharness: 2017-01-20 19:17:47.683584Z] Finished run-tests step (success) 11:17:47 INFO - Running post-run listener: _resource_record_post_run 11:17:47 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 2012672; Write bytes: 555056640; Read time: 22; Write time: 1695 11:17:47 INFO - TinderboxPrint: CPU usage
54.6% 11:17:47 INFO - TinderboxPrint: I/O read bytes / time
2,012,672 / 22 11:17:47 INFO - TinderboxPrint: I/O write bytes / time
555,056,640 / 1,695 11:17:47 INFO - TinderboxPrint: CPU idle
2,178.0 (45.4%) 11:17:47 INFO - TinderboxPrint: CPU system
972.9 (20.3%) 11:17:47 INFO - TinderboxPrint: CPU user
1,650.9 (34.4%) 11:17:47 INFO - TinderboxPrint: Swap in / out
253,546,496 / 0 11:17:47 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247345664; Write bytes: 241555456; Read time: 17899; Write time: 517 11:17:47 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 1971712; Write bytes: 299939328; Read time: 20; Write time: 1134 11:17:48 INFO - Running post-run listener: _upload_blobber_files 11:17:48 INFO - Blob upload gear active. 11:17:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:17:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:17:48 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:17:48 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:17:48 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:17:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:17:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:49 INFO - (blobuploader) - INFO - Done attempting. 11:17:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:17:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:17:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:50 INFO - (blobuploader) - INFO - Done attempting. 11:17:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:17:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:51 INFO - (blobuploader) - INFO - Done attempting. 11:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:17:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:53 INFO - (blobuploader) - INFO - Done attempting. 11:17:53 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:53 INFO - Return code: 0 11:17:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:17:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7287696ac4425399fdc416624c5d21b738bf27d2f43ecefc7d0adb7ccf6705d3fdee9d8a9b8ed2fe40428a4678f88fa051bd79f144b186e33232299ea0f77b20", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9948af378c34877e164e620963f76f22ff12e1b18cef89e1afaf81214aee4211d89d58d92f5bc6d87493fd7e1ed03634e440392350254af818f6c6661336c898", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/50959929b5ae3c07d84fdceb555a8ec23ca005198cd2125be74fbc662af794387cd8d2ebfe0d39866276e7defb8b4e42e7617475c4e980384aa779c5f76b0171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fb16286106c19ececf01c95419e599d4e227827315a3b6be58e2531b021b4821e07f934a864862aa3501e321d362daede7df95fa31bae1307cb77e1722375aea"} 11:17:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:17:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:17:53 INFO - Contents: 11:17:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7287696ac4425399fdc416624c5d21b738bf27d2f43ecefc7d0adb7ccf6705d3fdee9d8a9b8ed2fe40428a4678f88fa051bd79f144b186e33232299ea0f77b20", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9948af378c34877e164e620963f76f22ff12e1b18cef89e1afaf81214aee4211d89d58d92f5bc6d87493fd7e1ed03634e440392350254af818f6c6661336c898", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/50959929b5ae3c07d84fdceb555a8ec23ca005198cd2125be74fbc662af794387cd8d2ebfe0d39866276e7defb8b4e42e7617475c4e980384aa779c5f76b0171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fb16286106c19ececf01c95419e599d4e227827315a3b6be58e2531b021b4821e07f934a864862aa3501e321d362daede7df95fa31bae1307cb77e1722375aea"} 11:17:53 INFO - Running post-run listener: copy_logs_to_upload_dir 11:17:53 INFO - Copying logs to upload dir... 11:17:53 INFO - mkdir: /builds/slave/test/build/upload/logs 11:17:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.566957 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-20 11:17:53.834771) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 11:17:53.837832) ========= 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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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/Graphics/sha512/7287696ac4425399fdc416624c5d21b738bf27d2f43ecefc7d0adb7ccf6705d3fdee9d8a9b8ed2fe40428a4678f88fa051bd79f144b186e33232299ea0f77b20", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9948af378c34877e164e620963f76f22ff12e1b18cef89e1afaf81214aee4211d89d58d92f5bc6d87493fd7e1ed03634e440392350254af818f6c6661336c898", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/50959929b5ae3c07d84fdceb555a8ec23ca005198cd2125be74fbc662af794387cd8d2ebfe0d39866276e7defb8b4e42e7617475c4e980384aa779c5f76b0171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fb16286106c19ececf01c95419e599d4e227827315a3b6be58e2531b021b4821e07f934a864862aa3501e321d362daede7df95fa31bae1307cb77e1722375aea"} build_url:https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/IuqqCk5BRsOPbdPu_L1uOQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7287696ac4425399fdc416624c5d21b738bf27d2f43ecefc7d0adb7ccf6705d3fdee9d8a9b8ed2fe40428a4678f88fa051bd79f144b186e33232299ea0f77b20", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9948af378c34877e164e620963f76f22ff12e1b18cef89e1afaf81214aee4211d89d58d92f5bc6d87493fd7e1ed03634e440392350254af818f6c6661336c898", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/50959929b5ae3c07d84fdceb555a8ec23ca005198cd2125be74fbc662af794387cd8d2ebfe0d39866276e7defb8b4e42e7617475c4e980384aa779c5f76b0171", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fb16286106c19ececf01c95419e599d4e227827315a3b6be58e2531b021b4821e07f934a864862aa3501e321d362daede7df95fa31bae1307cb77e1722375aea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 11:17:53.872797) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 11:17:53.873125) ========= 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.nN0Z2Av8Ae/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.7cBpocovnW/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.005115 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 11:17:53.921233) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 11:17:53.921552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 11:17:53.921908) ========= ========= Total master_lag: 0.19 =========