builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0255 starttime: 1471611148.34 results: success (0) buildid: 20160819033756 builduid: 7640b614f2c04a4ebb12ecb88bb74fed revision: b4a5ab92903593cb47d8f8d2155f724b4527d16d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:28.336842) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:28.337332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:28.337606) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:28.363071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:28.363512) ========= 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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-19 05:52:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2016-08-19 05:52:28 (18.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:28.511535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:28.511855) ========= 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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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.025231 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:28.560159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-19 05:52:28.560496) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4a5ab92903593cb47d8f8d2155f724b4527d16d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b4a5ab92903593cb47d8f8d2155f724b4527d16d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tVqXuBbK6L/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.3BJwbT2dX3/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-19 05:52:28,642 truncating revision to first 12 chars 2016-08-19 05:52:28,642 Setting DEBUG logging. 2016-08-19 05:52:28,642 attempt 1/10 2016-08-19 05:52:28,642 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4a5ab929035?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 05:52:30,446 unpacking tar archive at: mozilla-central-b4a5ab929035/testing/mozharness/ program finished with exit code 0 elapsedTime=2.081997 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-19 05:52:30.664553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:30.664880) ========= script_repo_revision: b4a5ab92903593cb47d8f8d2155f724b4527d16d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:30.665271) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:30.665532) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 05:52:30.681173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-19 05:52:30.681443) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tVqXuBbK6L/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.3BJwbT2dX3/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:52:30 INFO - MultiFileLogger online at 20160819 05:52:30 in /builds/slave/test 05:52:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:52:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:30 INFO - {'append_to_log': False, 05:52:30 INFO - 'base_work_dir': '/builds/slave/test', 05:52:30 INFO - 'blob_upload_branch': 'Firefox', 05:52:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:30 INFO - 'branch': 'Firefox', 05:52:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:30 INFO - 'config_files': ('talos/mac_config.py',), 05:52:30 INFO - 'default_actions': ('clobber', 05:52:30 INFO - 'read-buildbot-config', 05:52:30 INFO - 'download-and-extract', 05:52:30 INFO - 'populate-webroot', 05:52:30 INFO - 'create-virtualenv', 05:52:30 INFO - 'install', 05:52:30 INFO - 'run-tests'), 05:52:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:30 INFO - 'download_minidump_stackwalk': True, 05:52:30 INFO - 'download_symbols': 'ondemand', 05:52:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:30 INFO - 'installer_path': 'installer.exe', 05:52:30 INFO - 'log_level': 'info', 05:52:30 INFO - 'log_name': 'talos', 05:52:30 INFO - 'log_to_console': True, 05:52:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:52:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:52:30 INFO - 'opt_config_files': (), 05:52:30 INFO - 'pip_index': False, 05:52:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:30 INFO - 'cmd': ('bash', 05:52:30 INFO - '-c', 05:52:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:30 INFO - 'enabled': True, 05:52:30 INFO - 'halt_on_failure': False, 05:52:30 INFO - 'name': 'check_screen_resolution'},), 05:52:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:30 INFO - 'cmd': ('bash', 05:52:30 INFO - '-c', 05:52:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:30 INFO - 'enabled': True, 05:52:30 INFO - 'halt_on_failure': False, 05:52:30 INFO - 'name': 'check_screen_resolution'},), 05:52:30 INFO - 'run_cmd_checks_enabled': True, 05:52:30 INFO - 'sps_profile': False, 05:52:30 INFO - 'sps_profile_interval': 0, 05:52:30 INFO - 'suite': 'dromaeojs-e10s', 05:52:30 INFO - 'system_bits': '32', 05:52:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:30 INFO - 'title': 't-yosemite-r7-0255', 05:52:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:30 INFO - 'use_talos_json': True, 05:52:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:30 INFO - 'work_dir': 'build'} 05:52:30 INFO - [mozharness: 2016-08-19 12:52:30.878601Z] Running clobber step. 05:52:30 INFO - Running pre-action listener: _resource_record_pre_action 05:52:30 INFO - Running main action method: clobber 05:52:30 INFO - rmtree: /builds/slave/test/build 05:52:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:32 INFO - Running post-action listener: _resource_record_post_action 05:52:32 INFO - [mozharness: 2016-08-19 12:52:32.902761Z] Finished clobber step (success) 05:52:32 INFO - [mozharness: 2016-08-19 12:52:32.903010Z] Running read-buildbot-config step. 05:52:32 INFO - Running pre-action listener: _resource_record_pre_action 05:52:32 INFO - Running main action method: read_buildbot_config 05:52:32 INFO - Using buildbot properties: 05:52:32 INFO - { 05:52:32 INFO - "project": "", 05:52:32 INFO - "product": "firefox", 05:52:32 INFO - "script_repo_revision": "production", 05:52:32 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:52:32 INFO - "repository": "", 05:52:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:52:32 INFO - "buildid": "20160819033756", 05:52:32 INFO - "pgo_build": "False", 05:52:32 INFO - "basedir": "/builds/slave/test", 05:52:32 INFO - "buildnumber": 44, 05:52:32 INFO - "slavename": "t-yosemite-r7-0255", 05:52:32 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:52:32 INFO - "platform": "yosemite_r7", 05:52:32 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:52:32 INFO - "branch": "mozilla-central", 05:52:32 INFO - "repo_path": "mozilla-central", 05:52:32 INFO - "revision": "b4a5ab92903593cb47d8f8d2155f724b4527d16d", 05:52:32 INFO - "stage_platform": "macosx64", 05:52:32 INFO - "builduid": "7640b614f2c04a4ebb12ecb88bb74fed", 05:52:32 INFO - "slavebuilddir": "test" 05:52:32 INFO - } 05:52:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:52:32 INFO - Running post-action listener: _resource_record_post_action 05:52:32 INFO - [mozharness: 2016-08-19 12:52:32.908651Z] Finished read-buildbot-config step (success) 05:52:32 INFO - [mozharness: 2016-08-19 12:52:32.908866Z] Running download-and-extract step. 05:52:32 INFO - Running pre-action listener: _resource_record_pre_action 05:52:32 INFO - Running main action method: download_and_extract 05:52:32 INFO - mkdir: /builds/slave/test/build/tests 05:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:32 INFO - trying https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:52:32 INFO - Downloading https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 05:52:34 INFO - Downloaded 1199 bytes. 05:52:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:52:34 INFO - Using the following test package requirements: 05:52:34 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:52:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:34 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:52:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:34 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:52:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:34 INFO - u'jsshell-mac.zip'], 05:52:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:34 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:52:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:52:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:34 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:52:34 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:34 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:52:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:34 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:52:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:52:34 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:52:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:34 INFO - trying https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:52:34 INFO - Downloading https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:52:35 INFO - Downloaded 16339496 bytes. 05:52:35 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:52:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:41 INFO - trying https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:52:41 INFO - Downloading https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:52:42 INFO - Downloaded 16339496 bytes. 05:52:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:49 INFO - trying https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:52:49 INFO - Downloading https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:52:50 INFO - Downloaded 14413981 bytes. 05:52:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:50 INFO - trying https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:52:50 INFO - Downloading https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 05:52:53 INFO - Downloaded 111251202 bytes. 05:52:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:52:53 INFO - mkdir: /builds/slave/test/properties 05:52:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:53 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:53 INFO - Contents: 05:52:53 INFO - build_url:https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:52:54 INFO - Running post-action listener: _resource_record_post_action 05:52:54 INFO - Running post-action listener: set_extra_try_arguments 05:52:54 INFO - [mozharness: 2016-08-19 12:52:54.173845Z] Finished download-and-extract step (success) 05:52:54 INFO - [mozharness: 2016-08-19 12:52:54.173994Z] Running populate-webroot step. 05:52:54 INFO - Running pre-action listener: _resource_record_pre_action 05:52:54 INFO - Running main action method: populate_webroot 05:52:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:54 INFO - '--tppagecycles', 05:52:54 INFO - '7'], 05:52:54 INFO - 'tests': ['tsvgm']}}, 05:52:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:54 INFO - 'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:54 INFO - 'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['damp', 'tps']}, 05:52:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:54 INFO - 'tests': ['damp', 'tps']}, 05:52:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['dromaeo_dom']}, 05:52:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['basic_compositor_video']}, 05:52:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['a11yr', 05:52:54 INFO - 'ts_paint', 05:52:54 INFO - 'tpaint', 05:52:54 INFO - 'sessionrestore', 05:52:54 INFO - 'sessionrestore_no_auto_restore', 05:52:54 INFO - 'tabpaint']}, 05:52:54 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:54 INFO - 'ts_paint', 05:52:54 INFO - 'tpaint', 05:52:54 INFO - 'sessionrestore', 05:52:54 INFO - 'sessionrestore_no_auto_restore', 05:52:54 INFO - 'tabpaint']}, 05:52:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:54 INFO - 'ts_paint', 05:52:54 INFO - 'tpaint', 05:52:54 INFO - 'sessionrestore', 05:52:54 INFO - 'sessionrestore_no_auto_restore', 05:52:54 INFO - 'tabpaint']}, 05:52:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:54 INFO - 'ts_paint', 05:52:54 INFO - 'tpaint', 05:52:54 INFO - 'sessionrestore', 05:52:54 INFO - 'sessionrestore_no_auto_restore', 05:52:54 INFO - 'tabpaint']}, 05:52:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['a11yr', 05:52:54 INFO - 'ts_paint', 05:52:54 INFO - 'tpaint', 05:52:54 INFO - 'sessionrestore', 05:52:54 INFO - 'sessionrestore_no_auto_restore', 05:52:54 INFO - 'tabpaint']}, 05:52:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['a11yr', 05:52:54 INFO - 'ts_paint', 05:52:54 INFO - 'tpaint', 05:52:54 INFO - 'sessionrestore', 05:52:54 INFO - 'sessionrestore_no_auto_restore', 05:52:54 INFO - 'tabpaint']}, 05:52:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['tsvgx', 05:52:54 INFO - 'tsvgr_opacity', 05:52:54 INFO - 'tart', 05:52:54 INFO - 'tscrollx', 05:52:54 INFO - 'cart']}, 05:52:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:54 INFO - 'tsvgr_opacity', 05:52:54 INFO - 'tart', 05:52:54 INFO - 'tscrollx', 05:52:54 INFO - 'cart']}, 05:52:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:54 INFO - 'talos_options': ['--disable-e10s'], 05:52:54 INFO - 'tests': ['tp5o']}, 05:52:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:54 INFO - 'tests': ['tp5o']}, 05:52:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:54 INFO - 'talos_options': ['--disable-e10s', 05:52:54 INFO - '--xperf_path', 05:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:54 INFO - 'tests': ['tp5n']}, 05:52:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:54 INFO - 'talos_options': ['--xperf_path', 05:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:54 INFO - 'tests': ['tp5n']}}, 05:52:54 INFO - 'talos.zip': {'path': '', 05:52:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:54 INFO - Running post-action listener: _resource_record_post_action 05:52:54 INFO - [mozharness: 2016-08-19 12:52:54.193215Z] Finished populate-webroot step (success) 05:52:54 INFO - [mozharness: 2016-08-19 12:52:54.193339Z] Running create-virtualenv step. 05:52:54 INFO - Running pre-action listener: _resource_record_pre_action 05:52:54 INFO - Running main action method: create_virtualenv 05:52:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:52:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:54 INFO - Using real prefix '/tools/python27' 05:52:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:57 INFO - Installing pip.................done. 05:52:57 INFO - Return code: 0 05:52:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 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 0x10fbc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1addded0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, '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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:52:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:52:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:57 INFO - 'HOME': '/Users/cltbld', 05:52:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:57 INFO - 'LOGNAME': 'cltbld', 05:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:57 INFO - 'MOZ_NO_REMOTE': '1', 05:52:57 INFO - 'NO_EM_RESTART': '1', 05:52:57 INFO - 'PAGER': '/bin/cat', 05:52:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:57 INFO - 'PWD': '/builds/slave/test', 05:52:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:57 INFO - 'SHELL': '/bin/bash', 05:52:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:52:57 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:52:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:57 INFO - 'USER': 'cltbld', 05:52:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:57 INFO - 'XPC_FLAGS': '0x0', 05:52:57 INFO - 'XPC_SERVICE_NAME': '0', 05:52:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:52:58 INFO - Cleaning up... 05:52:58 INFO - Return code: 0 05:52:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:58 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 0x10fbc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1addded0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, '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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:58 INFO - 'HOME': '/Users/cltbld', 05:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:58 INFO - 'LOGNAME': 'cltbld', 05:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:58 INFO - 'MOZ_NO_REMOTE': '1', 05:52:58 INFO - 'NO_EM_RESTART': '1', 05:52:58 INFO - 'PAGER': '/bin/cat', 05:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:58 INFO - 'PWD': '/builds/slave/test', 05:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:58 INFO - 'SHELL': '/bin/bash', 05:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:52:58 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:58 INFO - 'USER': 'cltbld', 05:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:58 INFO - 'XPC_FLAGS': '0x0', 05:52:58 INFO - 'XPC_SERVICE_NAME': '0', 05:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:58 INFO - Downloading/unpacking psutil>=3.1.1 05:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:01 INFO - Installing collected packages: psutil 05:53:01 INFO - Running setup.py install for psutil 05:53:01 INFO - building 'psutil._psutil_osx' extension 05:53:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:53:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:53:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:53:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:53:02 INFO - building 'psutil._psutil_posix' extension 05:53:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:53:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:53:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:53:02 INFO - ^ 05:53:02 INFO - 1 warning generated. 05:53:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:53:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:02 INFO - Successfully installed psutil 05:53:02 INFO - Cleaning up... 05:53:02 INFO - Return code: 0 05:53:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:02 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 0x10fbc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1addded0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, '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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:53:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:53:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:02 INFO - 'HOME': '/Users/cltbld', 05:53:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:02 INFO - 'LOGNAME': 'cltbld', 05:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:02 INFO - 'MOZ_NO_REMOTE': '1', 05:53:02 INFO - 'NO_EM_RESTART': '1', 05:53:02 INFO - 'PAGER': '/bin/cat', 05:53:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:02 INFO - 'PWD': '/builds/slave/test', 05:53:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:02 INFO - 'SHELL': '/bin/bash', 05:53:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:53:02 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:53:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:02 INFO - 'USER': 'cltbld', 05:53:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:02 INFO - 'XPC_FLAGS': '0x0', 05:53:02 INFO - 'XPC_SERVICE_NAME': '0', 05:53:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:53:05 INFO - Installing collected packages: mozsystemmonitor 05:53:05 INFO - Running setup.py install for mozsystemmonitor 05:53:05 INFO - Successfully installed mozsystemmonitor 05:53:05 INFO - Cleaning up... 05:53:05 INFO - Return code: 0 05:53:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:05 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 0x10fbc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1addded0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, '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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:53:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:53:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:05 INFO - 'HOME': '/Users/cltbld', 05:53:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:05 INFO - 'LOGNAME': 'cltbld', 05:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:05 INFO - 'MOZ_NO_REMOTE': '1', 05:53:05 INFO - 'NO_EM_RESTART': '1', 05:53:05 INFO - 'PAGER': '/bin/cat', 05:53:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:05 INFO - 'PWD': '/builds/slave/test', 05:53:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:05 INFO - 'SHELL': '/bin/bash', 05:53:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:53:05 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:53:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:05 INFO - 'USER': 'cltbld', 05:53:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:05 INFO - 'XPC_FLAGS': '0x0', 05:53:05 INFO - 'XPC_SERVICE_NAME': '0', 05:53:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:06 INFO - Downloading/unpacking jsonschema==2.5.1 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:09 INFO - warning: no files found matching '*.txt' 05:53:09 INFO - no previously-included directories found matching 'build' 05:53:09 INFO - no previously-included directories found matching 'dist' 05:53:09 INFO - no previously-included directories found matching '.git*' 05:53:09 INFO - Installing collected packages: jsonschema, functools32 05:53:09 INFO - Running setup.py install for functools32 05:53:09 INFO - warning: no files found matching '*.txt' 05:53:09 INFO - no previously-included directories found matching 'build' 05:53:09 INFO - no previously-included directories found matching 'dist' 05:53:09 INFO - no previously-included directories found matching '.git*' 05:53:09 INFO - Successfully installed jsonschema functools32 05:53:09 INFO - Cleaning up... 05:53:09 INFO - Return code: 0 05:53:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:09 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 0x10fbc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1addded0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, '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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:53:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:53:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:09 INFO - 'HOME': '/Users/cltbld', 05:53:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:09 INFO - 'LOGNAME': 'cltbld', 05:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:09 INFO - 'MOZ_NO_REMOTE': '1', 05:53:09 INFO - 'NO_EM_RESTART': '1', 05:53:09 INFO - 'PAGER': '/bin/cat', 05:53:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:09 INFO - 'PWD': '/builds/slave/test', 05:53:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:09 INFO - 'SHELL': '/bin/bash', 05:53:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:53:09 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:53:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:09 INFO - 'USER': 'cltbld', 05:53:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:09 INFO - 'XPC_FLAGS': '0x0', 05:53:09 INFO - 'XPC_SERVICE_NAME': '0', 05:53:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:09 INFO - Cleaning up... 05:53:09 INFO - Return code: 0 05:53:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:09 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 0x10fbc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1addded0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, '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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:53:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:53:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:09 INFO - 'HOME': '/Users/cltbld', 05:53:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:09 INFO - 'LOGNAME': 'cltbld', 05:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:09 INFO - 'MOZ_NO_REMOTE': '1', 05:53:09 INFO - 'NO_EM_RESTART': '1', 05:53:09 INFO - 'PAGER': '/bin/cat', 05:53:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:09 INFO - 'PWD': '/builds/slave/test', 05:53:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:09 INFO - 'SHELL': '/bin/bash', 05:53:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:53:09 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:53:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:09 INFO - 'USER': 'cltbld', 05:53:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:09 INFO - 'XPC_FLAGS': '0x0', 05:53:09 INFO - 'XPC_SERVICE_NAME': '0', 05:53:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:12 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:13 INFO - Downloading docopt-0.6.1.tar.gz 05:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:13 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:13 INFO - Running setup.py install for blobuploader 05:53:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:13 INFO - Running setup.py install for requests 05:53:14 INFO - Running setup.py install for docopt 05:53:14 INFO - Successfully installed blobuploader requests docopt 05:53:14 INFO - Cleaning up... 05:53:14 INFO - Return code: 0 05:53:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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 0x10fbc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1addded0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, '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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:53:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:14 INFO - 'HOME': '/Users/cltbld', 05:53:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:14 INFO - 'LOGNAME': 'cltbld', 05:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:14 INFO - 'MOZ_NO_REMOTE': '1', 05:53:14 INFO - 'NO_EM_RESTART': '1', 05:53:14 INFO - 'PAGER': '/bin/cat', 05:53:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:14 INFO - 'PWD': '/builds/slave/test', 05:53:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:14 INFO - 'SHELL': '/bin/bash', 05:53:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:53:14 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:53:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:14 INFO - 'USER': 'cltbld', 05:53:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:14 INFO - 'XPC_FLAGS': '0x0', 05:53:14 INFO - 'XPC_SERVICE_NAME': '0', 05:53:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:14 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-GMJ6D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:14 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-SwGwIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:14 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-rTx4Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:15 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-reSgfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:15 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-QU_kZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:15 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-omkZej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:15 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-vkx4yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:15 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-qE1X6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:15 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-5XtAqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:15 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-5jumdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:15 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-h5aB6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:15 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-vp5gqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:15 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-tQVzoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:16 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-nHE0a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:16 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-uazpMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:16 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-Dfr6tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:16 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-iGUsRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:16 INFO - Running setup.py install for manifestparser 05:53:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:16 INFO - Running setup.py install for mozcrash 05:53:16 INFO - Running setup.py install for mozdebug 05:53:16 INFO - Running setup.py install for mozdevice 05:53:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:17 INFO - Running setup.py install for mozfile 05:53:17 INFO - Running setup.py install for mozhttpd 05:53:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:17 INFO - Running setup.py install for mozinfo 05:53:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:17 INFO - Running setup.py install for mozInstall 05:53:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:17 INFO - Running setup.py install for mozleak 05:53:17 INFO - Running setup.py install for mozlog 05:53:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:17 INFO - Running setup.py install for moznetwork 05:53:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:18 INFO - Running setup.py install for mozprocess 05:53:18 INFO - Running setup.py install for mozprofile 05:53:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:18 INFO - Running setup.py install for mozrunner 05:53:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:18 INFO - Running setup.py install for mozscreenshot 05:53:18 INFO - Running setup.py install for moztest 05:53:18 INFO - Running setup.py install for mozversion 05:53:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:19 INFO - Cleaning up... 05:53:19 INFO - Return code: 0 05:53:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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 0x10fbc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1addded0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, '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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:19 INFO - 'HOME': '/Users/cltbld', 05:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:19 INFO - 'LOGNAME': 'cltbld', 05:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:19 INFO - 'MOZ_NO_REMOTE': '1', 05:53:19 INFO - 'NO_EM_RESTART': '1', 05:53:19 INFO - 'PAGER': '/bin/cat', 05:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:19 INFO - 'PWD': '/builds/slave/test', 05:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:19 INFO - 'SHELL': '/bin/bash', 05:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:53:19 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:19 INFO - 'USER': 'cltbld', 05:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:19 INFO - 'XPC_FLAGS': '0x0', 05:53:19 INFO - 'XPC_SERVICE_NAME': '0', 05:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:19 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-XZUR_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:19 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-4zcvvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:19 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-Bl7g7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:19 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-C8cy5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:19 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-_67kOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:19 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-09QxJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:19 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-YL0kmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:20 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-y58EUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:20 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-j2oSob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:20 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-u9v5gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:20 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-R7tPlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:20 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-n2KHLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:20 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-JfyDuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:20 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-tgRzuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:20 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-VxAsyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:20 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-d_Fy5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:20 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-b1MMPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:23 INFO - Downloading blessings-1.6.tar.gz 05:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:23 INFO - Installing collected packages: blessings 05:53:23 INFO - Running setup.py install for blessings 05:53:23 INFO - Successfully installed blessings 05:53:23 INFO - Cleaning up... 05:53:23 INFO - Return code: 0 05:53:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:24 INFO - Reading from file tmpfile_stdout 05:53:24 INFO - Current package versions: 05:53:24 INFO - blessings == 1.6 05:53:24 INFO - blobuploader == 1.2.4 05:53:24 INFO - docopt == 0.6.1 05:53:24 INFO - functools32 == 3.2.3-2 05:53:24 INFO - jsonschema == 2.5.1 05:53:24 INFO - manifestparser == 1.1 05:53:24 INFO - mozInstall == 1.12 05:53:24 INFO - mozcrash == 0.17 05:53:24 INFO - mozdebug == 0.1 05:53:24 INFO - mozdevice == 0.48 05:53:24 INFO - mozfile == 1.2 05:53:24 INFO - mozhttpd == 0.7 05:53:24 INFO - mozinfo == 0.9 05:53:24 INFO - mozleak == 0.1 05:53:24 INFO - mozlog == 3.3 05:53:24 INFO - moznetwork == 0.27 05:53:24 INFO - mozprocess == 0.23 05:53:24 INFO - mozprofile == 0.28 05:53:24 INFO - mozrunner == 6.12 05:53:24 INFO - mozscreenshot == 0.1 05:53:24 INFO - mozsystemmonitor == 0.3 05:53:24 INFO - moztest == 0.7 05:53:24 INFO - mozversion == 1.4 05:53:24 INFO - psutil == 3.1.1 05:53:24 INFO - requests == 1.2.3 05:53:24 INFO - wsgiref == 0.1.2 05:53:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:24 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 0x10fbc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1addded0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, '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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:53:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:24 INFO - 'HOME': '/Users/cltbld', 05:53:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:24 INFO - 'LOGNAME': 'cltbld', 05:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:24 INFO - 'MOZ_NO_REMOTE': '1', 05:53:24 INFO - 'NO_EM_RESTART': '1', 05:53:24 INFO - 'PAGER': '/bin/cat', 05:53:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:24 INFO - 'PWD': '/builds/slave/test', 05:53:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:24 INFO - 'SHELL': '/bin/bash', 05:53:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:53:24 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:53:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:24 INFO - 'USER': 'cltbld', 05:53:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:24 INFO - 'XPC_FLAGS': '0x0', 05:53:24 INFO - 'XPC_SERVICE_NAME': '0', 05:53:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:53:24 INFO - Cleaning up... 05:53:24 INFO - Return code: 0 05:53:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1addded0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, '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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53: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', 'jsonschema'] in /builds/slave/test/build 05:53: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 jsonschema 05:53:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:53:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:24 INFO - 'HOME': '/Users/cltbld', 05:53:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:24 INFO - 'LOGNAME': 'cltbld', 05:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:24 INFO - 'MOZ_NO_REMOTE': '1', 05:53:24 INFO - 'NO_EM_RESTART': '1', 05:53:24 INFO - 'PAGER': '/bin/cat', 05:53:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:24 INFO - 'PWD': '/builds/slave/test', 05:53:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:24 INFO - 'SHELL': '/bin/bash', 05:53:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:53:24 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:53:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:24 INFO - 'USER': 'cltbld', 05:53:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:24 INFO - 'XPC_FLAGS': '0x0', 05:53:24 INFO - 'XPC_SERVICE_NAME': '0', 05:53:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:53:24 INFO - Cleaning up... 05:53:25 INFO - Return code: 0 05:53:25 INFO - Running post-action listener: _resource_record_post_action 05:53:25 INFO - Running post-action listener: _start_resource_monitoring 05:53:25 INFO - Starting resource monitoring. 05:53:25 INFO - [mozharness: 2016-08-19 12:53:25.030538Z] Finished create-virtualenv step (success) 05:53:25 INFO - [mozharness: 2016-08-19 12:53:25.031543Z] Running install step. 05:53:25 INFO - Running pre-action listener: _resource_record_pre_action 05:53:25 INFO - Running main action method: install 05:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:25 INFO - Reading from file tmpfile_stdout 05:53:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:25 INFO - Reading from file tmpfile_stdout 05:53:25 INFO - Output received: 05:53:25 INFO - Usage: mozinstall [options] installer 05:53:25 INFO - Options: 05:53:25 INFO - -h, --help show this help message and exit 05:53:25 INFO - -d DEST, --destination=DEST 05:53:25 INFO - Directory to install application into. [default: 05:53:25 INFO - "/builds/slave/test"] 05:53:25 INFO - --app=APP Application being installed. [default: firefox] 05:53:25 INFO - mkdir: /builds/slave/test/build/application 05:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:53:59 INFO - Reading from file tmpfile_stdout 05:53:59 INFO - Output received: 05:53:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:53:59 INFO - Running post-action listener: _resource_record_post_action 05:53:59 INFO - [mozharness: 2016-08-19 12:53:59.873406Z] Finished install step (success) 05:53:59 INFO - [mozharness: 2016-08-19 12:53:59.873559Z] Running run-tests step. 05:53:59 INFO - Running pre-action listener: _resource_record_pre_action 05:53:59 INFO - Running main action method: run_tests 05:53:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:59 INFO - 2016-08-19 05:53:59.887 screenresolution[1634:7525] starting screenresolution argv=screenresolution get 05:53:59 INFO - 2016-08-19 05:53:59.890 screenresolution[1634:7525] Display 0: 1600x1200x32@60 05:53:59 INFO - 2016-08-19 05:53:59.896 screenresolution[1635:7527] starting screenresolution argv=screenresolution list 05:53:59 INFO - Available Modes on Display 0 05:53:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:54:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:54:00 INFO - Intel Iris: 05:54:00 INFO - Chipset Model: Intel Iris 05:54:00 INFO - Type: GPU 05:54:00 INFO - Bus: Built-In 05:54:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:54:00 INFO - Vendor: Intel (0x8086) 05:54:00 INFO - Device ID: 0x0a2e 05:54:00 INFO - Revision ID: 0x0009 05:54:00 INFO - Displays: 05:54:00 INFO - Display: 05:54:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:54:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:54:00 INFO - Display Serial Number: 1600x1200 60 05:54:00 INFO - Main Display: Yes 05:54:00 INFO - Mirror: Off 05:54:00 INFO - Online: Yes 05:54:00 INFO - Rotation: Supported 05:54:00 INFO - Return code: 0 05:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:54:00 INFO - Python 2.7.3 05:54:00 INFO - Return code: 0 05:54:00 INFO - grabbing minidump binary from tooltool 05:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:00 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 0x10fb29d30>, '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 0x10f88edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb21b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:54:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:54:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:54:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:54:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:54:00 INFO - Return code: 0 05:54:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:54:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:54:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:54:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:54:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0255', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0255 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:54:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVqXuBbK6L/Render', 05:54:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:00 INFO - 'HOME': '/Users/cltbld', 05:54:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:00 INFO - 'LOGNAME': 'cltbld', 05:54:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:54:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:00 INFO - 'MOZ_NO_REMOTE': '1', 05:54:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:54:00 INFO - 'NO_EM_RESTART': '1', 05:54:00 INFO - 'PAGER': '/bin/cat', 05:54:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:00 INFO - 'PWD': '/builds/slave/test', 05:54:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:54:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:00 INFO - 'SHELL': '/bin/bash', 05:54:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3BJwbT2dX3/Listeners', 05:54:00 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 05:54:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:00 INFO - 'USER': 'cltbld', 05:54:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:00 INFO - 'XPC_FLAGS': '0x0', 05:54:00 INFO - 'XPC_SERVICE_NAME': '0', 05:54:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0255', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:54:00 INFO - mozversion application_buildid: 20160819033756 05:54:00 INFO - mozversion application_changeset: b4a5ab92903593cb47d8f8d2155f724b4527d16d 05:54:00 INFO - mozversion application_display_name: Nightly 05:54:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:54:00 INFO - mozversion application_name: Firefox 05:54:00 INFO - mozversion application_remotingname: firefox 05:54:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:54:00 INFO - mozversion application_vendor: Mozilla 05:54:00 INFO - mozversion application_version: 51.0a1 05:54:00 INFO - mozversion platform_buildid: 20160819033756 05:54:00 INFO - mozversion platform_changeset: b4a5ab92903593cb47d8f8d2155f724b4527d16d 05:54:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:54:00 INFO - mozversion platform_version: 51.0a1 05:54:00 INFO - using testdate: 1471611240 05:54:00 INFO - actual date: 1471611240 05:54:00 INFO - starting webserver on 'localhost:49275' 05:54:00 INFO - SUITE-START | Running 2 tests 05:54:00 INFO - TEST-START | dromaeo_css 05:54:00 INFO - operating with platform_type : mac_ 05:54:00 INFO - Initialising browser for dromaeo_css test... 05:54:00 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmp0WBaCV/profile http://localhost:49275/getInfo.html) 05:54:03 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 05:54:03 INFO - PROCESS | 1645 | colorDepth:24 05:54:03 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 05:54:03 INFO - PROCESS | 1645 | __metrics 05:54:03 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:54:04 INFO - TEST-INFO | 1645: exit 0 05:54:04 INFO - Browser initialized. 05:54:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:54:04 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmp0WBaCV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:16 INFO - PROCESS | 1648 | RSS: Main: 239292416 05:54:16 INFO - PROCESS | 1648 | 05:55:05 INFO - PROCESS | 1648 | 1471611305801 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:57:17 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 05:57:18 INFO - PROCESS | 1648 | RSS: Main: 254291968 05:57:18 INFO - PROCESS | 1648 | 06:00:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 06:00:21 INFO - PROCESS | 1648 | RSS: Main: 266280960 06:00:21 INFO - PROCESS | 1648 | 06:03:23 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 06:03:24 INFO - PROCESS | 1648 | RSS: Main: 271011840 06:03:24 INFO - PROCESS | 1648 | 06:06:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 06:06:27 INFO - PROCESS | 1648 | RSS: Main: 270958592 06:06:27 INFO - PROCESS | 1648 | 06:09:30 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 06:09:30 INFO - PROCESS | 1648 | RSS: Main: 275673088 06:09:30 INFO - PROCESS | 1648 | 06:12:33 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 06:12:33 INFO - PROCESS | 1648 | RSS: Main: 278593536 06:12:33 INFO - PROCESS | 1648 | 06:12:33 INFO - PROCESS | 1648 | __start_tp_report 06:12:33 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 06:12:33 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 06:12:33 INFO - PROCESS | 1648 | |i|pagename|runs| 06:12:33 INFO - PROCESS | 1648 | |0;dojo.html;2842.744153026227;3164.430402527544;3361.7814842035264;3381.384942721749;3425.640307767684;4671.4627817800965;5750.654960702355;5756.136579513075;5788.044972579524;5896.351401345849;5647.37878833328;5723.9713801431035;5807.680577568232;5834.883302333961;5862.648241105526;5152.948470515294;5197.740112994354;5266.8419947401635;5319.308489896308;5330.813421530247;5232.843014709565;5307.893842123155;5353.330833645794;5416.837494875141;5445.074337362638;4410;5159.767810448501;5193.2989046479;5233.738313084331;5237.13587258102;4458.910821783578;5170.6122040847085;5171.276021357013;5176.689398636094;5193.922091168635;4292.334688123315;5151.4333423323405;5214.843554693365;5225.608079394023;5250.212468129773;5433.510984011418;5653.886922261573;5760.107183386582;5795.536357091465;5830.562707796932;6203.503719702413;6238.781642642486;6261.749530018794;6274.529410294201;6310.148130002437;6151.507879369639;6209.192804935375;6295.748170073191;6301.08634248036;6302.149209856657;5794;5822.563307751935;5837.620554663891;5870.73581688825;5910.970445147833;6275.278342990523;6277.937220627827;6281.874362512815;6296.181496405529;6302.212223472066;6040.848978775566;6217.165936048877;6223.377662233831;6237.064440333896;6240.500759939194;6206.131141640174;6207.5654704171175;6247.5939063960695;6301.40136687014;6317.526185536103;5264.842054738364;6103.610425594294;6125.71360014393;6126.754929802758;6184.381561843779;4654.348391225231;5184.585233181337;5514.338279406497;6158.353372895871;6286.119943207955;4198.454200953917;4685.437747470325;4867.196912509467;4898.706077635282;5058.317127187783;3682.8710995115043;4398.1643487737865;4402.229609818269;4445.133199026223;4449.7775111244955;4892.902141957141;5666.97166514173;5780;5914.0241860093465;5931.199288096138;5290.867728306746;6169.198004259507;6231.594946328474;6249.875002499924;6287.49700023997;5908.940910590839;5918.763249470059;5927.673977931255;5961.701914904237;5970.552208584373;5403.270558474555;5437.483439073281;5449.536789372948;5454.181872719124;5460.426655201226;6237.877182107173;6268.091126786681;6284.025975973731;6316.336784637639;6316.9368306317265;6272.560920735505;6286.245650521967;6290.622562646256;6299.842503937255;6308.653024083719;6289.245290564979;6308.33762454954;6331.778387756406;6358.364163583605;6371.808845734636;6105.572609917263;6107.643995706967;6148.692565371624;6267.2165979252595;6296.937030629819;5005.673496523352;5887.5575484006695;5923.911141332969;5929.140274660236;6280.9685951569945;5227.764750586157;5844.853878653068;6100.23747031621;6147.293061297829;6173.938260617337;5987.461128498456;6096.420840020191;6107.037103281039;6170.722317495633;6180.721867515883;4639.443266808004;4939.950600493949;5192.299039629753;5949.196858424058;6090.330063692902;5017.974910125426;6147.047207682816;6192.783252586138;6202.5658203925295;6204.627722336674;5891.58758886891;5974.641521508724;6030.547708921936;6042.758289668364;6087.026075827846 06:12:33 INFO - PROCESS | 1648 | |1;ext.html;447.2620176708431;495.2051956609639;529.0820426559918;531.0653250279508;561.9715919866644;32299;32718.182045448877;33527.82652607156;41065.38401923973;41137.794311028476;40831.59168408315;41313.58686413135;41375.37936930941;41425.37861932066;41427;9684;9883.209343252558;9906.157976572;9929.404235745878;9970.651027214013;9706.320557560974;9788.314817962746;9792.706218813448;9810;9821.65624203153;9768.120869121813;9816.950915245414;9821.65624203153;9833.459159746248;9841.753956151082;9803.362781419184;9835.655752048715;9862.556184971694;9865.90134098657;9874.506274686237;9711.951440242825;9778.07108324708;9789.265805064648;9801.362911410806;9801.460919649417;40254.79872600648;40405.393919091235;40589;40693.796531017455;40799;2616.2151354593548;3280.425925463034;3316.4196265653413;3513.9648603513892;3520.06718219672;30355.544666830014;30631.434862822105;30800.8459957701;31606.525902111487;31716.841415793006;3141.19899425645;3157.4000939821362;3180.9522857157162;3218.1954511372155;3228.6448490666007;434849;438157.8092109519;438584;441771;442097.7895110536;28438.715612844022;33582;33686;33734.83132584322;33830.80099793505;34002.14994625154;34599.962001140004;34744.82627586897;35288.11779705528;35319;16771.161441927856;16801.495955121365;16833.158342082847;16915.577110572332;16931.915340423464;10718.088962438123;12989;12991.805122923164;13005.089643724848;13019.544315949086;16045.839541604668;18967.90516047411;19193.616127677367;19213.807861921483;19236.84578925269;7907.525548467111;8104.394236609761;8162.224588664068;8185;8207.440586288705;837.4305472278909;870.4777133719717;935.0976307862945;1008.4907121903539;1037.662759603117;30944.226394339872;31308;31400.685993140232;31879.681203187673;32193.839030804695;997.6408492942535;1000.9599616015423;1057.724991502215;1071.2057304015743;1147.3517462633586;15508.767368489482;15528.456504022304;15606.751459883182;16123.919380403024;16628.916855415646;560085;685951;687761;688005;689781;60447.39552604505;60940.781184376065;60964;61125.69437152786;61176;1318.4989703912452;1327.462377737018;1362.148657089339;1364.0724307471014;1368.1449094316054;24506.264812055666;29951.951681691036;30632.693673063877;30869.67824504616;31205.68794312028;52993.73503132614;53220.73389633182;53420;53524.732376337866;53558.983076268654;556852;560786;561477;562074;562277.3772262225;27338.179854604394;27596.586051208847;27611.447771044066;27677.30806729848;27679.30801729973;48612.75693621509;48800.5119948796;48898;49804;49873.25190122223;39523.40714889221;40408.58569950038;40764.38853417142;40945.59054409418;41486.377704335064;31538.211544711565;40013.99965000782;40028.39886404511;40426.1914761709;41297.76106716803;39666.40500392439;39758;39808.60191398049;40720.79639601783;40889.773306800846;33442;35925.46111808273;36474.27051459009;36632.633673662924;36646;22309.665355020014;25897.741022589533;26247.868760656074;26543.86728066347;26635.7336426641 06:12:33 INFO - PROCESS | 1648 | |2;jquery.html;364.62990065083943;372.4004352991683;376.91896242307905;379.9886003419898;394.15847166299943;19998.400047998548;21529.56940861182;22078.116875324988;22112.557748845014;22295;16648.417305394312;18205.544861378472;19405;20441.18235270591;21554.245601403916;4714.434267887858;5348.197770334462;6046.425589568995;6160.675454777222;6174.50603951685;6096.786612468564;6138.263408391;6153.7846175383875;6156.445919867211;6177.536684748639;5443.455654434545;6099.146119543268;6506.577072490297;6546.639934803584;6566.540342176049;5985.341612422651;6052.636841789506;6075.210222671069;6505.1543299371015;6623.569467984566;5034.219695947134;5779.9307128181;5934.406559344075;5939.940600593982;5986.910196347058;12890.419931103123;13223.933880330536;13337.466501340032;13374.063815532916;13385.66535836602;2025.5341271507489;2072.7409073865765;2114.7145135406677;2404.0744313439277;2929.3848291858735;10067.798644027152;10223.182145428422;10223.846642300372;11558.53765849365;11739.823902641467;1877.521232085823;1896.3173257627243;1916.6358391905494;1940.5439721665539;2018.5559176981042;121084;127851;129127;129597.33623973794;129852.35073824665;10144.391336519684;10153.746156346002;10306;10444.947775261075;11352.318860868374;14104.294785260696;14108.929455352658;14113.576592702235;14120;14121.929390352983;8317.708880189164;8466.661333546712;8472.74581762548;8485.703000394957;8621.870671939925;7237.746678866214;8492.51381008321;8514.659413623385;8632.35257355701;8707.956460217658;4410.889727756768;4455.955440445554;4509.143262780061;4513.68404211702;4576.558384108995;1862.590230149392;1932.3623204342534;1937.3509874192303;1944.9416517504499;1957.4225603447017;860.7632900952289;916.7845556294266;1017.9236557258236;1018.4551265073151;1053.1522124689698;21030.684539731916;22121.446963826034;22170;22204.11183552672;22643.320700379016;819.7581713394563;936.1995493852794;938.9953050234842;952.3476418653245;967.2213867836318;10728.624498142684;11532.88467115318;11540.942295288638;11613;11657.825132623017;521531;522862;526236;619577;645072.5492745106;92367.53816230876;114989.4250528742;116247;136606;142866;962.1100482054212;1012.4785735346303;1025.2157099818644;1026.5637104230673;1031.4687935713114;15714.371425142866;18840.811591884452;19742.50643733918;19858.801411985696;19892.801071989095;55991.72004139953;57126;57365;57421.71289143527;58078.70960645339;76050.6197469009;78350.6082469584;80528.59735701284;80990.59504702438;84755;7649.655765490677;7659.540427574363;7754.379649627904;7903.407244456574;8018.158093400342;10416.531256093342;12309.630711078324;12433;12512.812307815208;12550.497980080694;10644;10651.520681569504;10675.412852293199;10755.838662419914;11020.338779673246;10500.422476763546;10777.515011824644;10950.288231264942;11009.009189173014;11024.834627480755;10872.945635271773;10952.616658416917;11186.83219751688;11298.717532061764;11410.714732131763;6290.528210384148;7746.767596972099;7787.5716835574585;7826.295633393022;7947.8807817881625;10228.28402011852;10254.897451025394;10691.893081069089;10728.73178170552;10764.300320479144 06:12:33 INFO - PROCESS | 1648 | |3;mootools.html;1488.5040534263067;1494.7458931981564;1692.1962068017685;1815.2013114229746;1818.9818101818978;7991.92008079919;8499.575021248937;8627.784305392353;9080.409773364727;9117;8589.18402751739;8818.691345802883;8844.823103537925;8845.292376609872;8859.335549833757;2377.084822343402;2398.712154541449;2403.0507949359994;2409.7469765674614;2410.6143017117265;1987.9801201988012;2350.6239001759723;2384.0582969726947;2384.606539920911;2394.832361734679;2031.6444622191057;2189.9233526826565;2363.302825666424;2376.061455724988;2384.1655420602738;1979.5051237190703;2336.6378211377264;2353.7410884802657;2358.929232123039;2361.031976889467;2328.6507023946374;2342.5666251743482;2342.906283748665;2343.7890589846997;2356.2813341930705;8049.436539442183;8971.237444817198;8988;9015.549222538912;9039.819203615956;5244.239585260154;5451.48210919962;5451.754671039773;5453.481919217668;5475.425080366544;3119.984400077985;3310;3601.423772196436;3648.799316037617;3652.981735091334;1092.639428988432;1104.304288298375;1749.9737503937451;1819.1177279019664;1884.896330701811;11148.888511114867;11511.539538418454;11644.941775291154;11646.301221926627;11706.707332316675;3952.505936757905;4433.46798384196;4481.014176881081;4648.48866624671;4660.603848672901;9135.543222838964;9216.354855160209;9216.815663686688;9220.723378298662;9230.261579073658;5211.2443695663915;5242.816501422508;5259.289995850511;5280.234366016983;5285.709285989231;4382.802773875183;4778.808847646124;4933.383327084114;4956.553910148104;4975.676581022222;3666.8533258669354;3779.149691319431;3805.5623603285976;3817.6945844332386;3865.072382628205;1169.1348402182493;1177.7408970026581;1181.8995385392166;1187.625897842177;1189.9881001189876;815.604431850552;923.3305853256336;935.5556110847293;944.622151139536;971.7667759737753;5859.560532960045;5997.640141591519;6128.78549250783;6151;6199.659018753921;366.83309094362;426.8932766808298;444.64650602770877;450.20988165768864;454.11447677029264;3965.5439624442984;4071.226466971266;4112.979435102805;4174.3112386456505;4205.285101532747;8543.401961862734;10897.073748731287;10900.291481053706;10921.617743379102;10944.890551094388;9025.277977761894;10613.363198207977;10841.457927103771;10881.67354979336;10888.67333979982;6245.843853903689;8193.221643943816;8254.174582541818;8261.545614991233;8296.502209867427;5408.621396502207;5975.671338076274;5984.670843103671;6060.454559089703;6069.180660610938;9327.347085703936;10089.29374943747;10127.594896204364;10142.087212150942;10175.796484070424;9728.513574321114;10223.846642300521;10277.229207809294;10341.4312212829;10354;7007.159140903124;7416.666250018654;7537.849243014999;7556.508826926232;7698.92301076982;8516.489010659132;8534;8558.657653694032;8573.485590864319;8594.957025214833;7326.81682957909;7555.206703296075;7565.546067235983;7678.692852285846;7685.308322251024;6548.770793022221;7283.708651653875;7468.290512401313;7468.9626551866895;7578.810529736801;6985.0220969065385;7036.718531258693;7049.823754406181;7056.470764692566;7057.682404291922;5022.171341728574;5096.949030509648;5182.585393168462;5185.299984502044;5192;4503.099380123923;4561.7262964222255;4674.813007479799;5151.201563757623;5327.334083239595 06:12:33 INFO - PROCESS | 1648 | |4;prototype.html;295.8180718857903;296.37317074387664;301.7043297568383;307.1384765732121;309.35190775325697;4720.339152518646;5316.78732850686;5512.91730624041;5615.185798059279;5706.9143962840535;4943.777530011149;5573.4147914469;5715.799947001856;5725.656460612367;5725.969325521404;4281.957180428202;4304.354346847967;4316.6978311518205;4318.719283246594;4319.287317592609;3441.7418693597956;3489.232368878855;3720.3489389356755;4311.5472875348105;4320.762358070305;4191.916161676764;4198.265303571878;4198.958010419902;4214.515330736958;4226.830926762926;3541.291741651667;3562.750607457479;4225.302825033866;4242.109157076987;4258.361245813137;3650.3064417760543;3665.6151104133946;3666.5416822897137;3669.1377526281303;3685;4883;5217.034848553029;5462.890742185134;5514.92458970501;5576;4819.325294458778;4838.177509823338;4869.415670119608;4900.010993294088;4910.312556242129;4906.215005599087;5015.84952451427;5573.526250268732;6024.457798798086;6050.939490605126;3179.6979286967703;3393.9660603394145;3713.3316003119426;3738.738288319819;3926.980365098185;5448.945510544883;6369.617822930639;6372.458341041017;6379.808605741835;6430.517711171634;3423.7774544654517;3953.932438241716;4066.207089617496;4078.3066878630702;4098.057446787196;4040.777757223381;4105.803395183562;4112.3420252759415;4115.6006957634545;4131;4325.637424211363;4502.977485112553;4616.446026476844;4820.734859582686;4823.107725070873;5203.843884683465;5267.9736601316745;5779.162021506858;5795.348325727232;5988.610740301867;1142.7942970265433;1259.93535462534;1275.1775105057186;1323.7622822660842;1400.838903526087;802.1937952357843;824.7773101262745;839.6137776622822;843.8185790055168;848.0163010907318;3887.319719049155;4223.852165174204;4331;4622.907541849144;4774.140654682121;4666.393368862026;4820.3369837406035;4841.588464980446;5154.809206087398;5157.381114266312;4251.80866860992;4267.445232119867;4619.3806193806195;4699.2481203007355;4742.264948932921;2400.675908752331;2435.4641978764644;2509.460465999819;2548.3817775712555;2646.801489888266;4752.049590081998;4949;5045.571126454219;5311.840644780663;5337.306150200527;4343.82624695015;5212.348456442945;5274.446183150791;5278.683279003272;5293.867653308698;4732.834350797705;4882.755862206946;4995.325631039836;5239.318888544465;5334.759401051568;4274.871753847389;4385.517593064824;5109.156989096758;5189.870253243548;5194.532492075731;4663.626909847137;5034.421041580265;5068.670536415121;5092.294081482744;5096.413912400121;4202.411662367333;4515.525869783625;4962.791557756764;5205.189197833279;5365.731713414391;3177.269228077509;3179.9682003179673;3192.7765056445824;3222.258880457555;3574.7855128692363;4393.143337049245;4693;4728.71627702339;5119.644963316767;5621.297337832771;5623.746931388016;5932.436418540232;5971.133855749178;6013.548983826318;6034.758609655741;5925.644461332334;5931.466168044896;5931.614445061057;5940.6435613863305;6003.789867354796;5539.25220095282;5784.94215057844;5812.505936995402;5873.177755114202;5892.7642894283745;5061.569766569883;6020.8795824084145;6025.367336429612;6031.879362412815;6044.615015591283;4602.7468489233415;5343.732813359395;5838.12428135783;5878.265216847894;5888.49738860991 06:12:33 INFO - PROCESS | 1648 | |5;yui.html;671.763602716822;695.4275637682241;708.8334241453258;758.1849511774843;846.6867259114129;14566.417343306268;15685.764713529306;16055.598610034755;16562.089085100313;16653.084080375604;15014.699706005873;15217.163056031914;15434.354236600007;16080.356785728556;16255.024698518067;832.9750107496785;838.7944953486374;851.2381418630322;853.4964371021097;856.0839901305606;499.69828596506125;656.668382466856;672.5628341577989;744.4491076603329;839.9874001889976;892.4689809563299;897.833900728364;902.801383695586;904.416651259937;906.1210625693067;886.5434301334818;903.2051794420901;906.474244937941;908.1599520443564;908.4095338030268;657.0374401501823;657.6120089147425;665.4476784269093;666.0708311904865;666.3303380103014;14698.632534186623;14773.556793296219;15913.602159945978;15915.681686366324;16107.114108724016;14391.2084835334;14395.064320819218;14433.927830360886;14619.342129604192;14624.780628290478;11772.293662380285;11899.583514577034;12244.81632775509;12263.325517096557;12655.873441265561;3844.1350696093436;3854.1520865409566;3869.3808990561374;3965.9801700991597;4015.7992100395154;112488.43755781169;115075.84924150736;115746;116867;117460.8253917467;11174.497147628375;11192.944035279934;11261.943690281496;11284.097272218367;11600.535978560933;21969;22312.77687223107;22373.216937407113;22435.887820560794;22551.661725074136;7954.085280192852;8169.63236654352;8183.508989460652;8213.34293256538;8347.749567512985;4565.954340456619;4601.608863246594;4651.693192523193;4663.533646635377;4764.1657961685005;3618.9638103618627;3697.6487233712755;3710.6474884885893;3727.1241258304276;3735.028892487973;535.74552087758;602.8124594548732;631.0912286307703;664.4485077385758;689.8413364925995;588.8763359694426;619.6213425129051;647.2104033079635;648.5233353485185;678.3928384096206;7445.627718614048;8608.698695545625;8790.340724445692;9393.342466027449;9523.809523809485;509.21834983300454;621.5307442880596;626.8028066393167;633.7179954920108;676.1649363036646;4289.806958686867;4474.597286244189;4727.2436410174205;4748.287756836502;4841.757912104381;99193;145744;146677;157479.21260393623;162067.18966405094;114173;137368.31315843356;138666;142234;145198.2740086293;78413.60793195998;94488.52755736177;109839.35240971232;120715;121011.78988210358;8438.409311348147;8872.072216168519;8894.110588941054;8897.466152030898;8903.777405564913;46544.00646735556;64464.45445500543;65248.67375663092;65730.34269657434;67409;96815;99955.50022249842;103496;103658.48170759098;105362.47318763357;11807.468663909973;11808.82286765682;11838.822417663914;11857.940710296394;12160.148789584999;12881;13051;13494.460221591418;14346.928265358607;15252.161131137895;10649.44220753751;13104.017198709944;13106.410211540313;13980.650483737987;14058.507952221624;11289.37908415045;12339.814902776287;13592.93203533976;13903.791443128159;13957.371918263905;11614.70963225926;12803.423845926769;13398;14164.78752818688;14334.713305734036;10645.574177032831;11083.72290692739;11161.832572511257;11519.481623327138;11663.24188927717;8150.551719655476;9680.467574283482;10600.416977066336;11448.542058317575;11486 06:12:33 INFO - PROCESS | 1648 | __end_tp_report 06:12:33 INFO - PROCESS | 1648 | __start_cc_report 06:12:33 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,423 06:12:33 INFO - PROCESS | 1648 | __end_cc_report 06:12:33 INFO - PROCESS | 1648 | __startTimestamp1471612353645__endTimestamp 06:12:33 INFO - PROCESS | 1648 | 06:12:33 INFO - PROCESS | 1648 | ------- Summary: start ------- 06:12:33 INFO - PROCESS | 1648 | Number of tests: 6 06:12:33 INFO - PROCESS | 1648 | 06:12:33 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5663.87 Median:5910.97 stddev:715.21 (12.1%) stddev-sans-first:682.31 06:12:33 INFO - PROCESS | 1648 | Values: 2842.7 3164.4 3361.8 3381.4 3425.6 4671.5 5750.7 5756.1 5788.0 5896.4 5647.4 5724.0 5807.7 5834.9 5862.6 5152.9 5197.7 5266.8 5319.3 5330.8 5232.8 5307.9 5353.3 5416.8 5445.1 4410.0 5159.8 5193.3 5233.7 5237.1 4458.9 5170.6 5171.3 5176.7 5193.9 4292.3 5151.4 5214.8 5225.6 5250.2 5433.5 5653.9 5760.1 5795.5 5830.6 6203.5 6238.8 6261.7 6274.5 6310.1 6151.5 6209.2 6295.7 6301.1 6302.1 5794.0 5822.6 5837.6 5870.7 5911.0 6275.3 6277.9 6281.9 6296.2 6302.2 6040.8 6217.2 6223.4 6237.1 6240.5 6206.1 6207.6 6247.6 6301.4 6317.5 5264.8 6103.6 6125.7 6126.8 6184.4 4654.3 5184.6 5514.3 6158.4 6286.1 4198.5 4685.4 4867.2 4898.7 5058.3 3682.9 4398.2 4402.2 4445.1 4449.8 4892.9 5667.0 5780.0 5914.0 5931.2 5290.9 6169.2 6231.6 6249.9 6287.5 5908.9 5918.8 5927.7 5961.7 5970.6 5403.3 5437.5 5449.5 5454.2 5460.4 6237.9 6268.1 6284.0 6316.3 6316.9 6272.6 6286.2 6290.6 6299.8 6308.7 6289.2 6308.3 6331.8 6358.4 6371.8 6105.6 6107.6 6148.7 6267.2 6296.9 5005.7 5887.6 5923.9 5929.1 6281.0 5227.8 5844.9 6100.2 6147.3 6173.9 5987.5 6096.4 6107.0 6170.7 6180.7 4639.4 4940.0 5192.3 5949.2 6090.3 5018.0 6147.0 6192.8 6202.6 6204.6 5891.6 5974.6 6030.5 6042.8 6087.0 06:12:33 INFO - PROCESS | 1648 | 06:12:33 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:67852.43 Median:40141.60 stddev:150471.46 (374.9%) stddev-sans-first:150808.47 06:12:33 INFO - PROCESS | 1648 | Values: 447.3 495.2 529.1 531.1 562.0 32299.0 32718.2 33527.8 41065.4 41137.8 40831.6 41313.6 41375.4 41425.4 41427.0 9684.0 9883.2 9906.2 9929.4 9970.7 9706.3 9788.3 9792.7 9810.0 9821.7 9768.1 9817.0 9821.7 9833.5 9841.8 9803.4 9835.7 9862.6 9865.9 9874.5 9712.0 9778.1 9789.3 9801.4 9801.5 40254.8 40405.4 40589.0 40693.8 40799.0 2616.2 3280.4 3316.4 3514.0 3520.1 30355.5 30631.4 30800.8 31606.5 31716.8 3141.2 3157.4 3181.0 3218.2 3228.6 434849.0 438157.8 438584.0 441771.0 442097.8 28438.7 33582.0 33686.0 33734.8 33830.8 34002.1 34600.0 34744.8 35288.1 35319.0 16771.2 16801.5 16833.2 16915.6 16931.9 10718.1 12989.0 12991.8 13005.1 13019.5 16045.8 18967.9 19193.6 19213.8 19236.8 7907.5 8104.4 8162.2 8185.0 8207.4 837.4 870.5 935.1 1008.5 1037.7 30944.2 31308.0 31400.7 31879.7 32193.8 997.6 1001.0 1057.7 1071.2 1147.4 15508.8 15528.5 15606.8 16123.9 16628.9 560085.0 685951.0 687761.0 688005.0 689781.0 60447.4 60940.8 60964.0 61125.7 61176.0 1318.5 1327.5 1362.1 1364.1 1368.1 24506.3 29952.0 30632.7 30869.7 31205.7 52993.7 53220.7 53420.0 53524.7 53559.0 556852.0 560786.0 561477.0 562074.0 562277.4 27338.2 27596.6 27611.4 27677.3 27679.3 48612.8 48800.5 48898.0 49804.0 49873.3 39523.4 40408.6 40764.4 40945.6 41486.4 31538.2 40014.0 40028.4 40426.2 41297.8 39666.4 39758.0 39808.6 40720.8 40889.8 33442.0 35925.5 36474.3 36632.6 36646.0 22309.7 25897.7 26247.9 26543.9 26635.7 06:12:33 INFO - PROCESS | 1648 | 06:12:33 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:34045.59 Median:21541.91 stddev:95583.31 (443.7%) stddev-sans-first:95818.00 06:12:33 INFO - PROCESS | 1648 | Values: 364.6 372.4 376.9 380.0 394.2 19998.4 21529.6 22078.1 22112.6 22295.0 16648.4 18205.5 19405.0 20441.2 21554.2 4714.4 5348.2 6046.4 6160.7 6174.5 6096.8 6138.3 6153.8 6156.4 6177.5 5443.5 6099.1 6506.6 6546.6 6566.5 5985.3 6052.6 6075.2 6505.2 6623.6 5034.2 5779.9 5934.4 5939.9 5986.9 12890.4 13223.9 13337.5 13374.1 13385.7 2025.5 2072.7 2114.7 2404.1 2929.4 10067.8 10223.2 10223.8 11558.5 11739.8 1877.5 1896.3 1916.6 1940.5 2018.6 121084.0 127851.0 129127.0 129597.3 129852.4 10144.4 10153.7 10306.0 10444.9 11352.3 14104.3 14108.9 14113.6 14120.0 14121.9 8317.7 8466.7 8472.7 8485.7 8621.9 7237.7 8492.5 8514.7 8632.4 8708.0 4410.9 4456.0 4509.1 4513.7 4576.6 1862.6 1932.4 1937.4 1944.9 1957.4 860.8 916.8 1017.9 1018.5 1053.2 21030.7 22121.4 22170.0 22204.1 22643.3 819.8 936.2 939.0 952.3 967.2 10728.6 11532.9 11540.9 11613.0 11657.8 521531.0 522862.0 526236.0 619577.0 645072.5 92367.5 114989.4 116247.0 136606.0 142866.0 962.1 1012.5 1025.2 1026.6 1031.5 15714.4 18840.8 19742.5 19858.8 19892.8 55991.7 57126.0 57365.0 57421.7 58078.7 76050.6 78350.6 80528.6 80990.6 84755.0 7649.7 7659.5 7754.4 7903.4 8018.2 10416.5 12309.6 12433.0 12512.8 12550.5 10644.0 10651.5 10675.4 10755.8 11020.3 10500.4 10777.5 10950.3 11009.0 11024.8 10872.9 10952.6 11186.8 11298.7 11410.7 6290.5 7746.8 7787.6 7826.3 7947.9 10228.3 10254.9 10691.9 10728.7 10764.3 06:12:33 INFO - PROCESS | 1648 | 06:12:33 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5674.96 Median:4856.10 stddev:3178.58 (65.5%) stddev-sans-first:3171.93 06:12:33 INFO - PROCESS | 1648 | Values: 1488.5 1494.7 1692.2 1815.2 1819.0 7991.9 8499.6 8627.8 9080.4 9117.0 8589.2 8818.7 8844.8 8845.3 8859.3 2377.1 2398.7 2403.1 2409.7 2410.6 1988.0 2350.6 2384.1 2384.6 2394.8 2031.6 2189.9 2363.3 2376.1 2384.2 1979.5 2336.6 2353.7 2358.9 2361.0 2328.7 2342.6 2342.9 2343.8 2356.3 8049.4 8971.2 8988.0 9015.5 9039.8 5244.2 5451.5 5451.8 5453.5 5475.4 3120.0 3310.0 3601.4 3648.8 3653.0 1092.6 1104.3 1750.0 1819.1 1884.9 11148.9 11511.5 11644.9 11646.3 11706.7 3952.5 4433.5 4481.0 4648.5 4660.6 9135.5 9216.4 9216.8 9220.7 9230.3 5211.2 5242.8 5259.3 5280.2 5285.7 4382.8 4778.8 4933.4 4956.6 4975.7 3666.9 3779.1 3805.6 3817.7 3865.1 1169.1 1177.7 1181.9 1187.6 1190.0 815.6 923.3 935.6 944.6 971.8 5859.6 5997.6 6128.8 6151.0 6199.7 366.8 426.9 444.6 450.2 454.1 3965.5 4071.2 4113.0 4174.3 4205.3 8543.4 10897.1 10900.3 10921.6 10944.9 9025.3 10613.4 10841.5 10881.7 10888.7 6245.8 8193.2 8254.2 8261.5 8296.5 5408.6 5975.7 5984.7 6060.5 6069.2 9327.3 10089.3 10127.6 10142.1 10175.8 9728.5 10223.8 10277.2 10341.4 10354.0 7007.2 7416.7 7537.8 7556.5 7698.9 8516.5 8534.0 8558.7 8573.5 8595.0 7326.8 7555.2 7565.5 7678.7 7685.3 6548.8 7283.7 7468.3 7469.0 7578.8 6985.0 7036.7 7049.8 7056.5 7057.7 5022.2 5096.9 5182.6 5185.3 5192.0 4503.1 4561.7 4674.8 5151.2 5327.3 06:12:33 INFO - PROCESS | 1648 | 06:12:33 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4456.73 Median:4830.64 stddev:1403.41 (29.1%) stddev-sans-first:1372.16 06:12:33 INFO - PROCESS | 1648 | Values: 295.8 296.4 301.7 307.1 309.4 4720.3 5316.8 5512.9 5615.2 5706.9 4943.8 5573.4 5715.8 5725.7 5726.0 4282.0 4304.4 4316.7 4318.7 4319.3 3441.7 3489.2 3720.3 4311.5 4320.8 4191.9 4198.3 4199.0 4214.5 4226.8 3541.3 3562.8 4225.3 4242.1 4258.4 3650.3 3665.6 3666.5 3669.1 3685.0 4883.0 5217.0 5462.9 5514.9 5576.0 4819.3 4838.2 4869.4 4900.0 4910.3 4906.2 5015.8 5573.5 6024.5 6050.9 3179.7 3394.0 3713.3 3738.7 3927.0 5448.9 6369.6 6372.5 6379.8 6430.5 3423.8 3953.9 4066.2 4078.3 4098.1 4040.8 4105.8 4112.3 4115.6 4131.0 4325.6 4503.0 4616.4 4820.7 4823.1 5203.8 5268.0 5779.2 5795.3 5988.6 1142.8 1259.9 1275.2 1323.8 1400.8 802.2 824.8 839.6 843.8 848.0 3887.3 4223.9 4331.0 4622.9 4774.1 4666.4 4820.3 4841.6 5154.8 5157.4 4251.8 4267.4 4619.4 4699.2 4742.3 2400.7 2435.5 2509.5 2548.4 2646.8 4752.0 4949.0 5045.6 5311.8 5337.3 4343.8 5212.3 5274.4 5278.7 5293.9 4732.8 4882.8 4995.3 5239.3 5334.8 4274.9 4385.5 5109.2 5189.9 5194.5 4663.6 5034.4 5068.7 5092.3 5096.4 4202.4 4515.5 4962.8 5205.2 5365.7 3177.3 3180.0 3192.8 3222.3 3574.8 4393.1 4693.0 4728.7 5119.6 5621.3 5623.7 5932.4 5971.1 6013.5 6034.8 5925.6 5931.5 5931.6 5940.6 6003.8 5539.3 5784.9 5812.5 5873.2 5892.8 5061.6 6020.9 6025.4 6031.9 6044.6 4602.7 5343.7 5838.1 5878.3 5888.5 06:12:33 INFO - PROCESS | 1648 | 06:12:33 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:25134.72 Median:3718.89 stddev:40415.43 (1086.8%) stddev-sans-first:40487.07 06:12:33 INFO - PROCESS | 1648 | Values: 671.8 695.4 708.8 758.2 846.7 14566.4 15685.8 16055.6 16562.1 16653.1 15014.7 15217.2 15434.4 16080.4 16255.0 833.0 838.8 851.2 853.5 856.1 499.7 656.7 672.6 744.4 840.0 892.5 897.8 902.8 904.4 906.1 886.5 903.2 906.5 908.2 908.4 657.0 657.6 665.4 666.1 666.3 14698.6 14773.6 15913.6 15915.7 16107.1 14391.2 14395.1 14433.9 14619.3 14624.8 11772.3 11899.6 12244.8 12263.3 12655.9 3844.1 3854.2 3869.4 3966.0 4015.8 112488.4 115075.8 115746.0 116867.0 117460.8 11174.5 11192.9 11261.9 11284.1 11600.5 21969.0 22312.8 22373.2 22435.9 22551.7 7954.1 8169.6 8183.5 8213.3 8347.7 4566.0 4601.6 4651.7 4663.5 4764.2 3619.0 3697.6 3710.6 3727.1 3735.0 535.7 602.8 631.1 664.4 689.8 588.9 619.6 647.2 648.5 678.4 7445.6 8608.7 8790.3 9393.3 9523.8 509.2 621.5 626.8 633.7 676.2 4289.8 4474.6 4727.2 4748.3 4841.8 99193.0 145744.0 146677.0 157479.2 162067.2 114173.0 137368.3 138666.0 142234.0 145198.3 78413.6 94488.5 109839.4 120715.0 121011.8 8438.4 8872.1 8894.1 8897.5 8903.8 46544.0 64464.5 65248.7 65730.3 67409.0 96815.0 99955.5 103496.0 103658.5 105362.5 11807.5 11808.8 11838.8 11857.9 12160.1 12881.0 13051.0 13494.5 14346.9 15252.2 10649.4 13104.0 13106.4 13980.7 14058.5 11289.4 12339.8 13592.9 13903.8 13957.4 11614.7 12803.4 13398.0 14164.8 14334.7 10645.6 11083.7 11161.8 11519.5 11663.2 8150.6 9680.5 10600.4 11448.5 11486.0 06:12:33 INFO - PROCESS | 1648 | -------- Summary: end -------- 06:12:33 INFO - PROCESS | 1648 | 06:12:34 INFO - TEST-INFO | 1648: exit 0 06:12:34 INFO - TEST-OK | dromaeo_css | took 1113753ms 06:12:34 INFO - TEST-START | kraken 06:12:34 INFO - operating with platform_type : mac_ 06:12:34 INFO - Initialising browser for kraken test... 06:12:34 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmp5a1YK7/profile http://localhost:49275/getInfo.html) 06:12:37 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 06:12:37 INFO - PROCESS | 1660 | colorDepth:24 06:12:37 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 06:12:37 INFO - PROCESS | 1660 | __metrics 06:12:37 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 06:12:37 INFO - TEST-INFO | 1660: exit 0 06:12:37 INFO - Browser initialized. 06:12:37 INFO - Running cycle 1/1 for kraken test... 06:12:37 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmp5a1YK7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:49 INFO - PROCESS | 1662 | RSS: Main: 239529984 06:12:49 INFO - PROCESS | 1662 | 06:12:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:53 INFO - PROCESS | 1662 | RSS: Main: 252227584 06:12:53 INFO - PROCESS | 1662 | 06:12:56 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 06:12:57 INFO - PROCESS | 1662 | RSS: Main: 260931584 06:12:57 INFO - PROCESS | 1662 | 06:13:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 06:13:01 INFO - PROCESS | 1662 | RSS: Main: 263774208 06:13:01 INFO - PROCESS | 1662 | 06:13:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 06:13:03 INFO - PROCESS | 1662 | RSS: Main: 265125888 06:13:03 INFO - PROCESS | 1662 | 06:13:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:13:06 INFO - PROCESS | 1662 | RSS: Main: 266940416 06:13:06 INFO - PROCESS | 1662 | 06:13:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:10 INFO - PROCESS | 1662 | RSS: Main: 267026432 06:13:10 INFO - PROCESS | 1662 | 06:13:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:13 INFO - PROCESS | 1662 | RSS: Main: 267157504 06:13:13 INFO - PROCESS | 1662 | 06:13:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 06:13:17 INFO - PROCESS | 1662 | RSS: Main: 267448320 06:13:17 INFO - PROCESS | 1662 | 06:13:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:20 INFO - PROCESS | 1662 | RSS: Main: 267075584 06:13:20 INFO - PROCESS | 1662 | 06:13:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:22 INFO - PROCESS | 1662 | RSS: Main: 267210752 06:13:22 INFO - PROCESS | 1662 | 06:13:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:25 INFO - PROCESS | 1662 | RSS: Main: 267423744 06:13:25 INFO - PROCESS | 1662 | 06:13:28 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:29 INFO - PROCESS | 1662 | RSS: Main: 267436032 06:13:29 INFO - PROCESS | 1662 | 06:13:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:32 INFO - PROCESS | 1662 | RSS: Main: 267653120 06:13:32 INFO - PROCESS | 1662 | 06:13:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 06:13:35 INFO - PROCESS | 1662 | RSS: Main: 268865536 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | __start_tp_report 06:13:35 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 06:13:35 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 06:13:35 INFO - PROCESS | 1662 | |i|pagename|runs| 06:13:35 INFO - PROCESS | 1662 | |0;ai-astar;110;117;109;117;117;117;120;147;173;119 06:13:35 INFO - PROCESS | 1662 | |1;audio-beat-detection;184;143;167;155;112;129;130;109;160;110 06:13:35 INFO - PROCESS | 1662 | |2;audio-dft;195;206;241;198;192;201;192;224;265;194 06:13:35 INFO - PROCESS | 1662 | |3;audio-fft;71;85;77;144;65;84;52;75;163;83 06:13:35 INFO - PROCESS | 1662 | |4;audio-oscillator;71;72;119;80;102;113;98;97;103;149 06:13:35 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;93;90;92;119;135;112;92;113;136;89 06:13:35 INFO - PROCESS | 1662 | |6;imaging-darkroom;97;97;97;96;118;152;115;98;98;98 06:13:35 INFO - PROCESS | 1662 | |7;imaging-desaturate;148;89;150;147;84;131;136;152;145;89 06:13:35 INFO - PROCESS | 1662 | |8;json-parse-financial;57;58;60;56;56;58;56;56;57;59 06:13:35 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;62;67;67;67;72;74;74;72;71;70 06:13:35 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;91;87;87;88;90;86;88;87;88;85 06:13:35 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;142;137;168;152;131;149;163;157;175;148 06:13:35 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;172;187;234;157;226;242;181;240;188;214 06:13:35 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;83;69;71;67;62;62;69;79;91;91 06:13:35 INFO - PROCESS | 1662 | __end_tp_report 06:13:35 INFO - PROCESS | 1662 | __start_cc_report 06:13:35 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1048 06:13:35 INFO - PROCESS | 1662 | __end_cc_report 06:13:35 INFO - PROCESS | 1662 | __startTimestamp1471612415026__endTimestamp 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | ------- Summary: start ------- 06:13:35 INFO - PROCESS | 1662 | Number of tests: 14 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:124.60 Median:118.00 stddev:19.96 (16.9%) stddev-sans-first:20.46 06:13:35 INFO - PROCESS | 1662 | Values: 110.0 117.0 109.0 117.0 117.0 117.0 120.0 147.0 173.0 119.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:149.00 stddev:26.17 (17.6%) stddev-sans-first:22.37 06:13:35 INFO - PROCESS | 1662 | Values: 184.0 143.0 167.0 155.0 112.0 129.0 130.0 109.0 160.0 110.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:210.80 Median:203.50 stddev:24.82 (12.2%) stddev-sans-first:25.66 06:13:35 INFO - PROCESS | 1662 | Values: 195.0 206.0 241.0 198.0 192.0 201.0 192.0 224.0 265.0 194.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:89.90 Median:76.00 stddev:35.24 (46.4%) stddev-sans-first:36.71 06:13:35 INFO - PROCESS | 1662 | Values: 71.0 85.0 77.0 144.0 65.0 84.0 52.0 75.0 163.0 83.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:100.40 Median:71.50 stddev:23.52 (32.9%) stddev-sans-first:22.42 06:13:35 INFO - PROCESS | 1662 | Values: 71.0 72.0 119.0 80.0 102.0 113.0 98.0 97.0 103.0 149.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:107.10 Median:89.50 stddev:18.53 (20.7%) stddev-sans-first:18.93 06:13:35 INFO - PROCESS | 1662 | Values: 93.0 90.0 92.0 119.0 135.0 112.0 92.0 113.0 136.0 89.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:106.60 Median:97.00 stddev:17.86 (18.4%) stddev-sans-first:18.61 06:13:35 INFO - PROCESS | 1662 | Values: 97.0 97.0 97.0 96.0 118.0 152.0 115.0 98.0 98.0 98.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:127.10 Median:151.00 stddev:28.19 (18.7%) stddev-sans-first:28.87 06:13:35 INFO - PROCESS | 1662 | Values: 148.0 89.0 150.0 147.0 84.0 131.0 136.0 152.0 145.0 89.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:1.42 (2.5%) stddev-sans-first:1.50 06:13:35 INFO - PROCESS | 1662 | Values: 57.0 58.0 60.0 56.0 56.0 58.0 56.0 56.0 57.0 59.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:71.50 stddev:3.81 (5.3%) stddev-sans-first:2.88 06:13:35 INFO - PROCESS | 1662 | Values: 62.0 67.0 67.0 67.0 72.0 74.0 74.0 72.0 71.0 70.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.00 stddev:1.77 (2.0%) stddev-sans-first:1.41 06:13:35 INFO - PROCESS | 1662 | Values: 91.0 87.0 87.0 88.0 90.0 86.0 88.0 87.0 88.0 85.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:154.50 stddev:13.83 (9.0%) stddev-sans-first:14.17 06:13:35 INFO - PROCESS | 1662 | Values: 142.0 137.0 168.0 152.0 131.0 149.0 163.0 157.0 175.0 148.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.10 Median:220.00 stddev:30.79 (14.0%) stddev-sans-first:30.39 06:13:35 INFO - PROCESS | 1662 | Values: 172.0 187.0 234.0 157.0 226.0 242.0 181.0 240.0 188.0 214.0 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:75.00 stddev:10.95 (14.6%) stddev-sans-first:11.16 06:13:35 INFO - PROCESS | 1662 | Values: 83.0 69.0 71.0 67.0 62.0 62.0 69.0 79.0 91.0 91.0 06:13:35 INFO - PROCESS | 1662 | -------- Summary: end -------- 06:13:35 INFO - PROCESS | 1662 | 06:13:35 INFO - TEST-INFO | 1662: exit 0 06:13:35 INFO - TEST-OK | kraken | took 61630ms 06:13:35 INFO - SUITE-END | took 1175s 06:13:36 INFO - Completed test suite (00:19:35) 06:13:36 INFO - javascript benchmark 06:13:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7248.074302445674, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2842.744153026227, 3164.430402527544, 3361.7814842035264, 3381.384942721749, 3425.640307767684, 4671.4627817800965, 5750.654960702355, 5756.136579513075, 5788.044972579524, 5896.351401345849, 5647.37878833328, 5723.9713801431035, 5807.680577568232, 5834.883302333961, 5862.648241105526, 5152.948470515294, 5197.740112994354, 5266.8419947401635, 5319.308489896308, 5330.813421530247, 5232.843014709565, 5307.893842123155, 5353.330833645794, 5416.837494875141, 5445.074337362638, 4410.0, 5159.767810448501, 5193.2989046479, 5233.738313084331, 5237.13587258102, 4458.910821783578, 5170.6122040847085, 5171.276021357013, 5176.689398636094, 5193.922091168635, 4292.334688123315, 5151.4333423323405, 5214.843554693365, 5225.608079394023, 5250.212468129773, 5433.510984011418, 5653.886922261573, 5760.107183386582, 5795.536357091465, 5830.562707796932, 6203.503719702413, 6238.781642642486, 6261.749530018794, 6274.529410294201, 6310.148130002437, 6151.507879369639, 6209.192804935375, 6295.748170073191, 6301.08634248036, 6302.149209856657, 5794.0, 5822.563307751935, 5837.620554663891, 5870.73581688825, 5910.970445147833, 6275.278342990523, 6277.937220627827, 6281.874362512815, 6296.181496405529, 6302.212223472066, 6040.848978775566, 6217.165936048877, 6223.377662233831, 6237.064440333896, 6240.500759939194, 6206.131141640174, 6207.5654704171175, 6247.5939063960695, 6301.40136687014, 6317.526185536103, 5264.842054738364, 6103.610425594294, 6125.71360014393, 6126.754929802758, 6184.381561843779, 4654.348391225231, 5184.585233181337, 5514.338279406497, 6158.353372895871, 6286.119943207955, 4198.454200953917, 4685.437747470325, 4867.196912509467, 4898.706077635282, 5058.317127187783, 3682.8710995115043, 4398.1643487737865, 4402.229609818269, 4445.133199026223, 4449.7775111244955, 4892.902141957141, 5666.97166514173, 5780.0, 5914.0241860093465, 5931.199288096138, 5290.867728306746, 6169.198004259507, 6231.594946328474, 6249.875002499924, 6287.49700023997, 5908.940910590839, 5918.763249470059, 5927.673977931255, 5961.701914904237, 5970.552208584373, 5403.270558474555, 5437.483439073281, 5449.536789372948, 5454.181872719124, 5460.426655201226, 6237.877182107173, 6268.091126786681, 6284.025975973731, 6316.336784637639, 6316.9368306317265, 6272.560920735505, 6286.245650521967, 6290.622562646256, 6299.842503937255, 6308.653024083719, 6289.245290564979, 6308.33762454954, 6331.778387756406, 6358.364163583605, 6371.808845734636, 6105.572609917263, 6107.643995706967, 6148.692565371624, 6267.2165979252595, 6296.937030629819, 5005.673496523352, 5887.5575484006695, 5923.911141332969, 5929.140274660236, 6280.9685951569945, 5227.764750586157, 5844.853878653068, 6100.23747031621, 6147.293061297829, 6173.938260617337, 5987.461128498456, 6096.420840020191, 6107.037103281039, 6170.722317495633, 6180.721867515883, 4639.443266808004, 4939.950600493949, 5192.299039629753, 5949.196858424058, 6090.330063692902, 5017.974910125426, 6147.047207682816, 6192.783252586138, 6202.5658203925295, 6204.627722336674, 5891.58758886891, 5974.641521508724, 6030.547708921936, 6042.758289668364, 6087.026075827846], "value": 5618.0233645366825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.2620176708431, 495.2051956609639, 529.0820426559918, 531.0653250279508, 561.9715919866644, 32299.0, 32718.182045448877, 33527.82652607156, 41065.38401923973, 41137.794311028476, 40831.59168408315, 41313.58686413135, 41375.37936930941, 41425.37861932066, 41427.0, 9684.0, 9883.209343252558, 9906.157976572, 9929.404235745878, 9970.651027214013, 9706.320557560974, 9788.314817962746, 9792.706218813448, 9810.0, 9821.65624203153, 9768.120869121813, 9816.950915245414, 9821.65624203153, 9833.459159746248, 9841.753956151082, 9803.362781419184, 9835.655752048715, 9862.556184971694, 9865.90134098657, 9874.506274686237, 9711.951440242825, 9778.07108324708, 9789.265805064648, 9801.362911410806, 9801.460919649417, 40254.79872600648, 40405.393919091235, 40589.0, 40693.796531017455, 40799.0, 2616.2151354593548, 3280.425925463034, 3316.4196265653413, 3513.9648603513892, 3520.06718219672, 30355.544666830014, 30631.434862822105, 30800.8459957701, 31606.525902111487, 31716.841415793006, 3141.19899425645, 3157.4000939821362, 3180.9522857157162, 3218.1954511372155, 3228.6448490666007, 434849.0, 438157.8092109519, 438584.0, 441771.0, 442097.7895110536, 28438.715612844022, 33582.0, 33686.0, 33734.83132584322, 33830.80099793505, 34002.14994625154, 34599.962001140004, 34744.82627586897, 35288.11779705528, 35319.0, 16771.161441927856, 16801.495955121365, 16833.158342082847, 16915.577110572332, 16931.915340423464, 10718.088962438123, 12989.0, 12991.805122923164, 13005.089643724848, 13019.544315949086, 16045.839541604668, 18967.90516047411, 19193.616127677367, 19213.807861921483, 19236.84578925269, 7907.525548467111, 8104.394236609761, 8162.224588664068, 8185.0, 8207.440586288705, 837.4305472278909, 870.4777133719717, 935.0976307862945, 1008.4907121903539, 1037.662759603117, 30944.226394339872, 31308.0, 31400.685993140232, 31879.681203187673, 32193.839030804695, 997.6408492942535, 1000.9599616015423, 1057.724991502215, 1071.2057304015743, 1147.3517462633586, 15508.767368489482, 15528.456504022304, 15606.751459883182, 16123.919380403024, 16628.916855415646, 560085.0, 685951.0, 687761.0, 688005.0, 689781.0, 60447.39552604505, 60940.781184376065, 60964.0, 61125.69437152786, 61176.0, 1318.4989703912452, 1327.462377737018, 1362.148657089339, 1364.0724307471014, 1368.1449094316054, 24506.264812055666, 29951.951681691036, 30632.693673063877, 30869.67824504616, 31205.68794312028, 52993.73503132614, 53220.73389633182, 53420.0, 53524.732376337866, 53558.983076268654, 556852.0, 560786.0, 561477.0, 562074.0, 562277.3772262225, 27338.179854604394, 27596.586051208847, 27611.447771044066, 27677.30806729848, 27679.30801729973, 48612.75693621509, 48800.5119948796, 48898.0, 49804.0, 49873.25190122223, 39523.40714889221, 40408.58569950038, 40764.38853417142, 40945.59054409418, 41486.377704335064, 31538.211544711565, 40013.99965000782, 40028.39886404511, 40426.1914761709, 41297.76106716803, 39666.40500392439, 39758.0, 39808.60191398049, 40720.79639601783, 40889.773306800846, 33442.0, 35925.46111808273, 36474.27051459009, 36632.633673662924, 36646.0, 22309.665355020014, 25897.741022589533, 26247.868760656074, 26543.86728066347, 26635.7336426641], "value": 19486.34329800136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.62990065083943, 372.4004352991683, 376.91896242307905, 379.9886003419898, 394.15847166299943, 19998.400047998548, 21529.56940861182, 22078.116875324988, 22112.557748845014, 22295.0, 16648.417305394312, 18205.544861378472, 19405.0, 20441.18235270591, 21554.245601403916, 4714.434267887858, 5348.197770334462, 6046.425589568995, 6160.675454777222, 6174.50603951685, 6096.786612468564, 6138.263408391, 6153.7846175383875, 6156.445919867211, 6177.536684748639, 5443.455654434545, 6099.146119543268, 6506.577072490297, 6546.639934803584, 6566.540342176049, 5985.341612422651, 6052.636841789506, 6075.210222671069, 6505.1543299371015, 6623.569467984566, 5034.219695947134, 5779.9307128181, 5934.406559344075, 5939.940600593982, 5986.910196347058, 12890.419931103123, 13223.933880330536, 13337.466501340032, 13374.063815532916, 13385.66535836602, 2025.5341271507489, 2072.7409073865765, 2114.7145135406677, 2404.0744313439277, 2929.3848291858735, 10067.798644027152, 10223.182145428422, 10223.846642300372, 11558.53765849365, 11739.823902641467, 1877.521232085823, 1896.3173257627243, 1916.6358391905494, 1940.5439721665539, 2018.5559176981042, 121084.0, 127851.0, 129127.0, 129597.33623973794, 129852.35073824665, 10144.391336519684, 10153.746156346002, 10306.0, 10444.947775261075, 11352.318860868374, 14104.294785260696, 14108.929455352658, 14113.576592702235, 14120.0, 14121.929390352983, 8317.708880189164, 8466.661333546712, 8472.74581762548, 8485.703000394957, 8621.870671939925, 7237.746678866214, 8492.51381008321, 8514.659413623385, 8632.35257355701, 8707.956460217658, 4410.889727756768, 4455.955440445554, 4509.143262780061, 4513.68404211702, 4576.558384108995, 1862.590230149392, 1932.3623204342534, 1937.3509874192303, 1944.9416517504499, 1957.4225603447017, 860.7632900952289, 916.7845556294266, 1017.9236557258236, 1018.4551265073151, 1053.1522124689698, 21030.684539731916, 22121.446963826034, 22170.0, 22204.11183552672, 22643.320700379016, 819.7581713394563, 936.1995493852794, 938.9953050234842, 952.3476418653245, 967.2213867836318, 10728.624498142684, 11532.88467115318, 11540.942295288638, 11613.0, 11657.825132623017, 521531.0, 522862.0, 526236.0, 619577.0, 645072.5492745106, 92367.53816230876, 114989.4250528742, 116247.0, 136606.0, 142866.0, 962.1100482054212, 1012.4785735346303, 1025.2157099818644, 1026.5637104230673, 1031.4687935713114, 15714.371425142866, 18840.811591884452, 19742.50643733918, 19858.801411985696, 19892.801071989095, 55991.72004139953, 57126.0, 57365.0, 57421.71289143527, 58078.70960645339, 76050.6197469009, 78350.6082469584, 80528.59735701284, 80990.59504702438, 84755.0, 7649.655765490677, 7659.540427574363, 7754.379649627904, 7903.407244456574, 8018.158093400342, 10416.531256093342, 12309.630711078324, 12433.0, 12512.812307815208, 12550.497980080694, 10644.0, 10651.520681569504, 10675.412852293199, 10755.838662419914, 11020.338779673246, 10500.422476763546, 10777.515011824644, 10950.288231264942, 11009.009189173014, 11024.834627480755, 10872.945635271773, 10952.616658416917, 11186.83219751688, 11298.717532061764, 11410.714732131763, 6290.528210384148, 7746.767596972099, 7787.5716835574585, 7826.295633393022, 7947.8807817881625, 10228.28402011852, 10254.897451025394, 10691.893081069089, 10728.73178170552, 10764.300320479144], "value": 9422.55543006204, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.5040534263067, 1494.7458931981564, 1692.1962068017685, 1815.2013114229746, 1818.9818101818978, 7991.92008079919, 8499.575021248937, 8627.784305392353, 9080.409773364727, 9117.0, 8589.18402751739, 8818.691345802883, 8844.823103537925, 8845.292376609872, 8859.335549833757, 2377.084822343402, 2398.712154541449, 2403.0507949359994, 2409.7469765674614, 2410.6143017117265, 1987.9801201988012, 2350.6239001759723, 2384.0582969726947, 2384.606539920911, 2394.832361734679, 2031.6444622191057, 2189.9233526826565, 2363.302825666424, 2376.061455724988, 2384.1655420602738, 1979.5051237190703, 2336.6378211377264, 2353.7410884802657, 2358.929232123039, 2361.031976889467, 2328.6507023946374, 2342.5666251743482, 2342.906283748665, 2343.7890589846997, 2356.2813341930705, 8049.436539442183, 8971.237444817198, 8988.0, 9015.549222538912, 9039.819203615956, 5244.239585260154, 5451.48210919962, 5451.754671039773, 5453.481919217668, 5475.425080366544, 3119.984400077985, 3310.0, 3601.423772196436, 3648.799316037617, 3652.981735091334, 1092.639428988432, 1104.304288298375, 1749.9737503937451, 1819.1177279019664, 1884.896330701811, 11148.888511114867, 11511.539538418454, 11644.941775291154, 11646.301221926627, 11706.707332316675, 3952.505936757905, 4433.46798384196, 4481.014176881081, 4648.48866624671, 4660.603848672901, 9135.543222838964, 9216.354855160209, 9216.815663686688, 9220.723378298662, 9230.261579073658, 5211.2443695663915, 5242.816501422508, 5259.289995850511, 5280.234366016983, 5285.709285989231, 4382.802773875183, 4778.808847646124, 4933.383327084114, 4956.553910148104, 4975.676581022222, 3666.8533258669354, 3779.149691319431, 3805.5623603285976, 3817.6945844332386, 3865.072382628205, 1169.1348402182493, 1177.7408970026581, 1181.8995385392166, 1187.625897842177, 1189.9881001189876, 815.604431850552, 923.3305853256336, 935.5556110847293, 944.622151139536, 971.7667759737753, 5859.560532960045, 5997.640141591519, 6128.78549250783, 6151.0, 6199.659018753921, 366.83309094362, 426.8932766808298, 444.64650602770877, 450.20988165768864, 454.11447677029264, 3965.5439624442984, 4071.226466971266, 4112.979435102805, 4174.3112386456505, 4205.285101532747, 8543.401961862734, 10897.073748731287, 10900.291481053706, 10921.617743379102, 10944.890551094388, 9025.277977761894, 10613.363198207977, 10841.457927103771, 10881.67354979336, 10888.67333979982, 6245.843853903689, 8193.221643943816, 8254.174582541818, 8261.545614991233, 8296.502209867427, 5408.621396502207, 5975.671338076274, 5984.670843103671, 6060.454559089703, 6069.180660610938, 9327.347085703936, 10089.29374943747, 10127.594896204364, 10142.087212150942, 10175.796484070424, 9728.513574321114, 10223.846642300521, 10277.229207809294, 10341.4312212829, 10354.0, 7007.159140903124, 7416.666250018654, 7537.849243014999, 7556.508826926232, 7698.92301076982, 8516.489010659132, 8534.0, 8558.657653694032, 8573.485590864319, 8594.957025214833, 7326.81682957909, 7555.206703296075, 7565.546067235983, 7678.692852285846, 7685.308322251024, 6548.770793022221, 7283.708651653875, 7468.290512401313, 7468.9626551866895, 7578.810529736801, 6985.0220969065385, 7036.718531258693, 7049.823754406181, 7056.470764692566, 7057.682404291922, 5022.171341728574, 5096.949030509648, 5182.585393168462, 5185.299984502044, 5192.0, 4503.099380123923, 4561.7262964222255, 4674.813007479799, 5151.201563757623, 5327.334083239595], "value": 4509.126960126444, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.8180718857903, 296.37317074387664, 301.7043297568383, 307.1384765732121, 309.35190775325697, 4720.339152518646, 5316.78732850686, 5512.91730624041, 5615.185798059279, 5706.9143962840535, 4943.777530011149, 5573.4147914469, 5715.799947001856, 5725.656460612367, 5725.969325521404, 4281.957180428202, 4304.354346847967, 4316.6978311518205, 4318.719283246594, 4319.287317592609, 3441.7418693597956, 3489.232368878855, 3720.3489389356755, 4311.5472875348105, 4320.762358070305, 4191.916161676764, 4198.265303571878, 4198.958010419902, 4214.515330736958, 4226.830926762926, 3541.291741651667, 3562.750607457479, 4225.302825033866, 4242.109157076987, 4258.361245813137, 3650.3064417760543, 3665.6151104133946, 3666.5416822897137, 3669.1377526281303, 3685.0, 4883.0, 5217.034848553029, 5462.890742185134, 5514.92458970501, 5576.0, 4819.325294458778, 4838.177509823338, 4869.415670119608, 4900.010993294088, 4910.312556242129, 4906.215005599087, 5015.84952451427, 5573.526250268732, 6024.457798798086, 6050.939490605126, 3179.6979286967703, 3393.9660603394145, 3713.3316003119426, 3738.738288319819, 3926.980365098185, 5448.945510544883, 6369.617822930639, 6372.458341041017, 6379.808605741835, 6430.517711171634, 3423.7774544654517, 3953.932438241716, 4066.207089617496, 4078.3066878630702, 4098.057446787196, 4040.777757223381, 4105.803395183562, 4112.3420252759415, 4115.6006957634545, 4131.0, 4325.637424211363, 4502.977485112553, 4616.446026476844, 4820.734859582686, 4823.107725070873, 5203.843884683465, 5267.9736601316745, 5779.162021506858, 5795.348325727232, 5988.610740301867, 1142.7942970265433, 1259.93535462534, 1275.1775105057186, 1323.7622822660842, 1400.838903526087, 802.1937952357843, 824.7773101262745, 839.6137776622822, 843.8185790055168, 848.0163010907318, 3887.319719049155, 4223.852165174204, 4331.0, 4622.907541849144, 4774.140654682121, 4666.393368862026, 4820.3369837406035, 4841.588464980446, 5154.809206087398, 5157.381114266312, 4251.80866860992, 4267.445232119867, 4619.3806193806195, 4699.2481203007355, 4742.264948932921, 2400.675908752331, 2435.4641978764644, 2509.460465999819, 2548.3817775712555, 2646.801489888266, 4752.049590081998, 4949.0, 5045.571126454219, 5311.840644780663, 5337.306150200527, 4343.82624695015, 5212.348456442945, 5274.446183150791, 5278.683279003272, 5293.867653308698, 4732.834350797705, 4882.755862206946, 4995.325631039836, 5239.318888544465, 5334.759401051568, 4274.871753847389, 4385.517593064824, 5109.156989096758, 5189.870253243548, 5194.532492075731, 4663.626909847137, 5034.421041580265, 5068.670536415121, 5092.294081482744, 5096.413912400121, 4202.411662367333, 4515.525869783625, 4962.791557756764, 5205.189197833279, 5365.731713414391, 3177.269228077509, 3179.9682003179673, 3192.7765056445824, 3222.258880457555, 3574.7855128692363, 4393.143337049245, 4693.0, 4728.71627702339, 5119.644963316767, 5621.297337832771, 5623.746931388016, 5932.436418540232, 5971.133855749178, 6013.548983826318, 6034.758609655741, 5925.644461332334, 5931.466168044896, 5931.614445061057, 5940.6435613863305, 6003.789867354796, 5539.25220095282, 5784.94215057844, 5812.505936995402, 5873.177755114202, 5892.7642894283745, 5061.569766569883, 6020.8795824084145, 6025.367336429612, 6031.879362412815, 6044.615015591283, 4602.7468489233415, 5343.732813359395, 5838.12428135783, 5878.265216847894, 5888.49738860991], "value": 4007.315887752836, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.763602716822, 695.4275637682241, 708.8334241453258, 758.1849511774843, 846.6867259114129, 14566.417343306268, 15685.764713529306, 16055.598610034755, 16562.089085100313, 16653.084080375604, 15014.699706005873, 15217.163056031914, 15434.354236600007, 16080.356785728556, 16255.024698518067, 832.9750107496785, 838.7944953486374, 851.2381418630322, 853.4964371021097, 856.0839901305606, 499.69828596506125, 656.668382466856, 672.5628341577989, 744.4491076603329, 839.9874001889976, 892.4689809563299, 897.833900728364, 902.801383695586, 904.416651259937, 906.1210625693067, 886.5434301334818, 903.2051794420901, 906.474244937941, 908.1599520443564, 908.4095338030268, 657.0374401501823, 657.6120089147425, 665.4476784269093, 666.0708311904865, 666.3303380103014, 14698.632534186623, 14773.556793296219, 15913.602159945978, 15915.681686366324, 16107.114108724016, 14391.2084835334, 14395.064320819218, 14433.927830360886, 14619.342129604192, 14624.780628290478, 11772.293662380285, 11899.583514577034, 12244.81632775509, 12263.325517096557, 12655.873441265561, 3844.1350696093436, 3854.1520865409566, 3869.3808990561374, 3965.9801700991597, 4015.7992100395154, 112488.43755781169, 115075.84924150736, 115746.0, 116867.0, 117460.8253917467, 11174.497147628375, 11192.944035279934, 11261.943690281496, 11284.097272218367, 11600.535978560933, 21969.0, 22312.77687223107, 22373.216937407113, 22435.887820560794, 22551.661725074136, 7954.085280192852, 8169.63236654352, 8183.508989460652, 8213.34293256538, 8347.749567512985, 4565.954340456619, 4601.608863246594, 4651.693192523193, 4663.533646635377, 4764.1657961685005, 3618.9638103618627, 3697.6487233712755, 3710.6474884885893, 3727.1241258304276, 3735.028892487973, 535.74552087758, 602.8124594548732, 631.0912286307703, 664.4485077385758, 689.8413364925995, 588.8763359694426, 619.6213425129051, 647.2104033079635, 648.5233353485185, 678.3928384096206, 7445.627718614048, 8608.698695545625, 8790.340724445692, 9393.342466027449, 9523.809523809485, 509.21834983300454, 621.5307442880596, 626.8028066393167, 633.7179954920108, 676.1649363036646, 4289.806958686867, 4474.597286244189, 4727.2436410174205, 4748.287756836502, 4841.757912104381, 99193.0, 145744.0, 146677.0, 157479.21260393623, 162067.18966405094, 114173.0, 137368.31315843356, 138666.0, 142234.0, 145198.2740086293, 78413.60793195998, 94488.52755736177, 109839.35240971232, 120715.0, 121011.78988210358, 8438.409311348147, 8872.072216168519, 8894.110588941054, 8897.466152030898, 8903.777405564913, 46544.00646735556, 64464.45445500543, 65248.67375663092, 65730.34269657434, 67409.0, 96815.0, 99955.50022249842, 103496.0, 103658.48170759098, 105362.47318763357, 11807.468663909973, 11808.82286765682, 11838.822417663914, 11857.940710296394, 12160.148789584999, 12881.0, 13051.0, 13494.460221591418, 14346.928265358607, 15252.161131137895, 10649.44220753751, 13104.017198709944, 13106.410211540313, 13980.650483737987, 14058.507952221624, 11289.37908415045, 12339.814902776287, 13592.93203533976, 13903.791443128159, 13957.371918263905, 11614.70963225926, 12803.423845926769, 13398.0, 14164.78752818688, 14334.713305734036, 10645.574177032831, 11083.72290692739, 11161.832572511257, 11519.481623327138, 11663.24188927717, 8150.551719655476, 9680.467574283482, 10600.416977066336, 11448.542058317575, 11486.0], "value": 7777.866829400198, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1651.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 109.0, 117.0, 117.0, 117.0, 120.0, 147.0, 173.0, 119.0], "value": 124.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 143.0, 167.0, 155.0, 112.0, 129.0, 130.0, 109.0, 160.0, 110.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 206.0, 241.0, 198.0, 192.0, 201.0, 192.0, 224.0, 265.0, 194.0], "value": 210.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 85.0, 77.0, 144.0, 65.0, 84.0, 52.0, 75.0, 163.0, 83.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 119.0, 80.0, 102.0, 113.0, 98.0, 97.0, 103.0, 149.0], "value": 100.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 92.0, 119.0, 135.0, 112.0, 92.0, 113.0, 136.0, 89.0], "value": 107.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 96.0, 118.0, 152.0, 115.0, 98.0, 98.0, 98.0], "value": 106.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 89.0, 150.0, 147.0, 84.0, 131.0, 136.0, 152.0, 145.0, 89.0], "value": 127.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 60.0, 56.0, 56.0, 58.0, 56.0, 56.0, 57.0, 59.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 67.0, 67.0, 72.0, 74.0, 74.0, 72.0, 71.0, 70.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 87.0, 88.0, 90.0, 86.0, 88.0, 87.0, 88.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 168.0, 152.0, 131.0, 149.0, 163.0, 157.0, 175.0, 148.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 187.0, 234.0, 157.0, 226.0, 242.0, 181.0, 240.0, 188.0, 214.0], "value": 204.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 71.0, 67.0, 62.0, 62.0, 69.0, 79.0, 91.0, 91.0], "value": 74.4, "unit": "score"}]}]} 06:13:36 INFO - Return code: 0 06:13:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:13:36 ERROR - # TBPL SUCCESS # 06:13:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:13:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:13:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:13:36 INFO - 2016-08-19 06:13:36.330 screenresolution[1667:10650] starting screenresolution argv=screenresolution get 06:13:36 INFO - 2016-08-19 06:13:36.333 screenresolution[1667:10650] Display 0: 1600x1200x32@60 06:13:36 INFO - 2016-08-19 06:13:36.339 screenresolution[1668:10653] starting screenresolution argv=screenresolution list 06:13:36 INFO - Available Modes on Display 0 06:13:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:13:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:13:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:13:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:13:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:13:36 INFO - Intel Iris: 06:13:36 INFO - Chipset Model: Intel Iris 06:13:36 INFO - Type: GPU 06:13:36 INFO - Bus: Built-In 06:13:36 INFO - VRAM (Dynamic, Max): 1536 MB 06:13:36 INFO - Vendor: Intel (0x8086) 06:13:36 INFO - Device ID: 0x0a2e 06:13:36 INFO - Revision ID: 0x0009 06:13:36 INFO - Displays: 06:13:36 INFO - Display: 06:13:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:13:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:13:36 INFO - Display Serial Number: 1600x1200 60 06:13:36 INFO - Main Display: Yes 06:13:36 INFO - Mirror: Off 06:13:36 INFO - Online: Yes 06:13:36 INFO - Rotation: Supported 06:13:36 INFO - Return code: 0 06:13:36 INFO - Running post-action listener: _resource_record_post_action 06:13:36 INFO - [mozharness: 2016-08-19 13:13:36.572211Z] Finished run-tests step (success) 06:13:36 INFO - Running post-run listener: _resource_record_post_run 06:13:36 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 37245952; Write bytes: 706720768; Read time: 236; Write time: 1995 06:13:36 INFO - TinderboxPrint: CPU usage
54.8% 06:13:36 INFO - TinderboxPrint: I/O read bytes / time
37,245,952 / 236 06:13:36 INFO - TinderboxPrint: I/O write bytes / time
706,720,768 / 1,995 06:13:36 INFO - TinderboxPrint: CPU idle
2,192.3 (45.2%) 06:13:36 INFO - TinderboxPrint: CPU system
985.8 (20.3%) 06:13:36 INFO - TinderboxPrint: CPU user
1,667.5 (34.4%) 06:13:36 INFO - TinderboxPrint: Swap in / out
442,859,520 / 0 06:13:36 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 388426240; Write bytes: 382846464; Read time: 29445; Write time: 794 06:13:36 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 36279296; Write bytes: 298405376; Read time: 223; Write time: 1139 06:13:37 INFO - Running post-run listener: _upload_blobber_files 06:13:37 INFO - Blob upload gear active. 06:13:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:37 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 06:13:37 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:13:37 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:13:37 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:13:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:38 INFO - (blobuploader) - INFO - Done attempting. 06:13:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:13:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:39 INFO - (blobuploader) - INFO - Done attempting. 06:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:41 INFO - (blobuploader) - INFO - Done attempting. 06:13:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:41 INFO - Return code: 0 06:13:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65eb36a16aba4ccb009cf84f2c0e277365b452c2cbf37e643525aa4ce20bb4fffa11724c8f81efa026ca1cf79cc0646c83cc93f3e039056b5f2c8ab8b079149b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/554cf64a914c5cabb905542365761217f59368044383207c0dbbc058d3475309e47938b8f97f3aafe39ccc95765195f8a511bb6381f1cf6cdd25d9955622ed37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7163e4562ae028b2eb1bb1e8612f99a71a33270a175bb53f8b56b54fa1ecaaa4f422c17e1dbc1ee1a07955d093cf10870efbc4bd5e44aed0b3e714cb0e69409b"} 06:13:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:41 INFO - Contents: 06:13:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65eb36a16aba4ccb009cf84f2c0e277365b452c2cbf37e643525aa4ce20bb4fffa11724c8f81efa026ca1cf79cc0646c83cc93f3e039056b5f2c8ab8b079149b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/554cf64a914c5cabb905542365761217f59368044383207c0dbbc058d3475309e47938b8f97f3aafe39ccc95765195f8a511bb6381f1cf6cdd25d9955622ed37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7163e4562ae028b2eb1bb1e8612f99a71a33270a175bb53f8b56b54fa1ecaaa4f422c17e1dbc1ee1a07955d093cf10870efbc4bd5e44aed0b3e714cb0e69409b"} 06:13:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:41 INFO - Copying logs to upload dir... 06:13:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.814553 ========= master_lag: 1.82 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-19 06:13:43.311457) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 06:13:43.315165) ========= 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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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/Firefox/sha512/65eb36a16aba4ccb009cf84f2c0e277365b452c2cbf37e643525aa4ce20bb4fffa11724c8f81efa026ca1cf79cc0646c83cc93f3e039056b5f2c8ab8b079149b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/554cf64a914c5cabb905542365761217f59368044383207c0dbbc058d3475309e47938b8f97f3aafe39ccc95765195f8a511bb6381f1cf6cdd25d9955622ed37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7163e4562ae028b2eb1bb1e8612f99a71a33270a175bb53f8b56b54fa1ecaaa4f422c17e1dbc1ee1a07955d093cf10870efbc4bd5e44aed0b3e714cb0e69409b"} build_url:https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010332 build_url: 'https://queue.taskcluster.net/v1/task/TiPIU2n6QuSEQ_5ZR-K4XQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65eb36a16aba4ccb009cf84f2c0e277365b452c2cbf37e643525aa4ce20bb4fffa11724c8f81efa026ca1cf79cc0646c83cc93f3e039056b5f2c8ab8b079149b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/554cf64a914c5cabb905542365761217f59368044383207c0dbbc058d3475309e47938b8f97f3aafe39ccc95765195f8a511bb6381f1cf6cdd25d9955622ed37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7163e4562ae028b2eb1bb1e8612f99a71a33270a175bb53f8b56b54fa1ecaaa4f422c17e1dbc1ee1a07955d093cf10870efbc4bd5e44aed0b3e714cb0e69409b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 06:13:43.355398) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 06:13:43.356094) ========= 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.tVqXuBbK6L/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.3BJwbT2dX3/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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.005217 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 06:13:43.408936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 06:13:43.409338) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 06:13:43.409771) ========= ========= Total master_lag: 1.96 =========