builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0174 starttime: 1470658113.39 results: success (0) buildid: 20160808012421 builduid: f64ec4b55952477e87b269089c3452c5 revision: f8fc21bb232095b7b4c995d259558212cb90a44b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.393405) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.394052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.394361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.450299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.450721) ========= 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.BaPSY0iubj/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.cDr50gC1ko/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-08 05:08:33-- 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% 203M=0s 2016-08-08 05:08:33 (203 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100016 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.572277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.572743) ========= 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.BaPSY0iubj/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.cDr50gC1ko/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.024508 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.622779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:08:33.623277) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8fc21bb232095b7b4c995d259558212cb90a44b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f8fc21bb232095b7b4c995d259558212cb90a44b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BaPSY0iubj/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.cDr50gC1ko/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-08 05:08:33,698 truncating revision to first 12 chars 2016-08-08 05:08:33,698 Setting DEBUG logging. 2016-08-08 05:08:33,698 attempt 1/10 2016-08-08 05:08:33,698 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8fc21bb2320?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 05:08:34,598 unpacking tar archive at: fx-team-f8fc21bb2320/testing/mozharness/ program finished with exit code 0 elapsedTime=1.174091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:08:34.819764) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:34.820090) ========= script_repo_revision: f8fc21bb232095b7b4c995d259558212cb90a44b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:34.820461) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:34.820740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:34.839924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-08 05:08:34.840327) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BaPSY0iubj/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.cDr50gC1ko/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:08:35 INFO - MultiFileLogger online at 20160808 05:08:35 in /builds/slave/test 05:08:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:08:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:35 INFO - {'append_to_log': False, 05:08:35 INFO - 'base_work_dir': '/builds/slave/test', 05:08:35 INFO - 'blob_upload_branch': 'Fx-Team', 05:08:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:35 INFO - 'branch': 'Fx-Team', 05:08:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:35 INFO - 'config_files': ('talos/mac_config.py',), 05:08:35 INFO - 'default_actions': ('clobber', 05:08:35 INFO - 'read-buildbot-config', 05:08:35 INFO - 'download-and-extract', 05:08:35 INFO - 'populate-webroot', 05:08:35 INFO - 'create-virtualenv', 05:08:35 INFO - 'install', 05:08:35 INFO - 'run-tests'), 05:08:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:35 INFO - 'download_minidump_stackwalk': True, 05:08:35 INFO - 'download_symbols': 'ondemand', 05:08:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:35 INFO - 'installer_path': 'installer.exe', 05:08:35 INFO - 'log_level': 'info', 05:08:35 INFO - 'log_name': 'talos', 05:08:35 INFO - 'log_to_console': True, 05:08:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:08:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:08:35 INFO - 'opt_config_files': (), 05:08:35 INFO - 'pip_index': False, 05:08:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:35 INFO - 'cmd': ('bash', 05:08:35 INFO - '-c', 05:08:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:35 INFO - 'enabled': True, 05:08:35 INFO - 'halt_on_failure': False, 05:08:35 INFO - 'name': 'check_screen_resolution'},), 05:08:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:35 INFO - 'cmd': ('bash', 05:08:35 INFO - '-c', 05:08:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:35 INFO - 'enabled': True, 05:08:35 INFO - 'halt_on_failure': False, 05:08:35 INFO - 'name': 'check_screen_resolution'},), 05:08:35 INFO - 'run_cmd_checks_enabled': True, 05:08:35 INFO - 'sps_profile': False, 05:08:35 INFO - 'sps_profile_interval': 0, 05:08:35 INFO - 'suite': 'dromaeojs-e10s', 05:08:35 INFO - 'system_bits': '32', 05:08:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:35 INFO - 'title': 't-yosemite-r7-0174', 05:08:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:35 INFO - 'use_talos_json': True, 05:08:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:35 INFO - 'work_dir': 'build'} 05:08:35 INFO - [mozharness: 2016-08-08 12:08:35.037979Z] Running clobber step. 05:08:35 INFO - Running pre-action listener: _resource_record_pre_action 05:08:35 INFO - Running main action method: clobber 05:08:35 INFO - rmtree: /builds/slave/test/build 05:08:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:37 INFO - Running post-action listener: _resource_record_post_action 05:08:37 INFO - [mozharness: 2016-08-08 12:08:37.165445Z] Finished clobber step (success) 05:08:37 INFO - [mozharness: 2016-08-08 12:08:37.165603Z] Running read-buildbot-config step. 05:08:37 INFO - Running pre-action listener: _resource_record_pre_action 05:08:37 INFO - Running main action method: read_buildbot_config 05:08:37 INFO - Using buildbot properties: 05:08:37 INFO - { 05:08:37 INFO - "project": "", 05:08:37 INFO - "product": "firefox", 05:08:37 INFO - "script_repo_revision": "production", 05:08:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:08:37 INFO - "repository": "", 05:08:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:08:37 INFO - "buildid": "20160808012421", 05:08:37 INFO - "pgo_build": "False", 05:08:37 INFO - "basedir": "/builds/slave/test", 05:08:37 INFO - "buildnumber": 3, 05:08:37 INFO - "slavename": "t-yosemite-r7-0174", 05:08:37 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:08:37 INFO - "platform": "yosemite_r7", 05:08:37 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:08:37 INFO - "branch": "fx-team", 05:08:37 INFO - "repo_path": "integration/fx-team", 05:08:37 INFO - "revision": "f8fc21bb232095b7b4c995d259558212cb90a44b", 05:08:37 INFO - "stage_platform": "macosx64", 05:08:37 INFO - "builduid": "f64ec4b55952477e87b269089c3452c5", 05:08:37 INFO - "slavebuilddir": "test" 05:08:37 INFO - } 05:08:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:08:37 INFO - Running post-action listener: _resource_record_post_action 05:08:37 INFO - [mozharness: 2016-08-08 12:08:37.168972Z] Finished read-buildbot-config step (success) 05:08:37 INFO - [mozharness: 2016-08-08 12:08:37.169109Z] Running download-and-extract step. 05:08:37 INFO - Running pre-action listener: _resource_record_pre_action 05:08:37 INFO - Running main action method: download_and_extract 05:08:37 INFO - mkdir: /builds/slave/test/build/tests 05:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:37 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:08:37 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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:08:38 INFO - Downloaded 1199 bytes. 05:08:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:08:38 INFO - Using the following test package requirements: 05:08:38 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:08:38 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:08:38 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:08:38 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'jsshell-mac.zip'], 05:08:38 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:08:38 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:08:38 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:08:38 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:08:38 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:08:38 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:08:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:38 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:08:38 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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:08:39 INFO - Downloaded 16320444 bytes. 05:08:39 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:08:46 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:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:46 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:08:46 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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:08:47 INFO - Downloaded 16320444 bytes. 05:08:47 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:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:53 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:08:53 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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:08:55 INFO - Downloaded 14413723 bytes. 05:08:55 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:08:55 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:08:55 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:08:55 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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:08:58 INFO - Downloaded 111901101 bytes. 05:08:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:08:58 INFO - mkdir: /builds/slave/test/properties 05:08:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:58 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:58 INFO - Contents: 05:08:58 INFO - build_url:https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:08:59 INFO - Running post-action listener: _resource_record_post_action 05:08:59 INFO - Running post-action listener: set_extra_try_arguments 05:08:59 INFO - [mozharness: 2016-08-08 12:08:59.049477Z] Finished download-and-extract step (success) 05:08:59 INFO - [mozharness: 2016-08-08 12:08:59.049603Z] Running populate-webroot step. 05:08:59 INFO - Running pre-action listener: _resource_record_pre_action 05:08:59 INFO - Running main action method: populate_webroot 05:08:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:59 INFO - '--tppagecycles', 05:08:59 INFO - '7'], 05:08:59 INFO - 'tests': ['tsvgm']}}, 05:08:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:08:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:08:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:08:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:59 INFO - 'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:59 INFO - 'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['damp', 'tps']}, 05:08:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:59 INFO - 'tests': ['damp', 'tps']}, 05:08:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['dromaeo_dom']}, 05:08:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['basic_compositor_video']}, 05:08:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:08:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['a11yr', 05:08:59 INFO - 'ts_paint', 05:08:59 INFO - 'tpaint', 05:08:59 INFO - 'sessionrestore', 05:08:59 INFO - 'sessionrestore_no_auto_restore', 05:08:59 INFO - 'tabpaint']}, 05:08:59 INFO - 'other-e10s': {'tests': ['a11yr', 05:08:59 INFO - 'ts_paint', 05:08:59 INFO - 'tpaint', 05:08:59 INFO - 'sessionrestore', 05:08:59 INFO - 'sessionrestore_no_auto_restore', 05:08:59 INFO - 'tabpaint']}, 05:08:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:08:59 INFO - 'ts_paint', 05:08:59 INFO - 'tpaint', 05:08:59 INFO - 'sessionrestore', 05:08:59 INFO - 'sessionrestore_no_auto_restore', 05:08:59 INFO - 'tabpaint']}, 05:08:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:08:59 INFO - 'ts_paint', 05:08:59 INFO - 'tpaint', 05:08:59 INFO - 'sessionrestore', 05:08:59 INFO - 'sessionrestore_no_auto_restore', 05:08:59 INFO - 'tabpaint']}, 05:08:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['a11yr', 05:08:59 INFO - 'ts_paint', 05:08:59 INFO - 'tpaint', 05:08:59 INFO - 'sessionrestore', 05:08:59 INFO - 'sessionrestore_no_auto_restore', 05:08:59 INFO - 'tabpaint']}, 05:08:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['a11yr', 05:08:59 INFO - 'ts_paint', 05:08:59 INFO - 'tpaint', 05:08:59 INFO - 'sessionrestore', 05:08:59 INFO - 'sessionrestore_no_auto_restore', 05:08:59 INFO - 'tabpaint']}, 05:08:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['tsvgx', 05:08:59 INFO - 'tsvgr_opacity', 05:08:59 INFO - 'tart', 05:08:59 INFO - 'tscrollx', 05:08:59 INFO - 'cart']}, 05:08:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:08:59 INFO - 'tsvgr_opacity', 05:08:59 INFO - 'tart', 05:08:59 INFO - 'tscrollx', 05:08:59 INFO - 'cart']}, 05:08:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:59 INFO - 'talos_options': ['--disable-e10s'], 05:08:59 INFO - 'tests': ['tp5o']}, 05:08:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:59 INFO - 'tests': ['tp5o']}, 05:08:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:59 INFO - 'talos_options': ['--disable-e10s', 05:08:59 INFO - '--xperf_path', 05:08:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:59 INFO - 'tests': ['tp5n']}, 05:08:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:59 INFO - 'talos_options': ['--xperf_path', 05:08:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:59 INFO - 'tests': ['tp5n']}}, 05:08:59 INFO - 'talos.zip': {'path': '', 05:08:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:59 INFO - Running post-action listener: _resource_record_post_action 05:08:59 INFO - [mozharness: 2016-08-08 12:08:59.068375Z] Finished populate-webroot step (success) 05:08:59 INFO - [mozharness: 2016-08-08 12:08:59.068481Z] Running create-virtualenv step. 05:08:59 INFO - Running pre-action listener: _resource_record_pre_action 05:08:59 INFO - Running main action method: create_virtualenv 05:08:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:59 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:08:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:59 INFO - Using real prefix '/tools/python27' 05:08:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:02 INFO - Installing pip.................done. 05:09:02 INFO - Return code: 0 05:09:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09: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:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc901d8c7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, '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.BaPSY0iubj/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.cDr50gC1ko/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:09: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', 'pip>=1.5'] in /builds/slave/test/build 05:09: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 pip>=1.5 05:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:02 INFO - 'HOME': '/Users/cltbld', 05:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:02 INFO - 'LOGNAME': 'cltbld', 05:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:02 INFO - 'MOZ_NO_REMOTE': '1', 05:09:02 INFO - 'NO_EM_RESTART': '1', 05:09:02 INFO - 'PAGER': '/bin/cat', 05:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:02 INFO - 'PWD': '/builds/slave/test', 05:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:02 INFO - 'SHELL': '/bin/bash', 05:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:09:02 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:02 INFO - 'USER': 'cltbld', 05:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:02 INFO - 'XPC_FLAGS': '0x0', 05:09:02 INFO - 'XPC_SERVICE_NAME': '0', 05:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:03 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:09:03 INFO - Cleaning up... 05:09:03 INFO - Return code: 0 05:09:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:03 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 0x10af71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc901d8c7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, '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.BaPSY0iubj/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.cDr50gC1ko/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:09:03 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:09:03 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:09:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:09:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:03 INFO - 'HOME': '/Users/cltbld', 05:09:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:03 INFO - 'LOGNAME': 'cltbld', 05:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:03 INFO - 'MOZ_NO_REMOTE': '1', 05:09:03 INFO - 'NO_EM_RESTART': '1', 05:09:03 INFO - 'PAGER': '/bin/cat', 05:09:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:03 INFO - 'PWD': '/builds/slave/test', 05:09:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:03 INFO - 'SHELL': '/bin/bash', 05:09:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:09:03 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:09:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:03 INFO - 'USER': 'cltbld', 05:09:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:03 INFO - 'XPC_FLAGS': '0x0', 05:09:03 INFO - 'XPC_SERVICE_NAME': '0', 05:09:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:03 INFO - Downloading/unpacking psutil>=3.1.1 05:09: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:09: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:09: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:09: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:09: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:09: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:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:05 INFO - Installing collected packages: psutil 05:09:05 INFO - Running setup.py install for psutil 05:09:06 INFO - building 'psutil._psutil_osx' extension 05:09:06 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:09:06 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:09:06 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:09:06 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:09:06 INFO - building 'psutil._psutil_posix' extension 05:09:06 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:09:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:09:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:09:06 INFO - ^ 05:09:06 INFO - 1 warning generated. 05:09:06 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:09:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:07 INFO - Successfully installed psutil 05:09:07 INFO - Cleaning up... 05:09:07 INFO - Return code: 0 05:09:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:09:07 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:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:07 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:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:07 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 0x10af71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc901d8c7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, '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.BaPSY0iubj/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.cDr50gC1ko/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:09:07 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:09:07 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:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:07 INFO - 'HOME': '/Users/cltbld', 05:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:07 INFO - 'LOGNAME': 'cltbld', 05:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:07 INFO - 'MOZ_NO_REMOTE': '1', 05:09:07 INFO - 'NO_EM_RESTART': '1', 05:09:07 INFO - 'PAGER': '/bin/cat', 05:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:07 INFO - 'PWD': '/builds/slave/test', 05:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:07 INFO - 'SHELL': '/bin/bash', 05:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:09:07 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:07 INFO - 'USER': 'cltbld', 05:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:07 INFO - 'XPC_FLAGS': '0x0', 05:09:07 INFO - 'XPC_SERVICE_NAME': '0', 05:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:09:07 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:09:07 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:09:07 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:09:07 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:09:07 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:09:07 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:09:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:09:09 INFO - Installing collected packages: mozsystemmonitor 05:09:09 INFO - Running setup.py install for mozsystemmonitor 05:09:10 INFO - Successfully installed mozsystemmonitor 05:09:10 INFO - Cleaning up... 05:09:10 INFO - Return code: 0 05:09:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:10 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 0x10af71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc901d8c7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, '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.BaPSY0iubj/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.cDr50gC1ko/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:09:10 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:09:10 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:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:09:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:10 INFO - 'HOME': '/Users/cltbld', 05:09:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:10 INFO - 'LOGNAME': 'cltbld', 05:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:10 INFO - 'MOZ_NO_REMOTE': '1', 05:09:10 INFO - 'NO_EM_RESTART': '1', 05:09:10 INFO - 'PAGER': '/bin/cat', 05:09:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:10 INFO - 'PWD': '/builds/slave/test', 05:09:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:10 INFO - 'SHELL': '/bin/bash', 05:09:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:09:10 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:09:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:10 INFO - 'USER': 'cltbld', 05:09:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:10 INFO - 'XPC_FLAGS': '0x0', 05:09:10 INFO - 'XPC_SERVICE_NAME': '0', 05:09:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:10 INFO - Downloading/unpacking jsonschema==2.5.1 05:09:10 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:09:10 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:09:10 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:09:10 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:09:10 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:09:10 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:09:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:09: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:09: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:09: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:09: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:09: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:09: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:09:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:13 INFO - warning: no files found matching '*.txt' 05:09:13 INFO - no previously-included directories found matching 'build' 05:09:13 INFO - no previously-included directories found matching 'dist' 05:09:13 INFO - no previously-included directories found matching '.git*' 05:09:13 INFO - Installing collected packages: jsonschema, functools32 05:09:13 INFO - Running setup.py install for functools32 05:09:13 INFO - warning: no files found matching '*.txt' 05:09:13 INFO - no previously-included directories found matching 'build' 05:09:13 INFO - no previously-included directories found matching 'dist' 05:09:13 INFO - no previously-included directories found matching '.git*' 05:09:13 INFO - Successfully installed jsonschema functools32 05:09:13 INFO - Cleaning up... 05:09:13 INFO - Return code: 0 05:09:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:13 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 0x10af71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc901d8c7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, '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.BaPSY0iubj/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.cDr50gC1ko/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:09:13 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:09:13 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:09:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:09:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:13 INFO - 'HOME': '/Users/cltbld', 05:09:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:13 INFO - 'LOGNAME': 'cltbld', 05:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:13 INFO - 'MOZ_NO_REMOTE': '1', 05:09:13 INFO - 'NO_EM_RESTART': '1', 05:09:13 INFO - 'PAGER': '/bin/cat', 05:09:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:13 INFO - 'PWD': '/builds/slave/test', 05:09:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:13 INFO - 'SHELL': '/bin/bash', 05:09:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:09:13 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:09:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:13 INFO - 'USER': 'cltbld', 05:09:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:13 INFO - 'XPC_FLAGS': '0x0', 05:09:13 INFO - 'XPC_SERVICE_NAME': '0', 05:09:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:09:13 INFO - Cleaning up... 05:09:13 INFO - Return code: 0 05:09:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:13 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 0x10af71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc901d8c7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, '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.BaPSY0iubj/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.cDr50gC1ko/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:09:13 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:09:13 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:09:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:09:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:13 INFO - 'HOME': '/Users/cltbld', 05:09:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:13 INFO - 'LOGNAME': 'cltbld', 05:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:13 INFO - 'MOZ_NO_REMOTE': '1', 05:09:13 INFO - 'NO_EM_RESTART': '1', 05:09:13 INFO - 'PAGER': '/bin/cat', 05:09:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:13 INFO - 'PWD': '/builds/slave/test', 05:09:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:13 INFO - 'SHELL': '/bin/bash', 05:09:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:09:13 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:09:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:13 INFO - 'USER': 'cltbld', 05:09:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:13 INFO - 'XPC_FLAGS': '0x0', 05:09:13 INFO - 'XPC_SERVICE_NAME': '0', 05:09:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:14 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:09:14 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:09:14 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:09:14 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:09:14 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:09:14 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:09:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:17 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:09:17 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:09:17 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:09:17 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:09:17 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:09:17 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:09:17 INFO - Downloading docopt-0.6.1.tar.gz 05:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:17 INFO - Running setup.py install for blobuploader 05:09:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:17 INFO - Running setup.py install for requests 05:09:18 INFO - Running setup.py install for docopt 05:09:18 INFO - Successfully installed blobuploader requests docopt 05:09:18 INFO - Cleaning up... 05:09:18 INFO - Return code: 0 05:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:18 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:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:18 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:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:18 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 0x10af71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc901d8c7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, '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.BaPSY0iubj/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.cDr50gC1ko/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:09:18 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:09:18 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:09:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:09:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:18 INFO - 'HOME': '/Users/cltbld', 05:09:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:18 INFO - 'LOGNAME': 'cltbld', 05:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:18 INFO - 'MOZ_NO_REMOTE': '1', 05:09:18 INFO - 'NO_EM_RESTART': '1', 05:09:18 INFO - 'PAGER': '/bin/cat', 05:09:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:18 INFO - 'PWD': '/builds/slave/test', 05:09:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:18 INFO - 'SHELL': '/bin/bash', 05:09:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:09:18 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:09:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:18 INFO - 'USER': 'cltbld', 05:09:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:18 INFO - 'XPC_FLAGS': '0x0', 05:09:18 INFO - 'XPC_SERVICE_NAME': '0', 05:09:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:18 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-a3rlfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-RVpTac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-8Foeoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-SKDnok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-WluPE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-1IurE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-2vuBhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-_Cszhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-zIGhLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-0FMqPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-ZrS2B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:20 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-QVBvN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:20 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-1UsJKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:20 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-SJ02mP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:20 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-byqRcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:20 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-cBC9rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:20 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-7sqbWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:20 INFO - Running setup.py install for manifestparser 05:09:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:20 INFO - Running setup.py install for mozcrash 05:09:20 INFO - Running setup.py install for mozdebug 05:09:21 INFO - Running setup.py install for mozdevice 05:09:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:21 INFO - Running setup.py install for mozfile 05:09:21 INFO - Running setup.py install for mozhttpd 05:09:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:21 INFO - Running setup.py install for mozinfo 05:09:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:21 INFO - Running setup.py install for mozInstall 05:09:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:21 INFO - Running setup.py install for mozleak 05:09:22 INFO - Running setup.py install for mozlog 05:09:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:22 INFO - Running setup.py install for moznetwork 05:09:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:22 INFO - Running setup.py install for mozprocess 05:09:22 INFO - Running setup.py install for mozprofile 05:09:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:22 INFO - Running setup.py install for mozrunner 05:09:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:22 INFO - Running setup.py install for mozscreenshot 05:09:22 INFO - Running setup.py install for moztest 05:09:23 INFO - Running setup.py install for mozversion 05:09:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:23 INFO - Cleaning up... 05:09:23 INFO - Return code: 0 05:09:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:23 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:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:23 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:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:23 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 0x10af71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc901d8c7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, '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.BaPSY0iubj/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.cDr50gC1ko/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:09:23 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:09:23 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:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:23 INFO - 'HOME': '/Users/cltbld', 05:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:23 INFO - 'LOGNAME': 'cltbld', 05:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:23 INFO - 'MOZ_NO_REMOTE': '1', 05:09:23 INFO - 'NO_EM_RESTART': '1', 05:09:23 INFO - 'PAGER': '/bin/cat', 05:09:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:23 INFO - 'PWD': '/builds/slave/test', 05:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:23 INFO - 'SHELL': '/bin/bash', 05:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:09:23 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:23 INFO - 'USER': 'cltbld', 05:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:23 INFO - 'XPC_FLAGS': '0x0', 05:09:23 INFO - 'XPC_SERVICE_NAME': '0', 05:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:23 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-gi1rSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:23 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:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:23 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-_8l4CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:23 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:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:23 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-s8McbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:23 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:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:23 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-nKr2EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:23 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:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:23 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-4jA1xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:24 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-oDPCKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:24 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-1hKhg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:24 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-T6YS8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:24 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-nRfZ2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:24 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-IcjxKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:24 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-TLbvdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:24 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-IRhXbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:24 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-GOQ1Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:24 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-hIEutw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:25 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:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:25 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Xys_gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:25 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:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:25 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-5ZD6Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:25 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:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:25 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-P0fhj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:27 INFO - Downloading blessings-1.6.tar.gz 05:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:27 INFO - Installing collected packages: blessings 05:09:27 INFO - Running setup.py install for blessings 05:09:28 INFO - Successfully installed blessings 05:09:28 INFO - Cleaning up... 05:09:28 INFO - Return code: 0 05:09:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:28 INFO - Reading from file tmpfile_stdout 05:09:28 INFO - Current package versions: 05:09:28 INFO - blessings == 1.6 05:09:28 INFO - blobuploader == 1.2.4 05:09:28 INFO - docopt == 0.6.1 05:09:28 INFO - functools32 == 3.2.3-2 05:09:28 INFO - jsonschema == 2.5.1 05:09:28 INFO - manifestparser == 1.1 05:09:28 INFO - mozInstall == 1.12 05:09:28 INFO - mozcrash == 0.17 05:09:28 INFO - mozdebug == 0.1 05:09:28 INFO - mozdevice == 0.48 05:09:28 INFO - mozfile == 1.2 05:09:28 INFO - mozhttpd == 0.7 05:09:28 INFO - mozinfo == 0.9 05:09:28 INFO - mozleak == 0.1 05:09:28 INFO - mozlog == 3.3 05:09:28 INFO - moznetwork == 0.27 05:09:28 INFO - mozprocess == 0.23 05:09:28 INFO - mozprofile == 0.28 05:09:28 INFO - mozrunner == 6.12 05:09:28 INFO - mozscreenshot == 0.1 05:09:28 INFO - mozsystemmonitor == 0.3 05:09:28 INFO - moztest == 0.7 05:09:28 INFO - mozversion == 1.4 05:09:28 INFO - psutil == 3.1.1 05:09:28 INFO - requests == 1.2.3 05:09:28 INFO - wsgiref == 0.1.2 05:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:28 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 0x10af71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc901d8c7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, '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.BaPSY0iubj/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.cDr50gC1ko/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:09:28 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:09:28 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:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:28 INFO - 'HOME': '/Users/cltbld', 05:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:28 INFO - 'LOGNAME': 'cltbld', 05:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:28 INFO - 'MOZ_NO_REMOTE': '1', 05:09:28 INFO - 'NO_EM_RESTART': '1', 05:09:28 INFO - 'PAGER': '/bin/cat', 05:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:28 INFO - 'PWD': '/builds/slave/test', 05:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:28 INFO - 'SHELL': '/bin/bash', 05:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:09:28 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:28 INFO - 'USER': 'cltbld', 05:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:28 INFO - 'XPC_FLAGS': '0x0', 05:09:28 INFO - 'XPC_SERVICE_NAME': '0', 05:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 INFO - Cleaning up... 05:09:28 INFO - Return code: 0 05:09:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:28 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 0x10af71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc901d8c7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, '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.BaPSY0iubj/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.cDr50gC1ko/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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:09:28 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:09:28 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:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:28 INFO - 'HOME': '/Users/cltbld', 05:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:28 INFO - 'LOGNAME': 'cltbld', 05:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:28 INFO - 'MOZ_NO_REMOTE': '1', 05:09:28 INFO - 'NO_EM_RESTART': '1', 05:09:28 INFO - 'PAGER': '/bin/cat', 05:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:28 INFO - 'PWD': '/builds/slave/test', 05:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:28 INFO - 'SHELL': '/bin/bash', 05:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:09:28 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:28 INFO - 'USER': 'cltbld', 05:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:28 INFO - 'XPC_FLAGS': '0x0', 05:09:28 INFO - 'XPC_SERVICE_NAME': '0', 05:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:09:28 INFO - Cleaning up... 05:09:28 INFO - Return code: 0 05:09:28 INFO - Running post-action listener: _resource_record_post_action 05:09:28 INFO - Running post-action listener: _start_resource_monitoring 05:09:28 INFO - Starting resource monitoring. 05:09:28 INFO - [mozharness: 2016-08-08 12:09:28.954895Z] Finished create-virtualenv step (success) 05:09:28 INFO - [mozharness: 2016-08-08 12:09:28.955892Z] Running install step. 05:09:28 INFO - Running pre-action listener: _resource_record_pre_action 05:09:28 INFO - Running main action method: install 05:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:29 INFO - Reading from file tmpfile_stdout 05:09:29 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:29 INFO - Reading from file tmpfile_stdout 05:09:29 INFO - Output received: 05:09:29 INFO - Usage: mozinstall [options] installer 05:09:29 INFO - Options: 05:09:29 INFO - -h, --help show this help message and exit 05:09:29 INFO - -d DEST, --destination=DEST 05:09:29 INFO - Directory to install application into. [default: 05:09:29 INFO - "/builds/slave/test"] 05:09:29 INFO - --app=APP Application being installed. [default: firefox] 05:09:29 INFO - mkdir: /builds/slave/test/build/application 05:09:29 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:09:29 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:10:03 INFO - Reading from file tmpfile_stdout 05:10:03 INFO - Output received: 05:10:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:10:03 INFO - Running post-action listener: _resource_record_post_action 05:10:03 INFO - [mozharness: 2016-08-08 12:10:03.978665Z] Finished install step (success) 05:10:03 INFO - [mozharness: 2016-08-08 12:10:03.978855Z] Running run-tests step. 05:10:03 INFO - Running pre-action listener: _resource_record_pre_action 05:10:03 INFO - Running main action method: run_tests 05:10:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:03 INFO - 2016-08-08 05:10:03.993 screenresolution[1638:7432] starting screenresolution argv=screenresolution get 05:10:03 INFO - 2016-08-08 05:10:03.996 screenresolution[1638:7432] Display 0: 1600x1200x32@60 05:10:04 INFO - 2016-08-08 05:10:04.001 screenresolution[1639:7434] starting screenresolution argv=screenresolution list 05:10:04 INFO - Available Modes on Display 0 05:10:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:04 INFO - Intel Iris: 05:10:04 INFO - Chipset Model: Intel Iris 05:10:04 INFO - Type: GPU 05:10:04 INFO - Bus: Built-In 05:10:04 INFO - VRAM (Dynamic, Max): 1536 MB 05:10:04 INFO - Vendor: Intel (0x8086) 05:10:04 INFO - Device ID: 0x0a2e 05:10:04 INFO - Revision ID: 0x0009 05:10:04 INFO - Displays: 05:10:04 INFO - Display: 05:10:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:04 INFO - Display Serial Number: 1600x1200 60 05:10:04 INFO - Main Display: Yes 05:10:04 INFO - Mirror: Off 05:10:04 INFO - Online: Yes 05:10:04 INFO - Rotation: Supported 05:10:04 INFO - Return code: 0 05:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:04 INFO - Python 2.7.3 05:10:04 INFO - Return code: 0 05:10:04 INFO - grabbing minidump binary from tooltool 05:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:04 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 0x10aed5d30>, '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 0x10ac3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aecdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:04 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:10:04 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:10:04 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:10:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:04 INFO - Return code: 0 05:10:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:10:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:10:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--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:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0174 --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:10:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BaPSY0iubj/Render', 05:10:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:04 INFO - 'HOME': '/Users/cltbld', 05:10:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:04 INFO - 'LOGNAME': 'cltbld', 05:10:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:04 INFO - 'MOZ_NO_REMOTE': '1', 05:10:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:04 INFO - 'NO_EM_RESTART': '1', 05:10:04 INFO - 'PAGER': '/bin/cat', 05:10:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:04 INFO - 'PWD': '/builds/slave/test', 05:10:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:04 INFO - 'SHELL': '/bin/bash', 05:10:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cDr50gC1ko/Listeners', 05:10:04 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 05:10:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:04 INFO - 'USER': 'cltbld', 05:10:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:04 INFO - 'XPC_FLAGS': '0x0', 05:10:04 INFO - 'XPC_SERVICE_NAME': '0', 05:10:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--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:10:04 INFO - mozversion application_buildid: 20160808012421 05:10:04 INFO - mozversion application_changeset: f8fc21bb232095b7b4c995d259558212cb90a44b 05:10:04 INFO - mozversion application_display_name: Nightly 05:10:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:04 INFO - mozversion application_name: Firefox 05:10:04 INFO - mozversion application_remotingname: firefox 05:10:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:10:04 INFO - mozversion application_vendor: Mozilla 05:10:04 INFO - mozversion application_version: 51.0a1 05:10:04 INFO - mozversion platform_buildid: 20160808012421 05:10:04 INFO - mozversion platform_changeset: f8fc21bb232095b7b4c995d259558212cb90a44b 05:10:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:04 INFO - mozversion platform_version: 51.0a1 05:10:04 INFO - using testdate: 1470658204 05:10:04 INFO - actual date: 1470658204 05:10:04 INFO - starting webserver on 'localhost:49269' 05:10:04 INFO - SUITE-START | Running 2 tests 05:10:04 INFO - TEST-START | dromaeo_css 05:10:04 INFO - operating with platform_type : mac_ 05:10:04 INFO - Initialising browser for dromaeo_css test... 05:10:04 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp3RxFRh/profile http://localhost:49269/getInfo.html) 05:10:07 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 05:10:07 INFO - PROCESS | 1649 | colorDepth:24 05:10:07 INFO - PROCESS | 1649 | Browser inner width/height: 1024/663 05:10:07 INFO - PROCESS | 1649 | __metrics 05:10:07 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:10:08 INFO - TEST-INFO | 1649: exit 0 05:10:08 INFO - Browser initialized. 05:10:08 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:08 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp3RxFRh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:20 INFO - PROCESS | 1652 | RSS: Main: 263852032 05:10:20 INFO - PROCESS | 1652 | 05:11:09 INFO - PROCESS | 1652 | 1470658269971 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:13:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 05:13:24 INFO - PROCESS | 1652 | RSS: Main: 274780160 05:13:24 INFO - PROCESS | 1652 | 05:16:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 05:16:27 INFO - PROCESS | 1652 | RSS: Main: 289857536 05:16:27 INFO - PROCESS | 1652 | 05:19:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 05:19:30 INFO - PROCESS | 1652 | RSS: Main: 294473728 05:19:30 INFO - PROCESS | 1652 | 05:22:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 05:22:32 INFO - PROCESS | 1652 | RSS: Main: 294854656 05:22:32 INFO - PROCESS | 1652 | 05:25:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 05:25:35 INFO - PROCESS | 1652 | RSS: Main: 298627072 05:25:35 INFO - PROCESS | 1652 | 05:28:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 05:28:38 INFO - PROCESS | 1652 | RSS: Main: 298598400 05:28:38 INFO - PROCESS | 1652 | 05:28:38 INFO - PROCESS | 1652 | __start_tp_report 05:28:38 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 05:28:38 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 05:28:38 INFO - PROCESS | 1652 | |i|pagename|runs| 05:28:38 INFO - PROCESS | 1652 | |0;dojo.html;3066.3560652263027;3383.864645414185;3387.3225354929023;3389.610194827594;3433.3305005523916;5618.297712785902;5698.259226300575;5711.971440142799;5766.509846663039;5844.736986835592;5722.656640601567;5746.0806270996645;5773.33606635236;5787.623804452707;5877.177195192677;5137.383513978328;5242.030224408478;5252.973735131338;5267.341582302212;5344.866378340534;5305.098133317326;5346.8395948121615;5384.757685904144;5412.810551630694;5416.783328666848;4242.363645453176;5097.286379906816;5121.6670916390685;5121.820736274231;5241;5182.818601348972;5197.1424714922;5214.791408343662;5284.550813180885;5303.337082864642;5174.197999310113;5180.093483640348;5207.270982062514;5251.737413129366;5314.1497360422145;5580.497755202011;5680.602357834953;5754.1944127822135;5784.1034639630925;5789.102689083199;6169.321374648785;6221.595596286272;6224.937750622526;6245.156903817971;6249.625022498664;6231.688415579249;6249.9062514062325;6253.499720022387;6254.937450625481;6263.906041409383;5698.743556540007;5793.304803423532;5798.9130163047585;5882.55880808941;5889.204957330791;6301.6534090625455;6303;6327.715252813635;6328.240611126602;6351.491880649537;6192.071189321638;6197.287311959092;6198.721057552421;6216.222972128484;6235.033569796688;6125.052321061979;6173.536984726164;6195.659238741822;6228.968855155696;6237.09562113491;6164.260288765377;6224.62652240867;6254.906176407358;6266.686665666698;6270.843228919313;6147.108669242934;6205.875882482325;6259.812205633838;6274.529410294246;6278.654673992883;4949.381327334083;4996.150654388763;5006.89986200274;5022;5055.140626093573;4443.222436073739;4489.349044388546;4523.819047238139;4530.637548996073;4548.067646132535;5716;5808.361080281165;5828.591998560145;5832.970835145882;5833.270841144857;6174.166487524127;6180.8763824723255;6219.47134493564;6230.314665386894;6235;5800.9129863052085;5808.157817116495;5812.796552120655;5846.327672317653;5874.412558744177;5468.261784659099;5508.476694713996;5517;5535.557155427637;5536.778528858881;6186.4741496971465;6211.192544969306;6280.277768056732;6351.2060992375955;6352.396522330371;6185.072239164161;6204.627722336674;6216.347283535345;6217.440430361289;6238.189035425366;6294.055891616111;6373.808785736435;6392.9360706392345;6397.680115994275;6419.197600299963;6100.944524685144;6122;6148.846278842886;6157.6613286269685;6250.031245157008;6171.84570385744;6230.127782110599;6248.4064013918605;6255.31191568918;6276.372362763687;5436.266104076058;6115.082737589397;6173.660448675366;6198.132261483306;6213.1922850031015;4873.853784386474;6104.145419641165;6105.236845394325;6130.816075517741;6135.785247516315;4433.423654924968;6008.759649613967;6031.939680603138;6032.155498230163;6133.294671112701;5077.669951453144;6151.138840562415;6161.784337548164;6191.721372538156;6208.875822483435;5835.883282334415;6013.30846952606;6039.396060393926;6065.211522502046;6073.665948372705 05:28:38 INFO - PROCESS | 1652 | |1;ext.html;453.94098767160244;517.2835622662611;532.0662237772709;548.3803302268436;562.5387182510341;34787.65212347879;38387.42418863719;41797.373039404396;41797.58202417975;41925.371119433155;34852.780152694664;41664.75005749825;41684.16631667365;42220.36669449961;42274;9026.684066057689;9611.26997140518;9667.95166024169;9674.613015479372;9692.951535242313;9566.760830979247;9673.081057299545;9679.854802177973;9689.127978481934;9710.66012689556;9603.951980240088;9680.661176858812;9691;9707.077827606367;9707.174890134313;9615.66345177919;9648.662296819648;9666.371685840468;9673.854892176589;9701.466419346933;9040.502772347518;9501.334906556544;9558.522073896278;9587.041295870427;9614.663486778;36372.63627363719;40403.787886363454;40622;40906.79546602248;40908.795456022825;3025.6217972753407;3309.7352211822995;3363.814990175539;3445.104272889042;3464.5842498900292;30694.69305306963;30709.232269193224;30740.692593074007;30763.69236307653;30936;3143.9371212575847;3144.418282617723;3146.166265939528;3182.0931034655014;3250.756193285513;466849;471321;471723;473392;474239;33445.49831752526;33649.66350336514;33921.66078339234;33934.32131357359;33942.66057339395;34892.82553587216;34969;35056.47415288773;36006.45990310147;36225;16647.917885337414;16813.831861681472;16875.409360672318;16893.32426702918;16924;12052.698682532831;12857.228566286052;12914.547990820276;13012.739745205043;13030.739385212242;19224.519387015436;19240;19266.614667706566;19273.903630481756;19283.51791205231;7975.880361794578;8115.918840811634;8131.227533384319;8135.552544609985;8161.551114688749;833.6165363932538;912.6714382822179;979.4417182206216;1012.9898701012895;1026.6252817721627;26310.6053409199;27353.863230684117;28935.987240446484;31268.218294542363;31595.684043159734;1059.56557811297;1149.0294145540438;1151.5393842463081;1166;1235.4440501774059;12993.440787105608;16204.83795162057;16249.10629915366;16390.426335078453;16507.66984660324;708415;708647;715179;715677.4216128886;718764;60403.395966040654;60627.78744425087;61180.77638447206;61379.079313810325;61389.69305153535;1369.9863001370059;1392.3803907261172;1409.7744360902207;1410.456974065013;1415.8442571317146;30378.544321834746;30722.385552289277;30761.692383076777;31347.84326078355;31477.842610787717;47213;47604;47680.28479572879;47792.7610361946;47805.76097119492;462176;465292;465603;466646;467780;27297.72702272952;27400;27486;27654;27725;47566.28650570175;49458.505414945386;50496.99006019933;50755.74622126866;50874.23688644747;39962;40793.184136316515;41413.1717365657;41833.79083104565;42205.155896882505;40218.39672404858;40431;40609;41878.581214188685;42337.57662423336;34493.31013379668;38099;38625.80687096546;39436.40845387264;39651.60348396479;32872.67127328792;33427.665723342456;35471.29057418889;35844.462333065545;36200;22649.773502264765;25977.350566235997;26177.345566360233;26688.59967100534;26689.065882694013 05:28:38 INFO - PROCESS | 1652 | |2;jquery.html;372.9682976946961;380.1958857017408;384.5289520337587;397.1441543473811;403.46339368639696;17035.829641703596;17660.646787064252;17764.822351776493;21569;21591.352259432202;20460.89769551154;20708.48228794281;20942.581148377023;21407.892960535177;21740.45648858779;5476.534494567946;6009.729562169713;6118.11287363332;6159.722812473449;6263;6111.174991376174;6157.876842463148;6176.660283684418;6190.0405437157315;6192.907106393408;5880.353161152269;6035.124906888498;6052.394760523956;6109.908351374733;6138.447539721425;5957.165996760457;5968.1942937703725;5975.671338076404;6053.394660533955;6063.302720187191;5210.557102646279;5251.317328747238;5253.553447956928;5260.605454590921;5277.6305658603915;20763.5847283055;26012;26769.330766730793;26849.46301073987;27092.864535677392;2265.1958554713005;2453.644221587878;2514.1954574536157;2546.32522381569;2964.7183517565795;13076.476940922352;15692.92153539225;16000.279987400594;16056.43802466908;16441.91779041097;1859.8233167849169;1860.8883466991888;1878.2487005197893;1905.3227271366256;1926.2680181531068;113684;116796.83203167944;117254;117409;118795.8120418802;10761;10868.836967445337;11034.503447344889;11442.256253343507;11551.653450396501;13994.860051399355;14002.369893354824;14019.579412617637;14023.78964315536;14062.929685351508;7318.3047610476915;8487.872681909776;8753.343499237582;8774.473531588124;8862.556872156496;8685.565721714016;8702.782430439163;8721.258693011165;8799.252063574668;8862.86705699415;5672.801451949162;6750.561213521106;6805.523613347018;6875.140607424072;6878.518503704692;1838.604699989482;1853.1382906948334;1877.9624407511774;1898.7436696045856;1898.8480921526245;892.848235751835;901.5312037740339;981.40134517944;1016.6136867990116;1070.3043022035738;15609.609759756097;22252.108570771667;22714.318570442912;22722.545549089256;22944.885275573517;878.2403221213732;908.42315129893;951.8572214167792;987.4717026390847;990.1880458024351;8988.011318754932;11749.706257343634;11879.821802672966;12020.519179232908;12092.395380230953;527170;528694;528839;589600;613524.9323753442;96760.51619741856;111277;111299;119606;141956;818.9058258300253;995.1193194023341;1020.3775696824931;1025.0467065628889;1035.6168217759327;19493.8050619492;19611.313604024363;20231.797682022992;20406.693899591814;20510.38468845937;53554;54562;55717.44282557123;56376.43623563876;56911.430885690614;70463.64768176331;71000;75503.62248188724;79361;79947.20184793504;8099.635516401894;8147.348212142896;8329.583520824055;8363.414560980673;8439.240468357631;11343.602973895873;12949;12995.28525931045;13114.803277951029;13247.867521324664;9585.856212156683;10632.202584806017;10885.78228435411;11386.544538218379;11506.654800356002;11090.390028548507;11249.887501124884;11301.71745706364;11381.032612228053;11567.537298507965;9961.950190249003;11412.657620271406;11436.885631143583;11657.88342116568;11744;8036.598170091355;8037.879431808645;8342.416030877781;8442.620082096444;8482.745517634481;10486.26596138263;11321.150913681671;11453.885461145615;11483.25358851672;11604.013658839092 05:28:38 INFO - PROCESS | 1652 | |3;mootools.html;1535.3167840311062;1557.3848329909683;1772.8758986870916;1800.6308706715117;1873.3536929759227;6824.249332573413;8357.122502137272;8398.874016889751;8947.150020748026;8955.955220223907;8540.743777686665;8727.694530691428;8750.343724220693;8750.824983500326;8795.208431241186;1900.4488698277482;2005.6289586426485;2144.7855214478545;2395.8203134764876;2407.410184504799;2355.7290911545133;2356.1164563288767;2395.185636883459;2398.59223931932;2400.795932345744;2060.7939206079345;2376.7623237676266;2380.95238095238;2399.36416849535;2403.843750156243;2258.1306197114063;2340.309608665431;2356.2460012795827;2358.7759162879497;2366.692329997098;2088.6658134698378;2110.926117585877;2246.7979630897553;2333.6581465657146;2379.654950032236;8707.695230666895;8734.432261902955;8797.692080777142;8858.911410885874;8875.423097498706;4143.627073563393;5357.196420536911;5388.622796404254;5389.407165211824;5406.675599464005;3517.103138699641;3551.7158627309755;3645.052286405527;3686.64976827201;3710.7588006779742;1021.279997601689;1062.3360399750156;1064.2656566968767;1082.3614067700096;1086.4947799273375;11529.192956493049;11631.592894248744;11634.534618615246;11665.766684666343;11704.590339338083;4552.019871355971;4719.693219940693;4801.303810947463;4838.201696720002;4845.055214233191;9933.304668673123;9945.701628951143;9959.452230127268;9974.20206383502;9979.201663866874;5324.068288049576;5326.307580014573;5329.280547126166;5349.919751203657;5352.330958630171;4407.272799987966;4741.905161896742;4865.805367785249;4870.196417591129;4885.340479035356;3953.822078006439;3999.4000899865255;4061.431399604058;4084.346504559256;4154.189932963103;1298.6623477895625;1305.549585393038;1305.994384324065;1315.5724389573427;1321.4119716725966;854.4958474500074;922.1193759959223;934.2946075712794;942.453377041328;976.9267304952157;5134.332536770271;5903.793367232126;6073.817785466443;6088.995315772848;6147.815565533041;370.1541976583494;395.2214138147844;397.838875255522;398.4720245674493;399.36301598949626;3971.92056158881;3982.38273067675;4051.1290072634524;4065.5121385433936;4102.261592913304;10348.068673819393;10538.31500952451;10628.681139565826;10628.787424251626;10697.572097116185;9067.773305667411;10558;10569.841452378221;10585.9470702646;10603.57585696579;6640.601563906084;7749.418793590503;8068.59657017135;8238;8246.01047874259;5675.77296908119;6056.939430605637;6066.848328791815;6081.695915204311;6164;9603.183729383081;9806.705798826046;9864.21086313079;9951.054649808257;10006.199504039514;9824.263180261367;10045.296829221885;10116.84824727615;10142.695719128438;10181.236407269336;6633.70148343316;7196.136463624399;7472.626368681653;7672.578008209602;7695.961520192363;8354.498730076215;8396.32829373661;8397.076321604742;8406.705765298186;8418.074011858813;6383.744650213939;7491.10106787189;7532.924670753222;7679.961600192187;7724.0731112266885;7342.971983922148;7397.186309506058;7484;7503;7570.659320330488;6938.757143499954;7000.229974702676;7018.789436316919;7078.752243671447;7082.787516374517;4546.318052292183;4827.95172048275;4925.310456536016;5101.8724531887;5135.6918584885025;4485.708428952108;4956.454789973028;4991.2513123030385;5105.948940510547;5228.764705588182 05:28:38 INFO - PROCESS | 1652 | |4;prototype.html;278.902384165542;289.9521578939475;309.0820263816464;312.45944515987355;315.32205757621114;5402.487303555001;5456.462744823656;5657.23627310313;5704.515116215121;5706.40220738193;4820.517948205186;5273.868153296169;5559.9444005559935;5564.554835613151;5586.664800111997;3923.2153569286115;4274.850380236685;4278.593533614302;4290.935635965448;4327.891802704942;4164;4242.490901091858;4277.2087163874785;4348.7825608719595;4359.912801743963;4199.7690127043;4218.029853133781;4221.409002739619;4237.279662457374;4256.106217694288;3527.5590551181103;3552.7335449841107;4217.114405974749;4235.703500754933;4268.573142685737;3213.5661685672603;3402.897913062612;3658.536585365848;3690.926181476382;3696.907577310562;4270.636995855356;5221.216817477371;5422.810201642924;5465.836024919259;5491.807786727485;4409.294512877957;4900.725811289055;4908.558229759339;4933.9638675878105;4943.307936888838;5603.8879222415735;5744.569157313218;5940.732667029994;5975.790847320366;6014.729337179838;3336.682010605797;4012.8194231259663;4040.696947728932;4042.3734321180264;4051.270771261172;5191.636585439021;5751.511121554631;5872.443802392327;6220.595661282002;6263.404976527223;3632.9091772705365;3931.4495970564144;4077.91844163121;4109.3425051991535;4126.628603425646;3908.791532783968;4146.66826653867;4170.791460426966;4171.270027745132;4184.4141820145205;4818.4217893852265;4876.658633895664;4886.853394398174;4902.460729319843;4920.8769780755765;4926.704397736147;5812.169166712472;5935.465808077293;5949.375315591887;5975.701214939236;1181.7695549367963;1426.3296250762126;1432.2265976372641;1434.2828585707146;1468.148473885144;830.8712149616819;875.8554838451712;888.2849306308354;891.7057371067532;895.820835832823;3955.5451123120633;4464.901496296736;4651.883702907455;4677.906441871143;4730.408698912636;4577.901303687157;4596.448426188878;5166.9224961625605;5170.1727723564045;5226.843194704165;3867.1878905430176;4182.644475219579;4401.889952751207;4494.584116071744;4634.119517291704;1977.3870100268962;2249.5388445368662;2343.480758184924;2650.814442989011;2674.9331266718486;4503.527129651339;4943.195733557298;4982.2811130160035;5173.71544565045;5208.9739551302;4618.445786505641;5064.12627327891;5146.876457107683;5302.144249512639;5310.6723319170205;5006.799728010838;5084.720340381241;5261.5264626183825;5302.39022512416;5326.440723723953;4532.954670453253;4795.20879054966;4818;4946.727929963887;5050.207176452306;5118.411382691038;5158.587313015025;5178.902544469496;5189.040027594907;5508.394076651485;5062.873428164326;5566.860828479321;5613.859653508695;6450.032495125769;6467.61194328323;4022.9798851005557;4032.30643129892;4057.89855253621;4063.39049142631;4086.918261634691;5578.888422231614;6030.708330834255;6224.20323602593;6226.844328891814;6288;5196.9740151299;5568;6009.008513595382;6026.487748541248;6031.457168854824;5008.6744361616375;5561.499465048165;5949.494292985145;6012.819615411545;6108.281814592464;4953.925691114564;5550.833474995757;5557.722113894209;5615.041395815858;5945.216435069376;5597.5726189821335;5970.850728731816;6020.668863212565;6097.725602347994;6110.938890611214;4867.829625963074;5330.466953304638;5634;5782.537397008314;6016.338202797776 05:28:38 INFO - PROCESS | 1652 | |5;yui.html;703.7642389799416;743.9925600743991;764.5947647746697;765.9119201291853;845.7462761171649;15015.399384024626;15452.304646290915;15719.60700982476;15766.605834854134;15786.842131578695;11670.533178672864;14454.349554270057;14464.276786160675;14485.565433037;14486.34811433488;735.1912895814588;828.5732847583514;836.2306677856357;869.5043825019741;878.0429332028089;840.8276303357796;854.44461100285;855.2815634866711;856.7044369692446;857.2456238510102;897.7576054465324;897.896741874683;898.9910100898973;900.7387857521311;907.768519027647;890.4924193209873;893.6738090596886;894.8568229083348;896.4218079338855;897.3718397122008;656.5568241437059;662.1259936883316;663.5653646861265;663.6781161136845;665.6904539389208;15272.38910443592;15296.847031529765;15395.461158859385;15411.075335479907;15441.613959651098;11811.704707382298;14401.279936003159;14628.975971681986;14713.632159195999;14764.778528322084;10383.844242336296;11898.762024759542;11902.226355286879;12064.095192860483;12225.144239903211;3785.0348161218712;3803.4675145479655;3897.610238976108;3999.1801680655685;4005.639492445665;104590;118334.22498662527;122236;123657.76342236552;125493.09197231785;11106.167037472222;11114.777704445865;11116.666500005012;11191.496382662799;11401.315921044765;20286.08712607936;21053.473663158544;22509;22653.320400388016;22712.886435568045;7799.337056350274;8077.27304542594;8113.8782918256275;8128.918710812816;8256.8348633027;4464.821407143743;4580.679352445297;4626;4664.510226426244;4679.766011699401;3646.5077214575695;3686.7972261525874;3741.9064523386587;3752.3058234226755;3772.6227377262053;606.9196829643242;613.9201903752573;645.9709313080829;665.1884700665154;667.2860039757413;597.748945442915;688.3185646210316;700.6076597105637;703.4372501998483;707.6391040569243;8836.823263534821;9443.291753118543;9557.713268601952;9615.134637882624;9667.758306042406;583.4894467341077;614.5882258886556;616.3035769580346;622.791364892766;667.3651490399131;3681.5214022176947;4350.477942646902;4371.595622407663;4480.987254945999;4799.208130658402;101257.49371253097;124683.37658311651;155187.22406387897;160470;168783.1560842188;109943;145208.205220506;145297;147741;149119;119850.20224696636;124897;126082;128366.35816821043;129670;8891.199792018491;8919.598618062073;8928;9020.413673111227;9059.184673379428;55522.16716749333;67167.66416167888;69217;69546.30453695398;70643.29356706367;91288;92641;94087.5295623545;104866.47566762117;107409.38885916874;10873.78252434931;10887.618933337295;10890.455477226265;10978.176636752116;11502.94248528752;12004.519819207135;12491.937540312603;12997.220166790023;13243.66890827737;13934.442622294995;11820.70448238801;12381.938090309492;13365.557946879027;14093.718125637635;14169.362378692776;13792.172469651852;13831.792523112363;13923.386915552037;13936.163830170222;14536.200508972108;12180.208286461706;13527.86472135266;13531.729365412833;13879;14455.060421072596;11139;11427.314361138358;11505.482253298454;11511.942440287745;11787.941060294643;8541.957290213757;8968.955155224183;10037.7954645443;10668.679939601825;11201.943990279997 05:28:38 INFO - PROCESS | 1652 | __end_tp_report 05:28:38 INFO - PROCESS | 1652 | __start_cc_report 05:28:38 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,427 05:28:38 INFO - PROCESS | 1652 | __end_cc_report 05:28:38 INFO - PROCESS | 1652 | __startTimestamp1470659318615__endTimestamp 05:28:38 INFO - PROCESS | 1652 | 05:28:38 INFO - PROCESS | 1652 | ------- Summary: start ------- 05:28:38 INFO - PROCESS | 1652 | Number of tests: 6 05:28:38 INFO - PROCESS | 1652 | 05:28:38 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5751.43 Median:6031.94 stddev:655.66 (10.9%) stddev-sans-first:622.92 05:28:38 INFO - PROCESS | 1652 | Values: 3066.4 3383.9 3387.3 3389.6 3433.3 5618.3 5698.3 5712.0 5766.5 5844.7 5722.7 5746.1 5773.3 5787.6 5877.2 5137.4 5242.0 5253.0 5267.3 5344.9 5305.1 5346.8 5384.8 5412.8 5416.8 4242.4 5097.3 5121.7 5121.8 5241.0 5182.8 5197.1 5214.8 5284.6 5303.3 5174.2 5180.1 5207.3 5251.7 5314.1 5580.5 5680.6 5754.2 5784.1 5789.1 6169.3 6221.6 6224.9 6245.2 6249.6 6231.7 6249.9 6253.5 6254.9 6263.9 5698.7 5793.3 5798.9 5882.6 5889.2 6301.7 6303.0 6327.7 6328.2 6351.5 6192.1 6197.3 6198.7 6216.2 6235.0 6125.1 6173.5 6195.7 6229.0 6237.1 6164.3 6224.6 6254.9 6266.7 6270.8 6147.1 6205.9 6259.8 6274.5 6278.7 4949.4 4996.2 5006.9 5022.0 5055.1 4443.2 4489.3 4523.8 4530.6 4548.1 5716.0 5808.4 5828.6 5833.0 5833.3 6174.2 6180.9 6219.5 6230.3 6235.0 5800.9 5808.2 5812.8 5846.3 5874.4 5468.3 5508.5 5517.0 5535.6 5536.8 6186.5 6211.2 6280.3 6351.2 6352.4 6185.1 6204.6 6216.3 6217.4 6238.2 6294.1 6373.8 6392.9 6397.7 6419.2 6100.9 6122.0 6148.8 6157.7 6250.0 6171.8 6230.1 6248.4 6255.3 6276.4 5436.3 6115.1 6173.7 6198.1 6213.2 4873.9 6104.1 6105.2 6130.8 6135.8 4433.4 6008.8 6031.9 6032.2 6133.3 5077.7 6151.1 6161.8 6191.7 6208.9 5835.9 6013.3 6039.4 6065.2 6073.7 05:28:38 INFO - PROCESS | 1652 | 05:28:38 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:67455.06 Median:39806.80 stddev:150568.40 (378.2%) stddev-sans-first:150906.75 05:28:38 INFO - PROCESS | 1652 | Values: 453.9 517.3 532.1 548.4 562.5 34787.7 38387.4 41797.4 41797.6 41925.4 34852.8 41664.8 41684.2 42220.4 42274.0 9026.7 9611.3 9668.0 9674.6 9693.0 9566.8 9673.1 9679.9 9689.1 9710.7 9604.0 9680.7 9691.0 9707.1 9707.2 9615.7 9648.7 9666.4 9673.9 9701.5 9040.5 9501.3 9558.5 9587.0 9614.7 36372.6 40403.8 40622.0 40906.8 40908.8 3025.6 3309.7 3363.8 3445.1 3464.6 30694.7 30709.2 30740.7 30763.7 30936.0 3143.9 3144.4 3146.2 3182.1 3250.8 466849.0 471321.0 471723.0 473392.0 474239.0 33445.5 33649.7 33921.7 33934.3 33942.7 34892.8 34969.0 35056.5 36006.5 36225.0 16647.9 16813.8 16875.4 16893.3 16924.0 12052.7 12857.2 12914.5 13012.7 13030.7 19224.5 19240.0 19266.6 19273.9 19283.5 7975.9 8115.9 8131.2 8135.6 8161.6 833.6 912.7 979.4 1013.0 1026.6 26310.6 27353.9 28936.0 31268.2 31595.7 1059.6 1149.0 1151.5 1166.0 1235.4 12993.4 16204.8 16249.1 16390.4 16507.7 708415.0 708647.0 715179.0 715677.4 718764.0 60403.4 60627.8 61180.8 61379.1 61389.7 1370.0 1392.4 1409.8 1410.5 1415.8 30378.5 30722.4 30761.7 31347.8 31477.8 47213.0 47604.0 47680.3 47792.8 47805.8 462176.0 465292.0 465603.0 466646.0 467780.0 27297.7 27400.0 27486.0 27654.0 27725.0 47566.3 49458.5 50497.0 50755.7 50874.2 39962.0 40793.2 41413.2 41833.8 42205.2 40218.4 40431.0 40609.0 41878.6 42337.6 34493.3 38099.0 38625.8 39436.4 39651.6 32872.7 33427.7 35471.3 35844.5 36200.0 22649.8 25977.4 26177.3 26688.6 26689.1 05:28:38 INFO - PROCESS | 1652 | 05:28:38 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:33802.55 Median:14279.16 stddev:93266.24 (653.2%) stddev-sans-first:93494.10 05:28:38 INFO - PROCESS | 1652 | Values: 373.0 380.2 384.5 397.1 403.5 17035.8 17660.6 17764.8 21569.0 21591.4 20460.9 20708.5 20942.6 21407.9 21740.5 5476.5 6009.7 6118.1 6159.7 6263.0 6111.2 6157.9 6176.7 6190.0 6192.9 5880.4 6035.1 6052.4 6109.9 6138.4 5957.2 5968.2 5975.7 6053.4 6063.3 5210.6 5251.3 5253.6 5260.6 5277.6 20763.6 26012.0 26769.3 26849.5 27092.9 2265.2 2453.6 2514.2 2546.3 2964.7 13076.5 15692.9 16000.3 16056.4 16441.9 1859.8 1860.9 1878.2 1905.3 1926.3 113684.0 116796.8 117254.0 117409.0 118795.8 10761.0 10868.8 11034.5 11442.3 11551.7 13994.9 14002.4 14019.6 14023.8 14062.9 7318.3 8487.9 8753.3 8774.5 8862.6 8685.6 8702.8 8721.3 8799.3 8862.9 5672.8 6750.6 6805.5 6875.1 6878.5 1838.6 1853.1 1878.0 1898.7 1898.8 892.8 901.5 981.4 1016.6 1070.3 15609.6 22252.1 22714.3 22722.5 22944.9 878.2 908.4 951.9 987.5 990.2 8988.0 11749.7 11879.8 12020.5 12092.4 527170.0 528694.0 528839.0 589600.0 613524.9 96760.5 111277.0 111299.0 119606.0 141956.0 818.9 995.1 1020.4 1025.0 1035.6 19493.8 19611.3 20231.8 20406.7 20510.4 53554.0 54562.0 55717.4 56376.4 56911.4 70463.6 71000.0 75503.6 79361.0 79947.2 8099.6 8147.3 8329.6 8363.4 8439.2 11343.6 12949.0 12995.3 13114.8 13247.9 9585.9 10632.2 10885.8 11386.5 11506.7 11090.4 11249.9 11301.7 11381.0 11567.5 9962.0 11412.7 11436.9 11657.9 11744.0 8036.6 8037.9 8342.4 8442.6 8482.7 10486.3 11321.2 11453.9 11483.3 11604.0 05:28:38 INFO - PROCESS | 1652 | 05:28:38 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5660.62 Median:4868.00 stddev:3185.13 (65.4%) stddev-sans-first:3178.98 05:28:38 INFO - PROCESS | 1652 | Values: 1535.3 1557.4 1772.9 1800.6 1873.4 6824.2 8357.1 8398.9 8947.2 8956.0 8540.7 8727.7 8750.3 8750.8 8795.2 1900.4 2005.6 2144.8 2395.8 2407.4 2355.7 2356.1 2395.2 2398.6 2400.8 2060.8 2376.8 2381.0 2399.4 2403.8 2258.1 2340.3 2356.2 2358.8 2366.7 2088.7 2110.9 2246.8 2333.7 2379.7 8707.7 8734.4 8797.7 8858.9 8875.4 4143.6 5357.2 5388.6 5389.4 5406.7 3517.1 3551.7 3645.1 3686.6 3710.8 1021.3 1062.3 1064.3 1082.4 1086.5 11529.2 11631.6 11634.5 11665.8 11704.6 4552.0 4719.7 4801.3 4838.2 4845.1 9933.3 9945.7 9959.5 9974.2 9979.2 5324.1 5326.3 5329.3 5349.9 5352.3 4407.3 4741.9 4865.8 4870.2 4885.3 3953.8 3999.4 4061.4 4084.3 4154.2 1298.7 1305.5 1306.0 1315.6 1321.4 854.5 922.1 934.3 942.5 976.9 5134.3 5903.8 6073.8 6089.0 6147.8 370.2 395.2 397.8 398.5 399.4 3971.9 3982.4 4051.1 4065.5 4102.3 10348.1 10538.3 10628.7 10628.8 10697.6 9067.8 10558.0 10569.8 10585.9 10603.6 6640.6 7749.4 8068.6 8238.0 8246.0 5675.8 6056.9 6066.8 6081.7 6164.0 9603.2 9806.7 9864.2 9951.1 10006.2 9824.3 10045.3 10116.8 10142.7 10181.2 6633.7 7196.1 7472.6 7672.6 7696.0 8354.5 8396.3 8397.1 8406.7 8418.1 6383.7 7491.1 7532.9 7680.0 7724.1 7343.0 7397.2 7484.0 7503.0 7570.7 6938.8 7000.2 7018.8 7078.8 7082.8 4546.3 4828.0 4925.3 5101.9 5135.7 4485.7 4956.5 4991.3 5105.9 5228.8 05:28:38 INFO - PROCESS | 1652 | 05:28:38 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4553.72 Median:4943.25 stddev:1408.36 (28.5%) stddev-sans-first:1375.28 05:28:38 INFO - PROCESS | 1652 | Values: 278.9 290.0 309.1 312.5 315.3 5402.5 5456.5 5657.2 5704.5 5706.4 4820.5 5273.9 5559.9 5564.6 5586.7 3923.2 4274.9 4278.6 4290.9 4327.9 4164.0 4242.5 4277.2 4348.8 4359.9 4199.8 4218.0 4221.4 4237.3 4256.1 3527.6 3552.7 4217.1 4235.7 4268.6 3213.6 3402.9 3658.5 3690.9 3696.9 4270.6 5221.2 5422.8 5465.8 5491.8 4409.3 4900.7 4908.6 4934.0 4943.3 5603.9 5744.6 5940.7 5975.8 6014.7 3336.7 4012.8 4040.7 4042.4 4051.3 5191.6 5751.5 5872.4 6220.6 6263.4 3632.9 3931.4 4077.9 4109.3 4126.6 3908.8 4146.7 4170.8 4171.3 4184.4 4818.4 4876.7 4886.9 4902.5 4920.9 4926.7 5812.2 5935.5 5949.4 5975.7 1181.8 1426.3 1432.2 1434.3 1468.1 830.9 875.9 888.3 891.7 895.8 3955.5 4464.9 4651.9 4677.9 4730.4 4577.9 4596.4 5166.9 5170.2 5226.8 3867.2 4182.6 4401.9 4494.6 4634.1 1977.4 2249.5 2343.5 2650.8 2674.9 4503.5 4943.2 4982.3 5173.7 5209.0 4618.4 5064.1 5146.9 5302.1 5310.7 5006.8 5084.7 5261.5 5302.4 5326.4 4533.0 4795.2 4818.0 4946.7 5050.2 5118.4 5158.6 5178.9 5189.0 5508.4 5062.9 5566.9 5613.9 6450.0 6467.6 4023.0 4032.3 4057.9 4063.4 4086.9 5578.9 6030.7 6224.2 6226.8 6288.0 5197.0 5568.0 6009.0 6026.5 6031.5 5008.7 5561.5 5949.5 6012.8 6108.3 4953.9 5550.8 5557.7 5615.0 5945.2 5597.6 5970.9 6020.7 6097.7 6110.9 4867.8 5330.5 5634.0 5782.5 6016.3 05:28:38 INFO - PROCESS | 1652 | 05:28:38 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:25837.03 Median:3664.01 stddev:42140.50 (1150.1%) stddev-sans-first:42216.46 05:28:38 INFO - PROCESS | 1652 | Values: 703.8 744.0 764.6 765.9 845.7 15015.4 15452.3 15719.6 15766.6 15786.8 11670.5 14454.3 14464.3 14485.6 14486.3 735.2 828.6 836.2 869.5 878.0 840.8 854.4 855.3 856.7 857.2 897.8 897.9 899.0 900.7 907.8 890.5 893.7 894.9 896.4 897.4 656.6 662.1 663.6 663.7 665.7 15272.4 15296.8 15395.5 15411.1 15441.6 11811.7 14401.3 14629.0 14713.6 14764.8 10383.8 11898.8 11902.2 12064.1 12225.1 3785.0 3803.5 3897.6 3999.2 4005.6 104590.0 118334.2 122236.0 123657.8 125493.1 11106.2 11114.8 11116.7 11191.5 11401.3 20286.1 21053.5 22509.0 22653.3 22712.9 7799.3 8077.3 8113.9 8128.9 8256.8 4464.8 4580.7 4626.0 4664.5 4679.8 3646.5 3686.8 3741.9 3752.3 3772.6 606.9 613.9 646.0 665.2 667.3 597.7 688.3 700.6 703.4 707.6 8836.8 9443.3 9557.7 9615.1 9667.8 583.5 614.6 616.3 622.8 667.4 3681.5 4350.5 4371.6 4481.0 4799.2 101257.5 124683.4 155187.2 160470.0 168783.2 109943.0 145208.2 145297.0 147741.0 149119.0 119850.2 124897.0 126082.0 128366.4 129670.0 8891.2 8919.6 8928.0 9020.4 9059.2 55522.2 67167.7 69217.0 69546.3 70643.3 91288.0 92641.0 94087.5 104866.5 107409.4 10873.8 10887.6 10890.5 10978.2 11502.9 12004.5 12491.9 12997.2 13243.7 13934.4 11820.7 12381.9 13365.6 14093.7 14169.4 13792.2 13831.8 13923.4 13936.2 14536.2 12180.2 13527.9 13531.7 13879.0 14455.1 11139.0 11427.3 11505.5 11511.9 11787.9 8542.0 8969.0 10037.8 10668.7 11201.9 05:28:38 INFO - PROCESS | 1652 | -------- Summary: end -------- 05:28:38 INFO - PROCESS | 1652 | 05:28:39 INFO - TEST-INFO | 1652: exit 0 05:28:39 INFO - TEST-OK | dromaeo_css | took 1114772ms 05:28:39 INFO - TEST-START | kraken 05:28:39 INFO - operating with platform_type : mac_ 05:28:39 INFO - Initialising browser for kraken test... 05:28:39 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpZH9ndW/profile http://localhost:49269/getInfo.html) 05:28:42 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 05:28:42 INFO - PROCESS | 1661 | colorDepth:24 05:28:42 INFO - PROCESS | 1661 | Browser inner width/height: 1024/663 05:28:42 INFO - PROCESS | 1661 | __metrics 05:28:42 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:28:42 INFO - TEST-INFO | 1661: exit 0 05:28:42 INFO - Browser initialized. 05:28:42 INFO - Running cycle 1/1 for kraken test... 05:28:42 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpZH9ndW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:54 INFO - PROCESS | 1663 | RSS: Main: 263757824 05:28:54 INFO - PROCESS | 1663 | 05:28:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:58 INFO - PROCESS | 1663 | RSS: Main: 274477056 05:28:58 INFO - PROCESS | 1663 | 05:29:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 05:29:01 INFO - PROCESS | 1663 | RSS: Main: 283267072 05:29:01 INFO - PROCESS | 1663 | 05:29:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 05:29:06 INFO - PROCESS | 1663 | RSS: Main: 283160576 05:29:06 INFO - PROCESS | 1663 | 05:29:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 05:29:08 INFO - PROCESS | 1663 | RSS: Main: 284020736 05:29:08 INFO - PROCESS | 1663 | 05:29:10 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:11 INFO - PROCESS | 1663 | RSS: Main: 285618176 05:29:11 INFO - PROCESS | 1663 | 05:29:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:14 INFO - PROCESS | 1663 | RSS: Main: 286412800 05:29:14 INFO - PROCESS | 1663 | 05:29:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:18 INFO - PROCESS | 1663 | RSS: Main: 286224384 05:29:18 INFO - PROCESS | 1663 | 05:29:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 05:29:22 INFO - PROCESS | 1663 | RSS: Main: 287182848 05:29:22 INFO - PROCESS | 1663 | 05:29:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:24 INFO - PROCESS | 1663 | RSS: Main: 286466048 05:29:24 INFO - PROCESS | 1663 | 05:29:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:27 INFO - PROCESS | 1663 | RSS: Main: 286027776 05:29:27 INFO - PROCESS | 1663 | 05:29:29 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:30 INFO - PROCESS | 1663 | RSS: Main: 286347264 05:29:30 INFO - PROCESS | 1663 | 05:29:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:33 INFO - PROCESS | 1663 | RSS: Main: 286412800 05:29:33 INFO - PROCESS | 1663 | 05:29:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:37 INFO - PROCESS | 1663 | RSS: Main: 286375936 05:29:37 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 05:29:39 INFO - PROCESS | 1663 | RSS: Main: 287608832 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | __start_tp_report 05:29:39 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 05:29:39 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 05:29:39 INFO - PROCESS | 1663 | |i|pagename|runs| 05:29:39 INFO - PROCESS | 1663 | |0;ai-astar;104;118;104;125;117;116;114;115;117;116 05:29:39 INFO - PROCESS | 1663 | |1;audio-beat-detection;140;115;170;198;92;156;157;138;179;109 05:29:39 INFO - PROCESS | 1663 | |2;audio-dft;198;217;205;286;253;278;215;197;196;196 05:29:39 INFO - PROCESS | 1663 | |3;audio-fft;64;110;105;184;53;48;52;55;135;84 05:29:39 INFO - PROCESS | 1663 | |4;audio-oscillator;82;97;146;62;101;116;145;55;91;148 05:29:39 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;89;91;91;88;90;87;90;87;91;87 05:29:39 INFO - PROCESS | 1663 | |6;imaging-darkroom;106;97;96;96;96;108;97;96;96;96 05:29:39 INFO - PROCESS | 1663 | |7;imaging-desaturate;91;151;123;147;75;105;144;133;105;98 05:29:39 INFO - PROCESS | 1663 | |8;json-parse-financial;56;55;59;55;58;57;57;56;56;57 05:29:39 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;62;101;97;69;85;80;76;109;103;60 05:29:39 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;90;88;86;83;85;88;106;104;110;91 05:29:39 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;139;168;142;161;130;133;150;128;162;157 05:29:39 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;172;174;168;167;191;161;235;159;214;228 05:29:39 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;70;70;68;68;90;80;83;70;59;77 05:29:39 INFO - PROCESS | 1663 | __end_tp_report 05:29:39 INFO - PROCESS | 1663 | __start_cc_report 05:29:39 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1069 05:29:39 INFO - PROCESS | 1663 | __end_cc_report 05:29:39 INFO - PROCESS | 1663 | __startTimestamp1470659379587__endTimestamp 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | ------- Summary: start ------- 05:29:39 INFO - PROCESS | 1663 | Number of tests: 14 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:114.60 Median:116.50 stddev:6.33 (5.4%) stddev-sans-first:5.43 05:29:39 INFO - PROCESS | 1663 | Values: 104.0 118.0 104.0 125.0 117.0 116.0 114.0 115.0 117.0 116.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:163.50 stddev:33.22 (20.3%) stddev-sans-first:35.18 05:29:39 INFO - PROCESS | 1663 | Values: 140.0 115.0 170.0 198.0 92.0 156.0 157.0 138.0 179.0 109.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:224.10 Median:216.00 stddev:35.06 (16.2%) stddev-sans-first:35.90 05:29:39 INFO - PROCESS | 1663 | Values: 198.0 217.0 205.0 286.0 253.0 278.0 215.0 197.0 196.0 196.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:89.00 Median:52.50 stddev:44.71 (85.2%) stddev-sans-first:46.50 05:29:39 INFO - PROCESS | 1663 | Values: 64.0 110.0 105.0 184.0 53.0 48.0 52.0 55.0 135.0 84.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:58.50 stddev:33.99 (58.1%) stddev-sans-first:35.08 05:29:39 INFO - PROCESS | 1663 | Values: 82.0 97.0 146.0 62.0 101.0 116.0 145.0 55.0 91.0 148.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:90.00 stddev:1.73 (1.9%) stddev-sans-first:1.83 05:29:39 INFO - PROCESS | 1663 | Values: 89.0 91.0 91.0 88.0 90.0 87.0 90.0 87.0 91.0 87.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:98.40 Median:96.00 stddev:4.58 (4.8%) stddev-sans-first:3.94 05:29:39 INFO - PROCESS | 1663 | Values: 106.0 97.0 96.0 96.0 96.0 108.0 97.0 96.0 96.0 96.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:117.20 Median:149.00 stddev:26.17 (17.6%) stddev-sans-first:25.99 05:29:39 INFO - PROCESS | 1663 | Values: 91.0 151.0 123.0 147.0 75.0 105.0 144.0 133.0 105.0 98.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.26 (2.2%) stddev-sans-first:1.32 05:29:39 INFO - PROCESS | 1663 | Values: 56.0 55.0 59.0 55.0 58.0 57.0 57.0 56.0 56.0 57.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:84.20 Median:72.50 stddev:17.67 (24.4%) stddev-sans-first:16.82 05:29:39 INFO - PROCESS | 1663 | Values: 62.0 101.0 97.0 69.0 85.0 80.0 76.0 109.0 103.0 60.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:87.00 stddev:9.75 (11.2%) stddev-sans-first:10.27 05:29:39 INFO - PROCESS | 1663 | Values: 90.0 88.0 86.0 83.0 85.0 88.0 106.0 104.0 110.0 91.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:153.50 stddev:14.55 (9.5%) stddev-sans-first:15.14 05:29:39 INFO - PROCESS | 1663 | Values: 139.0 168.0 142.0 161.0 130.0 133.0 150.0 128.0 162.0 157.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.90 Median:182.50 stddev:28.57 (15.7%) stddev-sans-first:29.79 05:29:39 INFO - PROCESS | 1663 | Values: 172.0 174.0 168.0 167.0 191.0 161.0 235.0 159.0 214.0 228.0 05:29:39 INFO - PROCESS | 1663 | 05:29:39 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:73.50 stddev:8.97 (12.2%) stddev-sans-first:9.43 05:29:39 INFO - PROCESS | 1663 | Values: 70.0 70.0 68.0 68.0 90.0 80.0 83.0 70.0 59.0 77.0 05:29:39 INFO - PROCESS | 1663 | -------- Summary: end -------- 05:29:39 INFO - PROCESS | 1663 | 05:29:40 INFO - TEST-INFO | 1663: exit 0 05:29:40 INFO - TEST-OK | kraken | took 61304ms 05:29:40 INFO - SUITE-END | took 1176s 05:29:40 INFO - Completed test suite (00:19:36) 05:29:40 INFO - javascript benchmark 05:29:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7348.789351783178, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.3560652263027, 3383.864645414185, 3387.3225354929023, 3389.610194827594, 3433.3305005523916, 5618.297712785902, 5698.259226300575, 5711.971440142799, 5766.509846663039, 5844.736986835592, 5722.656640601567, 5746.0806270996645, 5773.33606635236, 5787.623804452707, 5877.177195192677, 5137.383513978328, 5242.030224408478, 5252.973735131338, 5267.341582302212, 5344.866378340534, 5305.098133317326, 5346.8395948121615, 5384.757685904144, 5412.810551630694, 5416.783328666848, 4242.363645453176, 5097.286379906816, 5121.6670916390685, 5121.820736274231, 5241.0, 5182.818601348972, 5197.1424714922, 5214.791408343662, 5284.550813180885, 5303.337082864642, 5174.197999310113, 5180.093483640348, 5207.270982062514, 5251.737413129366, 5314.1497360422145, 5580.497755202011, 5680.602357834953, 5754.1944127822135, 5784.1034639630925, 5789.102689083199, 6169.321374648785, 6221.595596286272, 6224.937750622526, 6245.156903817971, 6249.625022498664, 6231.688415579249, 6249.9062514062325, 6253.499720022387, 6254.937450625481, 6263.906041409383, 5698.743556540007, 5793.304803423532, 5798.9130163047585, 5882.55880808941, 5889.204957330791, 6301.6534090625455, 6303.0, 6327.715252813635, 6328.240611126602, 6351.491880649537, 6192.071189321638, 6197.287311959092, 6198.721057552421, 6216.222972128484, 6235.033569796688, 6125.052321061979, 6173.536984726164, 6195.659238741822, 6228.968855155696, 6237.09562113491, 6164.260288765377, 6224.62652240867, 6254.906176407358, 6266.686665666698, 6270.843228919313, 6147.108669242934, 6205.875882482325, 6259.812205633838, 6274.529410294246, 6278.654673992883, 4949.381327334083, 4996.150654388763, 5006.89986200274, 5022.0, 5055.140626093573, 4443.222436073739, 4489.349044388546, 4523.819047238139, 4530.637548996073, 4548.067646132535, 5716.0, 5808.361080281165, 5828.591998560145, 5832.970835145882, 5833.270841144857, 6174.166487524127, 6180.8763824723255, 6219.47134493564, 6230.314665386894, 6235.0, 5800.9129863052085, 5808.157817116495, 5812.796552120655, 5846.327672317653, 5874.412558744177, 5468.261784659099, 5508.476694713996, 5517.0, 5535.557155427637, 5536.778528858881, 6186.4741496971465, 6211.192544969306, 6280.277768056732, 6351.2060992375955, 6352.396522330371, 6185.072239164161, 6204.627722336674, 6216.347283535345, 6217.440430361289, 6238.189035425366, 6294.055891616111, 6373.808785736435, 6392.9360706392345, 6397.680115994275, 6419.197600299963, 6100.944524685144, 6122.0, 6148.846278842886, 6157.6613286269685, 6250.031245157008, 6171.84570385744, 6230.127782110599, 6248.4064013918605, 6255.31191568918, 6276.372362763687, 5436.266104076058, 6115.082737589397, 6173.660448675366, 6198.132261483306, 6213.1922850031015, 4873.853784386474, 6104.145419641165, 6105.236845394325, 6130.816075517741, 6135.785247516315, 4433.423654924968, 6008.759649613967, 6031.939680603138, 6032.155498230163, 6133.294671112701, 5077.669951453144, 6151.138840562415, 6161.784337548164, 6191.721372538156, 6208.875822483435, 5835.883282334415, 6013.30846952606, 6039.396060393926, 6065.211522502046, 6073.665948372705], "value": 5710.414819277248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.94098767160244, 517.2835622662611, 532.0662237772709, 548.3803302268436, 562.5387182510341, 34787.65212347879, 38387.42418863719, 41797.373039404396, 41797.58202417975, 41925.371119433155, 34852.780152694664, 41664.75005749825, 41684.16631667365, 42220.36669449961, 42274.0, 9026.684066057689, 9611.26997140518, 9667.95166024169, 9674.613015479372, 9692.951535242313, 9566.760830979247, 9673.081057299545, 9679.854802177973, 9689.127978481934, 9710.66012689556, 9603.951980240088, 9680.661176858812, 9691.0, 9707.077827606367, 9707.174890134313, 9615.66345177919, 9648.662296819648, 9666.371685840468, 9673.854892176589, 9701.466419346933, 9040.502772347518, 9501.334906556544, 9558.522073896278, 9587.041295870427, 9614.663486778, 36372.63627363719, 40403.787886363454, 40622.0, 40906.79546602248, 40908.795456022825, 3025.6217972753407, 3309.7352211822995, 3363.814990175539, 3445.104272889042, 3464.5842498900292, 30694.69305306963, 30709.232269193224, 30740.692593074007, 30763.69236307653, 30936.0, 3143.9371212575847, 3144.418282617723, 3146.166265939528, 3182.0931034655014, 3250.756193285513, 466849.0, 471321.0, 471723.0, 473392.0, 474239.0, 33445.49831752526, 33649.66350336514, 33921.66078339234, 33934.32131357359, 33942.66057339395, 34892.82553587216, 34969.0, 35056.47415288773, 36006.45990310147, 36225.0, 16647.917885337414, 16813.831861681472, 16875.409360672318, 16893.32426702918, 16924.0, 12052.698682532831, 12857.228566286052, 12914.547990820276, 13012.739745205043, 13030.739385212242, 19224.519387015436, 19240.0, 19266.614667706566, 19273.903630481756, 19283.51791205231, 7975.880361794578, 8115.918840811634, 8131.227533384319, 8135.552544609985, 8161.551114688749, 833.6165363932538, 912.6714382822179, 979.4417182206216, 1012.9898701012895, 1026.6252817721627, 26310.6053409199, 27353.863230684117, 28935.987240446484, 31268.218294542363, 31595.684043159734, 1059.56557811297, 1149.0294145540438, 1151.5393842463081, 1166.0, 1235.4440501774059, 12993.440787105608, 16204.83795162057, 16249.10629915366, 16390.426335078453, 16507.66984660324, 708415.0, 708647.0, 715179.0, 715677.4216128886, 718764.0, 60403.395966040654, 60627.78744425087, 61180.77638447206, 61379.079313810325, 61389.69305153535, 1369.9863001370059, 1392.3803907261172, 1409.7744360902207, 1410.456974065013, 1415.8442571317146, 30378.544321834746, 30722.385552289277, 30761.692383076777, 31347.84326078355, 31477.842610787717, 47213.0, 47604.0, 47680.28479572879, 47792.7610361946, 47805.76097119492, 462176.0, 465292.0, 465603.0, 466646.0, 467780.0, 27297.72702272952, 27400.0, 27486.0, 27654.0, 27725.0, 47566.28650570175, 49458.505414945386, 50496.99006019933, 50755.74622126866, 50874.23688644747, 39962.0, 40793.184136316515, 41413.1717365657, 41833.79083104565, 42205.155896882505, 40218.39672404858, 40431.0, 40609.0, 41878.581214188685, 42337.57662423336, 34493.31013379668, 38099.0, 38625.80687096546, 39436.40845387264, 39651.60348396479, 32872.67127328792, 33427.665723342456, 35471.29057418889, 35844.462333065545, 36200.0, 22649.773502264765, 25977.350566235997, 26177.345566360233, 26688.59967100534, 26689.065882694013], "value": 19503.71520997343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.9682976946961, 380.1958857017408, 384.5289520337587, 397.1441543473811, 403.46339368639696, 17035.829641703596, 17660.646787064252, 17764.822351776493, 21569.0, 21591.352259432202, 20460.89769551154, 20708.48228794281, 20942.581148377023, 21407.892960535177, 21740.45648858779, 5476.534494567946, 6009.729562169713, 6118.11287363332, 6159.722812473449, 6263.0, 6111.174991376174, 6157.876842463148, 6176.660283684418, 6190.0405437157315, 6192.907106393408, 5880.353161152269, 6035.124906888498, 6052.394760523956, 6109.908351374733, 6138.447539721425, 5957.165996760457, 5968.1942937703725, 5975.671338076404, 6053.394660533955, 6063.302720187191, 5210.557102646279, 5251.317328747238, 5253.553447956928, 5260.605454590921, 5277.6305658603915, 20763.5847283055, 26012.0, 26769.330766730793, 26849.46301073987, 27092.864535677392, 2265.1958554713005, 2453.644221587878, 2514.1954574536157, 2546.32522381569, 2964.7183517565795, 13076.476940922352, 15692.92153539225, 16000.279987400594, 16056.43802466908, 16441.91779041097, 1859.8233167849169, 1860.8883466991888, 1878.2487005197893, 1905.3227271366256, 1926.2680181531068, 113684.0, 116796.83203167944, 117254.0, 117409.0, 118795.8120418802, 10761.0, 10868.836967445337, 11034.503447344889, 11442.256253343507, 11551.653450396501, 13994.860051399355, 14002.369893354824, 14019.579412617637, 14023.78964315536, 14062.929685351508, 7318.3047610476915, 8487.872681909776, 8753.343499237582, 8774.473531588124, 8862.556872156496, 8685.565721714016, 8702.782430439163, 8721.258693011165, 8799.252063574668, 8862.86705699415, 5672.801451949162, 6750.561213521106, 6805.523613347018, 6875.140607424072, 6878.518503704692, 1838.604699989482, 1853.1382906948334, 1877.9624407511774, 1898.7436696045856, 1898.8480921526245, 892.848235751835, 901.5312037740339, 981.40134517944, 1016.6136867990116, 1070.3043022035738, 15609.609759756097, 22252.108570771667, 22714.318570442912, 22722.545549089256, 22944.885275573517, 878.2403221213732, 908.42315129893, 951.8572214167792, 987.4717026390847, 990.1880458024351, 8988.011318754932, 11749.706257343634, 11879.821802672966, 12020.519179232908, 12092.395380230953, 527170.0, 528694.0, 528839.0, 589600.0, 613524.9323753442, 96760.51619741856, 111277.0, 111299.0, 119606.0, 141956.0, 818.9058258300253, 995.1193194023341, 1020.3775696824931, 1025.0467065628889, 1035.6168217759327, 19493.8050619492, 19611.313604024363, 20231.797682022992, 20406.693899591814, 20510.38468845937, 53554.0, 54562.0, 55717.44282557123, 56376.43623563876, 56911.430885690614, 70463.64768176331, 71000.0, 75503.62248188724, 79361.0, 79947.20184793504, 8099.635516401894, 8147.348212142896, 8329.583520824055, 8363.414560980673, 8439.240468357631, 11343.602973895873, 12949.0, 12995.28525931045, 13114.803277951029, 13247.867521324664, 9585.856212156683, 10632.202584806017, 10885.78228435411, 11386.544538218379, 11506.654800356002, 11090.390028548507, 11249.887501124884, 11301.71745706364, 11381.032612228053, 11567.537298507965, 9961.950190249003, 11412.657620271406, 11436.885631143583, 11657.88342116568, 11744.0, 8036.598170091355, 8037.879431808645, 8342.416030877781, 8442.620082096444, 8482.745517634481, 10486.26596138263, 11321.150913681671, 11453.885461145615, 11483.25358851672, 11604.013658839092], "value": 9836.5394689005, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.3167840311062, 1557.3848329909683, 1772.8758986870916, 1800.6308706715117, 1873.3536929759227, 6824.249332573413, 8357.122502137272, 8398.874016889751, 8947.150020748026, 8955.955220223907, 8540.743777686665, 8727.694530691428, 8750.343724220693, 8750.824983500326, 8795.208431241186, 1900.4488698277482, 2005.6289586426485, 2144.7855214478545, 2395.8203134764876, 2407.410184504799, 2355.7290911545133, 2356.1164563288767, 2395.185636883459, 2398.59223931932, 2400.795932345744, 2060.7939206079345, 2376.7623237676266, 2380.95238095238, 2399.36416849535, 2403.843750156243, 2258.1306197114063, 2340.309608665431, 2356.2460012795827, 2358.7759162879497, 2366.692329997098, 2088.6658134698378, 2110.926117585877, 2246.7979630897553, 2333.6581465657146, 2379.654950032236, 8707.695230666895, 8734.432261902955, 8797.692080777142, 8858.911410885874, 8875.423097498706, 4143.627073563393, 5357.196420536911, 5388.622796404254, 5389.407165211824, 5406.675599464005, 3517.103138699641, 3551.7158627309755, 3645.052286405527, 3686.64976827201, 3710.7588006779742, 1021.279997601689, 1062.3360399750156, 1064.2656566968767, 1082.3614067700096, 1086.4947799273375, 11529.192956493049, 11631.592894248744, 11634.534618615246, 11665.766684666343, 11704.590339338083, 4552.019871355971, 4719.693219940693, 4801.303810947463, 4838.201696720002, 4845.055214233191, 9933.304668673123, 9945.701628951143, 9959.452230127268, 9974.20206383502, 9979.201663866874, 5324.068288049576, 5326.307580014573, 5329.280547126166, 5349.919751203657, 5352.330958630171, 4407.272799987966, 4741.905161896742, 4865.805367785249, 4870.196417591129, 4885.340479035356, 3953.822078006439, 3999.4000899865255, 4061.431399604058, 4084.346504559256, 4154.189932963103, 1298.6623477895625, 1305.549585393038, 1305.994384324065, 1315.5724389573427, 1321.4119716725966, 854.4958474500074, 922.1193759959223, 934.2946075712794, 942.453377041328, 976.9267304952157, 5134.332536770271, 5903.793367232126, 6073.817785466443, 6088.995315772848, 6147.815565533041, 370.1541976583494, 395.2214138147844, 397.838875255522, 398.4720245674493, 399.36301598949626, 3971.92056158881, 3982.38273067675, 4051.1290072634524, 4065.5121385433936, 4102.261592913304, 10348.068673819393, 10538.31500952451, 10628.681139565826, 10628.787424251626, 10697.572097116185, 9067.773305667411, 10558.0, 10569.841452378221, 10585.9470702646, 10603.57585696579, 6640.601563906084, 7749.418793590503, 8068.59657017135, 8238.0, 8246.01047874259, 5675.77296908119, 6056.939430605637, 6066.848328791815, 6081.695915204311, 6164.0, 9603.183729383081, 9806.705798826046, 9864.21086313079, 9951.054649808257, 10006.199504039514, 9824.263180261367, 10045.296829221885, 10116.84824727615, 10142.695719128438, 10181.236407269336, 6633.70148343316, 7196.136463624399, 7472.626368681653, 7672.578008209602, 7695.961520192363, 8354.498730076215, 8396.32829373661, 8397.076321604742, 8406.705765298186, 8418.074011858813, 6383.744650213939, 7491.10106787189, 7532.924670753222, 7679.961600192187, 7724.0731112266885, 7342.971983922148, 7397.186309506058, 7484.0, 7503.0, 7570.659320330488, 6938.757143499954, 7000.229974702676, 7018.789436316919, 7078.752243671447, 7082.787516374517, 4546.318052292183, 4827.95172048275, 4925.310456536016, 5101.8724531887, 5135.6918584885025, 4485.708428952108, 4956.454789973028, 4991.2513123030385, 5105.948940510547, 5228.764705588182], "value": 4466.415635269728, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.902384165542, 289.9521578939475, 309.0820263816464, 312.45944515987355, 315.32205757621114, 5402.487303555001, 5456.462744823656, 5657.23627310313, 5704.515116215121, 5706.40220738193, 4820.517948205186, 5273.868153296169, 5559.9444005559935, 5564.554835613151, 5586.664800111997, 3923.2153569286115, 4274.850380236685, 4278.593533614302, 4290.935635965448, 4327.891802704942, 4164.0, 4242.490901091858, 4277.2087163874785, 4348.7825608719595, 4359.912801743963, 4199.7690127043, 4218.029853133781, 4221.409002739619, 4237.279662457374, 4256.106217694288, 3527.5590551181103, 3552.7335449841107, 4217.114405974749, 4235.703500754933, 4268.573142685737, 3213.5661685672603, 3402.897913062612, 3658.536585365848, 3690.926181476382, 3696.907577310562, 4270.636995855356, 5221.216817477371, 5422.810201642924, 5465.836024919259, 5491.807786727485, 4409.294512877957, 4900.725811289055, 4908.558229759339, 4933.9638675878105, 4943.307936888838, 5603.8879222415735, 5744.569157313218, 5940.732667029994, 5975.790847320366, 6014.729337179838, 3336.682010605797, 4012.8194231259663, 4040.696947728932, 4042.3734321180264, 4051.270771261172, 5191.636585439021, 5751.511121554631, 5872.443802392327, 6220.595661282002, 6263.404976527223, 3632.9091772705365, 3931.4495970564144, 4077.91844163121, 4109.3425051991535, 4126.628603425646, 3908.791532783968, 4146.66826653867, 4170.791460426966, 4171.270027745132, 4184.4141820145205, 4818.4217893852265, 4876.658633895664, 4886.853394398174, 4902.460729319843, 4920.8769780755765, 4926.704397736147, 5812.169166712472, 5935.465808077293, 5949.375315591887, 5975.701214939236, 1181.7695549367963, 1426.3296250762126, 1432.2265976372641, 1434.2828585707146, 1468.148473885144, 830.8712149616819, 875.8554838451712, 888.2849306308354, 891.7057371067532, 895.820835832823, 3955.5451123120633, 4464.901496296736, 4651.883702907455, 4677.906441871143, 4730.408698912636, 4577.901303687157, 4596.448426188878, 5166.9224961625605, 5170.1727723564045, 5226.843194704165, 3867.1878905430176, 4182.644475219579, 4401.889952751207, 4494.584116071744, 4634.119517291704, 1977.3870100268962, 2249.5388445368662, 2343.480758184924, 2650.814442989011, 2674.9331266718486, 4503.527129651339, 4943.195733557298, 4982.2811130160035, 5173.71544565045, 5208.9739551302, 4618.445786505641, 5064.12627327891, 5146.876457107683, 5302.144249512639, 5310.6723319170205, 5006.799728010838, 5084.720340381241, 5261.5264626183825, 5302.39022512416, 5326.440723723953, 4532.954670453253, 4795.20879054966, 4818.0, 4946.727929963887, 5050.207176452306, 5118.411382691038, 5158.587313015025, 5178.902544469496, 5189.040027594907, 5508.394076651485, 5062.873428164326, 5566.860828479321, 5613.859653508695, 6450.032495125769, 6467.61194328323, 4022.9798851005557, 4032.30643129892, 4057.89855253621, 4063.39049142631, 4086.918261634691, 5578.888422231614, 6030.708330834255, 6224.20323602593, 6226.844328891814, 6288.0, 5196.9740151299, 5568.0, 6009.008513595382, 6026.487748541248, 6031.457168854824, 5008.6744361616375, 5561.499465048165, 5949.494292985145, 6012.819615411545, 6108.281814592464, 4953.925691114564, 5550.833474995757, 5557.722113894209, 5615.041395815858, 5945.216435069376, 5597.5726189821335, 5970.850728731816, 6020.668863212565, 6097.725602347994, 6110.938890611214, 4867.829625963074, 5330.466953304638, 5634.0, 5782.537397008314, 6016.338202797776], "value": 4101.982406068805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.7642389799416, 743.9925600743991, 764.5947647746697, 765.9119201291853, 845.7462761171649, 15015.399384024626, 15452.304646290915, 15719.60700982476, 15766.605834854134, 15786.842131578695, 11670.533178672864, 14454.349554270057, 14464.276786160675, 14485.565433037, 14486.34811433488, 735.1912895814588, 828.5732847583514, 836.2306677856357, 869.5043825019741, 878.0429332028089, 840.8276303357796, 854.44461100285, 855.2815634866711, 856.7044369692446, 857.2456238510102, 897.7576054465324, 897.896741874683, 898.9910100898973, 900.7387857521311, 907.768519027647, 890.4924193209873, 893.6738090596886, 894.8568229083348, 896.4218079338855, 897.3718397122008, 656.5568241437059, 662.1259936883316, 663.5653646861265, 663.6781161136845, 665.6904539389208, 15272.38910443592, 15296.847031529765, 15395.461158859385, 15411.075335479907, 15441.613959651098, 11811.704707382298, 14401.279936003159, 14628.975971681986, 14713.632159195999, 14764.778528322084, 10383.844242336296, 11898.762024759542, 11902.226355286879, 12064.095192860483, 12225.144239903211, 3785.0348161218712, 3803.4675145479655, 3897.610238976108, 3999.1801680655685, 4005.639492445665, 104590.0, 118334.22498662527, 122236.0, 123657.76342236552, 125493.09197231785, 11106.167037472222, 11114.777704445865, 11116.666500005012, 11191.496382662799, 11401.315921044765, 20286.08712607936, 21053.473663158544, 22509.0, 22653.320400388016, 22712.886435568045, 7799.337056350274, 8077.27304542594, 8113.8782918256275, 8128.918710812816, 8256.8348633027, 4464.821407143743, 4580.679352445297, 4626.0, 4664.510226426244, 4679.766011699401, 3646.5077214575695, 3686.7972261525874, 3741.9064523386587, 3752.3058234226755, 3772.6227377262053, 606.9196829643242, 613.9201903752573, 645.9709313080829, 665.1884700665154, 667.2860039757413, 597.748945442915, 688.3185646210316, 700.6076597105637, 703.4372501998483, 707.6391040569243, 8836.823263534821, 9443.291753118543, 9557.713268601952, 9615.134637882624, 9667.758306042406, 583.4894467341077, 614.5882258886556, 616.3035769580346, 622.791364892766, 667.3651490399131, 3681.5214022176947, 4350.477942646902, 4371.595622407663, 4480.987254945999, 4799.208130658402, 101257.49371253097, 124683.37658311651, 155187.22406387897, 160470.0, 168783.1560842188, 109943.0, 145208.205220506, 145297.0, 147741.0, 149119.0, 119850.20224696636, 124897.0, 126082.0, 128366.35816821043, 129670.0, 8891.199792018491, 8919.598618062073, 8928.0, 9020.413673111227, 9059.184673379428, 55522.16716749333, 67167.66416167888, 69217.0, 69546.30453695398, 70643.29356706367, 91288.0, 92641.0, 94087.5295623545, 104866.47566762117, 107409.38885916874, 10873.78252434931, 10887.618933337295, 10890.455477226265, 10978.176636752116, 11502.94248528752, 12004.519819207135, 12491.937540312603, 12997.220166790023, 13243.66890827737, 13934.442622294995, 11820.70448238801, 12381.938090309492, 13365.557946879027, 14093.718125637635, 14169.362378692776, 13792.172469651852, 13831.792523112363, 13923.386915552037, 13936.163830170222, 14536.200508972108, 12180.208286461706, 13527.86472135266, 13531.729365412833, 13879.0, 14455.060421072596, 11139.0, 11427.314361138358, 11505.482253298454, 11511.942440287745, 11787.941060294643, 8541.957290213757, 8968.955155224183, 10037.7954645443, 10668.679939601825, 11201.943990279997], "value": 7846.359219324174, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1623.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 104.0, 125.0, 117.0, 116.0, 114.0, 115.0, 117.0, 116.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 115.0, 170.0, 198.0, 92.0, 156.0, 157.0, 138.0, 179.0, 109.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 217.0, 205.0, 286.0, 253.0, 278.0, 215.0, 197.0, 196.0, 196.0], "value": 224.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 110.0, 105.0, 184.0, 53.0, 48.0, 52.0, 55.0, 135.0, 84.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 97.0, 146.0, 62.0, 101.0, 116.0, 145.0, 55.0, 91.0, 148.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 91.0, 88.0, 90.0, 87.0, 90.0, 87.0, 91.0, 87.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 97.0, 96.0, 96.0, 96.0, 108.0, 97.0, 96.0, 96.0, 96.0], "value": 98.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 151.0, 123.0, 147.0, 75.0, 105.0, 144.0, 133.0, 105.0, 98.0], "value": 117.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 59.0, 55.0, 58.0, 57.0, 57.0, 56.0, 56.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 101.0, 97.0, 69.0, 85.0, 80.0, 76.0, 109.0, 103.0, 60.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 86.0, 83.0, 85.0, 88.0, 106.0, 104.0, 110.0, 91.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 168.0, 142.0, 161.0, 130.0, 133.0, 150.0, 128.0, 162.0, 157.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 168.0, 167.0, 191.0, 161.0, 235.0, 159.0, 214.0, 228.0], "value": 186.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 68.0, 68.0, 90.0, 80.0, 83.0, 70.0, 59.0, 77.0], "value": 73.5, "unit": "score"}]}]} 05:29:40 INFO - Return code: 0 05:29:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:29:40 ERROR - # TBPL SUCCESS # 05:29:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:29:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:29:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:29:40 INFO - 2016-08-08 05:29:40.912 screenresolution[1668:10249] starting screenresolution argv=screenresolution get 05:29:40 INFO - 2016-08-08 05:29:40.915 screenresolution[1668:10249] Display 0: 1600x1200x32@60 05:29:40 INFO - 2016-08-08 05:29:40.922 screenresolution[1669:10252] starting screenresolution argv=screenresolution list 05:29:40 INFO - Available Modes on Display 0 05:29:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:29:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:29:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:29:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:29:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:29:41 INFO - Intel Iris: 05:29:41 INFO - Chipset Model: Intel Iris 05:29:41 INFO - Type: GPU 05:29:41 INFO - Bus: Built-In 05:29:41 INFO - VRAM (Dynamic, Max): 1536 MB 05:29:41 INFO - Vendor: Intel (0x8086) 05:29:41 INFO - Device ID: 0x0a2e 05:29:41 INFO - Revision ID: 0x0009 05:29:41 INFO - Displays: 05:29:41 INFO - Display: 05:29:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:29:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:29:41 INFO - Display Serial Number: 1600x1200 60 05:29:41 INFO - Main Display: Yes 05:29:41 INFO - Mirror: Off 05:29:41 INFO - Online: Yes 05:29:41 INFO - Rotation: Supported 05:29:41 INFO - Return code: 0 05:29:41 INFO - Running post-action listener: _resource_record_post_action 05:29:41 INFO - [mozharness: 2016-08-08 12:29:41.166797Z] Finished run-tests step (success) 05:29:41 INFO - Running post-run listener: _resource_record_post_run 05:29:41 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 38102016; Write bytes: 708088320; Read time: 388; Write time: 2023 05:29:41 INFO - TinderboxPrint: CPU usage
54.3% 05:29:41 INFO - TinderboxPrint: I/O read bytes / time
38,102,016 / 388 05:29:41 INFO - TinderboxPrint: I/O write bytes / time
708,088,320 / 2,023 05:29:41 INFO - TinderboxPrint: CPU idle
2,214.2 (45.7%) 05:29:41 INFO - TinderboxPrint: CPU system
976.6 (20.2%) 05:29:41 INFO - TinderboxPrint: CPU user
1,654.8 (34.1%) 05:29:41 INFO - TinderboxPrint: Swap in / out
444,821,504 / 0 05:29:41 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 5609472; Write bytes: 411418112; Read time: 74; Write time: 800 05:29:41 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29195264; Write bytes: 295101440; Read time: 289; Write time: 1219 05:29:41 INFO - Running post-run listener: _upload_blobber_files 05:29:41 INFO - Blob upload gear active. 05:29:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:29:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:29:42 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:42 INFO - (blobuploader) - INFO - Done attempting. 05:29:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:43 INFO - (blobuploader) - INFO - Done attempting. 05:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:29:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:48 INFO - (blobuploader) - INFO - Done attempting. 05:29:48 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:48 INFO - Return code: 0 05:29:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f21ec9e5a6f522ce4231a979ec6c757f1ac0b10fde6f60d74a8e103f0ded765d4383d734a2df2e96ece8e0671a0b82fabff894b73fa0a2513dc094549b2a0667", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4261075c95a9132b43bc2ed51fc545f9daa6463db5f45b66872e52962419828dcf42593caa2124211c0a29fb03b044df908a61fa244b04a8a3201006d429c56f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8cc81bc0518b281bdd8f4c30f2fe6aeceecdf0f89e974ce6f8d27e9f29001a7a4be2626563a3086c4f09b7bcd2d28d52978e55eee838440c118c09f61a865c6c"} 05:29:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:48 INFO - Contents: 05:29:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f21ec9e5a6f522ce4231a979ec6c757f1ac0b10fde6f60d74a8e103f0ded765d4383d734a2df2e96ece8e0671a0b82fabff894b73fa0a2513dc094549b2a0667", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4261075c95a9132b43bc2ed51fc545f9daa6463db5f45b66872e52962419828dcf42593caa2124211c0a29fb03b044df908a61fa244b04a8a3201006d429c56f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8cc81bc0518b281bdd8f4c30f2fe6aeceecdf0f89e974ce6f8d27e9f29001a7a4be2626563a3086c4f09b7bcd2d28d52978e55eee838440c118c09f61a865c6c"} 05:29:48 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:48 INFO - Copying logs to upload dir... 05:29:48 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.820796 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-08 05:29:48.700956) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:29:48.704092) ========= 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.BaPSY0iubj/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.cDr50gC1ko/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f21ec9e5a6f522ce4231a979ec6c757f1ac0b10fde6f60d74a8e103f0ded765d4383d734a2df2e96ece8e0671a0b82fabff894b73fa0a2513dc094549b2a0667", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4261075c95a9132b43bc2ed51fc545f9daa6463db5f45b66872e52962419828dcf42593caa2124211c0a29fb03b044df908a61fa244b04a8a3201006d429c56f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8cc81bc0518b281bdd8f4c30f2fe6aeceecdf0f89e974ce6f8d27e9f29001a7a4be2626563a3086c4f09b7bcd2d28d52978e55eee838440c118c09f61a865c6c"} build_url:https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f21ec9e5a6f522ce4231a979ec6c757f1ac0b10fde6f60d74a8e103f0ded765d4383d734a2df2e96ece8e0671a0b82fabff894b73fa0a2513dc094549b2a0667", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4261075c95a9132b43bc2ed51fc545f9daa6463db5f45b66872e52962419828dcf42593caa2124211c0a29fb03b044df908a61fa244b04a8a3201006d429c56f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8cc81bc0518b281bdd8f4c30f2fe6aeceecdf0f89e974ce6f8d27e9f29001a7a4be2626563a3086c4f09b7bcd2d28d52978e55eee838440c118c09f61a865c6c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:29:48.736606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:29:48.737014) ========= 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.BaPSY0iubj/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.cDr50gC1ko/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005287 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:29:48.786453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:29:48.786819) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:29:48.787225) ========= ========= Total master_lag: 0.17 =========