builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0165 starttime: 1470658109.54 results: success (0) buildid: 20160808012421 builduid: f64ec4b55952477e87b269089c3452c5 revision: f8fc21bb232095b7b4c995d259558212cb90a44b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:29.535496) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:29.535952) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:29.536238) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:29.559427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:29.560034) ========= 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.V9pahXUwXf/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.Sfo4u1gb33/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-08-08 05:08:29 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:29.667218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:29.667747) ========= 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.V9pahXUwXf/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.Sfo4u1gb33/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.020771 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:29.718533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:08:29.718860) ========= 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.V9pahXUwXf/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.Sfo4u1gb33/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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:29,796 truncating revision to first 12 chars 2016-08-08 05:08:29,796 Setting DEBUG logging. 2016-08-08 05:08:29,796 attempt 1/10 2016-08-08 05:08:29,796 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:30,916 unpacking tar archive at: fx-team-f8fc21bb2320/testing/mozharness/ program finished with exit code 0 elapsedTime=1.393859 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:08:31.137726) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:31.138317) ========= script_repo_revision: f8fc21bb232095b7b4c995d259558212cb90a44b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:31.138738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:31.139015) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:31.157211) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-08 05:08:31.157477) ========= /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.V9pahXUwXf/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.Sfo4u1gb33/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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:31 INFO - MultiFileLogger online at 20160808 05:08:31 in /builds/slave/test 05:08:31 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:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:31 INFO - {'append_to_log': False, 05:08:31 INFO - 'base_work_dir': '/builds/slave/test', 05:08:31 INFO - 'blob_upload_branch': 'Fx-Team', 05:08:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:31 INFO - 'branch': 'Fx-Team', 05:08:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:31 INFO - 'config_files': ('talos/mac_config.py',), 05:08:31 INFO - 'default_actions': ('clobber', 05:08:31 INFO - 'read-buildbot-config', 05:08:31 INFO - 'download-and-extract', 05:08:31 INFO - 'populate-webroot', 05:08:31 INFO - 'create-virtualenv', 05:08:31 INFO - 'install', 05:08:31 INFO - 'run-tests'), 05:08:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:31 INFO - 'download_minidump_stackwalk': True, 05:08:31 INFO - 'download_symbols': 'ondemand', 05:08:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:31 INFO - 'installer_path': 'installer.exe', 05:08:31 INFO - 'log_level': 'info', 05:08:31 INFO - 'log_name': 'talos', 05:08:31 INFO - 'log_to_console': True, 05:08:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:08:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:08:31 INFO - 'opt_config_files': (), 05:08:31 INFO - 'pip_index': False, 05:08:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:31 INFO - 'cmd': ('bash', 05:08:31 INFO - '-c', 05:08:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:31 INFO - 'enabled': True, 05:08:31 INFO - 'halt_on_failure': False, 05:08:31 INFO - 'name': 'check_screen_resolution'},), 05:08:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:31 INFO - 'cmd': ('bash', 05:08:31 INFO - '-c', 05:08:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:31 INFO - 'enabled': True, 05:08:31 INFO - 'halt_on_failure': False, 05:08:31 INFO - 'name': 'check_screen_resolution'},), 05:08:31 INFO - 'run_cmd_checks_enabled': True, 05:08:31 INFO - 'sps_profile': False, 05:08:31 INFO - 'sps_profile_interval': 0, 05:08:31 INFO - 'suite': 'dromaeojs-e10s', 05:08:31 INFO - 'system_bits': '32', 05:08:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:31 INFO - 'title': 't-yosemite-r7-0165', 05:08:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:31 INFO - 'use_talos_json': True, 05:08:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:31 INFO - 'work_dir': 'build'} 05:08:31 INFO - [mozharness: 2016-08-08 12:08:31.351413Z] Running clobber step. 05:08:31 INFO - Running pre-action listener: _resource_record_pre_action 05:08:31 INFO - Running main action method: clobber 05:08:31 INFO - rmtree: /builds/slave/test/build 05:08:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:32 INFO - Running post-action listener: _resource_record_post_action 05:08:32 INFO - [mozharness: 2016-08-08 12:08:32.739242Z] Finished clobber step (success) 05:08:32 INFO - [mozharness: 2016-08-08 12:08:32.739494Z] Running read-buildbot-config step. 05:08:32 INFO - Running pre-action listener: _resource_record_pre_action 05:08:32 INFO - Running main action method: read_buildbot_config 05:08:32 INFO - Using buildbot properties: 05:08:32 INFO - { 05:08:32 INFO - "project": "", 05:08:32 INFO - "product": "firefox", 05:08:32 INFO - "script_repo_revision": "production", 05:08:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:08:32 INFO - "repository": "", 05:08:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:08:32 INFO - "buildid": "20160808012421", 05:08:32 INFO - "pgo_build": "False", 05:08:32 INFO - "basedir": "/builds/slave/test", 05:08:32 INFO - "buildnumber": 25, 05:08:32 INFO - "slavename": "t-yosemite-r7-0165", 05:08:32 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:08:32 INFO - "platform": "yosemite_r7", 05:08:32 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:08:32 INFO - "branch": "fx-team", 05:08:32 INFO - "repo_path": "integration/fx-team", 05:08:32 INFO - "revision": "f8fc21bb232095b7b4c995d259558212cb90a44b", 05:08:32 INFO - "stage_platform": "macosx64", 05:08:32 INFO - "builduid": "f64ec4b55952477e87b269089c3452c5", 05:08:32 INFO - "slavebuilddir": "test" 05:08:32 INFO - } 05:08:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:08:32 INFO - Running post-action listener: _resource_record_post_action 05:08:32 INFO - [mozharness: 2016-08-08 12:08:32.745433Z] Finished read-buildbot-config step (success) 05:08:32 INFO - [mozharness: 2016-08-08 12:08:32.745639Z] Running download-and-extract step. 05:08:32 INFO - Running pre-action listener: _resource_record_pre_action 05:08:32 INFO - Running main action method: download_and_extract 05:08:32 INFO - mkdir: /builds/slave/test/build/tests 05:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:32 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:08:32 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:32 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:33 INFO - Downloaded 1199 bytes. 05:08:33 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:08:33 INFO - Using the following test package requirements: 05:08:33 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:08:33 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:33 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:08:33 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:33 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:08:33 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:33 INFO - u'jsshell-mac.zip'], 05:08:33 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:33 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:08:33 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:08:33 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:33 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:08:33 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:33 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:08:33 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:33 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:08:33 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:33 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:08:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:33 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:08:33 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:33 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:34 INFO - Downloaded 16320444 bytes. 05:08:34 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:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:41 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:08:41 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:41 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:42 INFO - Downloaded 16320444 bytes. 05:08:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:49 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:08:49 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:49 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:51 INFO - Downloaded 14413723 bytes. 05:08:51 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:51 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:51 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:08:51 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:51 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:54 INFO - Downloaded 111901101 bytes. 05:08:54 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:54 INFO - mkdir: /builds/slave/test/properties 05:08:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:54 INFO - Contents: 05:08:54 INFO - build_url:https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:08:55 INFO - Running post-action listener: _resource_record_post_action 05:08:55 INFO - Running post-action listener: set_extra_try_arguments 05:08:55 INFO - [mozharness: 2016-08-08 12:08:55.114834Z] Finished download-and-extract step (success) 05:08:55 INFO - [mozharness: 2016-08-08 12:08:55.114982Z] Running populate-webroot step. 05:08:55 INFO - Running pre-action listener: _resource_record_pre_action 05:08:55 INFO - Running main action method: populate_webroot 05:08:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:55 INFO - '--tppagecycles', 05:08:55 INFO - '7'], 05:08:55 INFO - 'tests': ['tsvgm']}}, 05:08:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:08:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:08:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:08:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:55 INFO - 'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:55 INFO - 'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['damp', 'tps']}, 05:08:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:55 INFO - 'tests': ['damp', 'tps']}, 05:08:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['dromaeo_dom']}, 05:08:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['basic_compositor_video']}, 05:08:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:08:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['a11yr', 05:08:55 INFO - 'ts_paint', 05:08:55 INFO - 'tpaint', 05:08:55 INFO - 'sessionrestore', 05:08:55 INFO - 'sessionrestore_no_auto_restore', 05:08:55 INFO - 'tabpaint']}, 05:08:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:08:55 INFO - 'ts_paint', 05:08:55 INFO - 'tpaint', 05:08:55 INFO - 'sessionrestore', 05:08:55 INFO - 'sessionrestore_no_auto_restore', 05:08:55 INFO - 'tabpaint']}, 05:08:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:08:55 INFO - 'ts_paint', 05:08:55 INFO - 'tpaint', 05:08:55 INFO - 'sessionrestore', 05:08:55 INFO - 'sessionrestore_no_auto_restore', 05:08:55 INFO - 'tabpaint']}, 05:08:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:08:55 INFO - 'ts_paint', 05:08:55 INFO - 'tpaint', 05:08:55 INFO - 'sessionrestore', 05:08:55 INFO - 'sessionrestore_no_auto_restore', 05:08:55 INFO - 'tabpaint']}, 05:08:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['a11yr', 05:08:55 INFO - 'ts_paint', 05:08:55 INFO - 'tpaint', 05:08:55 INFO - 'sessionrestore', 05:08:55 INFO - 'sessionrestore_no_auto_restore', 05:08:55 INFO - 'tabpaint']}, 05:08:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['a11yr', 05:08:55 INFO - 'ts_paint', 05:08:55 INFO - 'tpaint', 05:08:55 INFO - 'sessionrestore', 05:08:55 INFO - 'sessionrestore_no_auto_restore', 05:08:55 INFO - 'tabpaint']}, 05:08:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['tsvgx', 05:08:55 INFO - 'tsvgr_opacity', 05:08:55 INFO - 'tart', 05:08:55 INFO - 'tscrollx', 05:08:55 INFO - 'cart']}, 05:08:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:08:55 INFO - 'tsvgr_opacity', 05:08:55 INFO - 'tart', 05:08:55 INFO - 'tscrollx', 05:08:55 INFO - 'cart']}, 05:08:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:55 INFO - 'talos_options': ['--disable-e10s'], 05:08:55 INFO - 'tests': ['tp5o']}, 05:08:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:55 INFO - 'tests': ['tp5o']}, 05:08:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:55 INFO - 'talos_options': ['--disable-e10s', 05:08:55 INFO - '--xperf_path', 05:08:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:55 INFO - 'tests': ['tp5n']}, 05:08:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:55 INFO - 'talos_options': ['--xperf_path', 05:08:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:55 INFO - 'tests': ['tp5n']}}, 05:08:55 INFO - 'talos.zip': {'path': '', 05:08:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:55 INFO - Running post-action listener: _resource_record_post_action 05:08:55 INFO - [mozharness: 2016-08-08 12:08:55.133439Z] Finished populate-webroot step (success) 05:08:55 INFO - [mozharness: 2016-08-08 12:08:55.133527Z] Running create-virtualenv step. 05:08:55 INFO - Running pre-action listener: _resource_record_pre_action 05:08:55 INFO - Running main action method: create_virtualenv 05:08:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:55 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:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:55 INFO - Using real prefix '/tools/python27' 05:08:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:58 INFO - Installing pip.................done. 05:08:58 INFO - Return code: 0 05:08:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103311a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49bc8b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, '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.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/Render', 05:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:58 INFO - 'HOME': '/Users/cltbld', 05:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:58 INFO - 'LOGNAME': 'cltbld', 05:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:58 INFO - 'MOZ_NO_REMOTE': '1', 05:08:58 INFO - 'NO_EM_RESTART': '1', 05:08:58 INFO - 'PAGER': '/bin/cat', 05:08:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:58 INFO - 'PWD': '/builds/slave/test', 05:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:58 INFO - 'SHELL': '/bin/bash', 05:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfo4u1gb33/Listeners', 05:08:58 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:58 INFO - 'USER': 'cltbld', 05:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:58 INFO - 'XPC_FLAGS': '0x0', 05:08:58 INFO - 'XPC_SERVICE_NAME': '0', 05:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:59 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:08:59 INFO - Cleaning up... 05:08:59 INFO - Return code: 0 05:08:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:08:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:59 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 0x103311a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49bc8b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, '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.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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:08:59 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:08:59 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:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/Render', 05:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:59 INFO - 'HOME': '/Users/cltbld', 05:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:59 INFO - 'LOGNAME': 'cltbld', 05:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:59 INFO - 'MOZ_NO_REMOTE': '1', 05:08:59 INFO - 'NO_EM_RESTART': '1', 05:08:59 INFO - 'PAGER': '/bin/cat', 05:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:59 INFO - 'PWD': '/builds/slave/test', 05:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:59 INFO - 'SHELL': '/bin/bash', 05:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfo4u1gb33/Listeners', 05:08:59 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:59 INFO - 'USER': 'cltbld', 05:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:59 INFO - 'XPC_FLAGS': '0x0', 05:08:59 INFO - 'XPC_SERVICE_NAME': '0', 05:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:59 INFO - Downloading/unpacking psutil>=3.1.1 05:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:08:59 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:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:02 INFO - Installing collected packages: psutil 05:09:02 INFO - Running setup.py install for psutil 05:09:02 INFO - building 'psutil._psutil_osx' extension 05:09:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:09:03 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:03 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:03 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:03 INFO - building 'psutil._psutil_posix' extension 05:09:03 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:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:09:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:09:03 INFO - ^ 05:09:03 INFO - 1 warning generated. 05:09:03 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:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:03 INFO - Successfully installed psutil 05:09:03 INFO - Cleaning up... 05:09:03 INFO - Return code: 0 05:09:03 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103311a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49bc8b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, '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.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 05:09:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 05:09:03 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 mozsystemmonitor==0.3 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:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:06 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:06 INFO - Installing collected packages: mozsystemmonitor 05:09:06 INFO - Running setup.py install for mozsystemmonitor 05:09:06 INFO - Successfully installed mozsystemmonitor 05:09:06 INFO - Cleaning up... 05:09:06 INFO - Return code: 0 05:09:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:09:06 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:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:06 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:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:06 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 0x103311a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49bc8b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, '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.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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:06 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:06 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:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/Render', 05:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:06 INFO - 'HOME': '/Users/cltbld', 05:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:06 INFO - 'LOGNAME': 'cltbld', 05:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:06 INFO - 'MOZ_NO_REMOTE': '1', 05:09:06 INFO - 'NO_EM_RESTART': '1', 05:09:06 INFO - 'PAGER': '/bin/cat', 05:09:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:06 INFO - 'PWD': '/builds/slave/test', 05:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:06 INFO - 'SHELL': '/bin/bash', 05:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfo4u1gb33/Listeners', 05:09:06 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:06 INFO - 'USER': 'cltbld', 05:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:06 INFO - 'XPC_FLAGS': '0x0', 05:09:06 INFO - 'XPC_SERVICE_NAME': '0', 05:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:06 INFO - Downloading/unpacking jsonschema==2.5.1 05:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:09 INFO - warning: no files found matching '*.txt' 05:09:09 INFO - no previously-included directories found matching 'build' 05:09:09 INFO - no previously-included directories found matching 'dist' 05:09:09 INFO - no previously-included directories found matching '.git*' 05:09:09 INFO - Installing collected packages: jsonschema, functools32 05:09:09 INFO - Running setup.py install for functools32 05:09:09 INFO - warning: no files found matching '*.txt' 05:09:09 INFO - no previously-included directories found matching 'build' 05:09:09 INFO - no previously-included directories found matching 'dist' 05:09:09 INFO - no previously-included directories found matching '.git*' 05:09:09 INFO - Successfully installed jsonschema functools32 05:09:09 INFO - Cleaning up... 05:09:10 INFO - Return code: 0 05:09:10 INFO - Installing functools32==3.2.3-2 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', '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 0x103311a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49bc8b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, '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.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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', 'functools32==3.2.3-2'] 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 functools32==3.2.3-2 05:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 05:09:10 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:09:10 INFO - Cleaning up... 05:09:10 INFO - Return code: 0 05:09:10 INFO - Installing blobuploader==1.2.4 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', '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 0x103311a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49bc8b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, '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.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 05:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 05:09:10 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 blobuploader==1.2.4 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 blobuploader-1.2.4.tar.gz 05:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:14 INFO - Downloading docopt-0.6.1.tar.gz 05:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:14 INFO - Running setup.py install for blobuploader 05:09:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:14 INFO - Running setup.py install for requests 05:09:14 INFO - Running setup.py install for docopt 05:09:15 INFO - Successfully installed blobuploader requests docopt 05:09:15 INFO - Cleaning up... 05:09:15 INFO - Return code: 0 05:09:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:15 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 0x103311a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49bc8b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, '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.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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:15 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:15 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:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/Render', 05:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:15 INFO - 'HOME': '/Users/cltbld', 05:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:15 INFO - 'LOGNAME': 'cltbld', 05:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:15 INFO - 'MOZ_NO_REMOTE': '1', 05:09:15 INFO - 'NO_EM_RESTART': '1', 05:09:15 INFO - 'PAGER': '/bin/cat', 05:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:15 INFO - 'PWD': '/builds/slave/test', 05:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:15 INFO - 'SHELL': '/bin/bash', 05:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfo4u1gb33/Listeners', 05:09:15 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:15 INFO - 'USER': 'cltbld', 05:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:15 INFO - 'XPC_FLAGS': '0x0', 05:09:15 INFO - 'XPC_SERVICE_NAME': '0', 05:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:15 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-AHBJVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:15 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-SaDk11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:15 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-q7u5ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:15 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-WQZq8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:15 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-lOQj5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:15 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-kj7_lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:16 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-vJSWdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:16 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-hjVf0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:16 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-VyC09y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:16 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-GG3pY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:16 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-7X0ToJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:16 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-W4URQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:16 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Uunael-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:16 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-jtl5or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:16 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-lGov1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:17 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-CiiwyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:17 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-oJeqTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:17 INFO - Running setup.py install for manifestparser 05:09:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:17 INFO - Running setup.py install for mozcrash 05:09:17 INFO - Running setup.py install for mozdebug 05:09:17 INFO - Running setup.py install for mozdevice 05:09:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:17 INFO - Running setup.py install for mozfile 05:09:17 INFO - Running setup.py install for mozhttpd 05:09:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:18 INFO - Running setup.py install for mozinfo 05:09:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:18 INFO - Running setup.py install for mozInstall 05:09:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:18 INFO - Running setup.py install for mozleak 05:09:18 INFO - Running setup.py install for mozlog 05:09:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:18 INFO - Running setup.py install for moznetwork 05:09:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:18 INFO - Running setup.py install for mozprocess 05:09:19 INFO - Running setup.py install for mozprofile 05:09:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:19 INFO - Running setup.py install for mozrunner 05:09:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:19 INFO - Running setup.py install for mozscreenshot 05:09:19 INFO - Running setup.py install for moztest 05:09:19 INFO - Running setup.py install for mozversion 05:09:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:19 INFO - Cleaning up... 05:09:19 INFO - Return code: 0 05:09:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103311a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49bc8b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, '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.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:09:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/Render', 05:09:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:19 INFO - 'HOME': '/Users/cltbld', 05:09:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:19 INFO - 'LOGNAME': 'cltbld', 05:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:19 INFO - 'MOZ_NO_REMOTE': '1', 05:09:19 INFO - 'NO_EM_RESTART': '1', 05:09:19 INFO - 'PAGER': '/bin/cat', 05:09:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:19 INFO - 'PWD': '/builds/slave/test', 05:09:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:19 INFO - 'SHELL': '/bin/bash', 05:09:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfo4u1gb33/Listeners', 05:09:19 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:09:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:19 INFO - 'USER': 'cltbld', 05:09:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:19 INFO - 'XPC_FLAGS': '0x0', 05:09:19 INFO - 'XPC_SERVICE_NAME': '0', 05:09:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:20 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-jLWf4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:20 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-vqUMLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:20 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-1tElgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:20 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-7WEPQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:20 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-HomsAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:20 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-5orZ1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:20 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-iqxh1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:20 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-dG4Zw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:20 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-WQtEcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:21 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-adWtWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:21 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-d2AyOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:21 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Yq9bZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:21 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-jqcmmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:21 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-5DihLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:21 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-mNvCqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:21 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-yxKm91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:21 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-no2F1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:24 INFO - Downloading blessings-1.6.tar.gz 05:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:24 INFO - Installing collected packages: blessings 05:09:24 INFO - Running setup.py install for blessings 05:09:24 INFO - Successfully installed blessings 05:09:24 INFO - Cleaning up... 05:09:24 INFO - Return code: 0 05:09:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:24 INFO - Reading from file tmpfile_stdout 05:09:24 INFO - Current package versions: 05:09:24 INFO - blessings == 1.6 05:09:24 INFO - blobuploader == 1.2.4 05:09:24 INFO - docopt == 0.6.1 05:09:24 INFO - functools32 == 3.2.3-2 05:09:24 INFO - jsonschema == 2.5.1 05:09:24 INFO - manifestparser == 1.1 05:09:24 INFO - mozInstall == 1.12 05:09:24 INFO - mozcrash == 0.17 05:09:24 INFO - mozdebug == 0.1 05:09:24 INFO - mozdevice == 0.48 05:09:24 INFO - mozfile == 1.2 05:09:24 INFO - mozhttpd == 0.7 05:09:24 INFO - mozinfo == 0.9 05:09:24 INFO - mozleak == 0.1 05:09:24 INFO - mozlog == 3.3 05:09:24 INFO - moznetwork == 0.27 05:09:24 INFO - mozprocess == 0.23 05:09:24 INFO - mozprofile == 0.28 05:09:24 INFO - mozrunner == 6.12 05:09:24 INFO - mozscreenshot == 0.1 05:09:24 INFO - mozsystemmonitor == 0.3 05:09:24 INFO - moztest == 0.7 05:09:24 INFO - mozversion == 1.4 05:09:24 INFO - psutil == 3.1.1 05:09:24 INFO - requests == 1.2.3 05:09:24 INFO - wsgiref == 0.1.2 05:09:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103311a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49bc8b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, '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.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:09:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/Render', 05:09:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:24 INFO - 'HOME': '/Users/cltbld', 05:09:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:24 INFO - 'LOGNAME': 'cltbld', 05:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:24 INFO - 'MOZ_NO_REMOTE': '1', 05:09:24 INFO - 'NO_EM_RESTART': '1', 05:09:24 INFO - 'PAGER': '/bin/cat', 05:09:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:24 INFO - 'PWD': '/builds/slave/test', 05:09:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:24 INFO - 'SHELL': '/bin/bash', 05:09:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfo4u1gb33/Listeners', 05:09:24 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:09:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:24 INFO - 'USER': 'cltbld', 05:09:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:24 INFO - 'XPC_FLAGS': '0x0', 05:09:24 INFO - 'XPC_SERVICE_NAME': '0', 05:09:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:25 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:25 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:25 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:25 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:25 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:25 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:25 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:25 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:25 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:25 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:25 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:25 INFO - Cleaning up... 05:09:25 INFO - Return code: 0 05:09:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:25 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:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:25 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:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:25 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 0x103311a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49bc8b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, '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.V9pahXUwXf/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.Sfo4u1gb33/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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:25 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:25 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:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/Render', 05:09:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:25 INFO - 'HOME': '/Users/cltbld', 05:09:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:25 INFO - 'LOGNAME': 'cltbld', 05:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:25 INFO - 'MOZ_NO_REMOTE': '1', 05:09:25 INFO - 'NO_EM_RESTART': '1', 05:09:25 INFO - 'PAGER': '/bin/cat', 05:09:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:25 INFO - 'PWD': '/builds/slave/test', 05:09:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:25 INFO - 'SHELL': '/bin/bash', 05:09:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfo4u1gb33/Listeners', 05:09:25 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:09:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:25 INFO - 'USER': 'cltbld', 05:09:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:25 INFO - 'XPC_FLAGS': '0x0', 05:09:25 INFO - 'XPC_SERVICE_NAME': '0', 05:09:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:09:25 INFO - Cleaning up... 05:09:25 INFO - Return code: 0 05:09:25 INFO - Running post-action listener: _resource_record_post_action 05:09:25 INFO - Running post-action listener: _start_resource_monitoring 05:09:25 INFO - Starting resource monitoring. 05:09:25 INFO - [mozharness: 2016-08-08 12:09:25.512700Z] Finished create-virtualenv step (success) 05:09:25 INFO - [mozharness: 2016-08-08 12:09:25.513676Z] Running install step. 05:09:25 INFO - Running pre-action listener: _resource_record_pre_action 05:09:25 INFO - Running main action method: install 05:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:25 INFO - Reading from file tmpfile_stdout 05:09:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:25 INFO - Reading from file tmpfile_stdout 05:09:25 INFO - Output received: 05:09:25 INFO - Usage: mozinstall [options] installer 05:09:25 INFO - Options: 05:09:25 INFO - -h, --help show this help message and exit 05:09:25 INFO - -d DEST, --destination=DEST 05:09:25 INFO - Directory to install application into. [default: 05:09:25 INFO - "/builds/slave/test"] 05:09:25 INFO - --app=APP Application being installed. [default: firefox] 05:09:25 INFO - mkdir: /builds/slave/test/build/application 05:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:10:00 INFO - Reading from file tmpfile_stdout 05:10:00 INFO - Output received: 05:10:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:10:00 INFO - Running post-action listener: _resource_record_post_action 05:10:00 INFO - [mozharness: 2016-08-08 12:10:00.237448Z] Finished install step (success) 05:10:00 INFO - [mozharness: 2016-08-08 12:10:00.237627Z] Running run-tests step. 05:10:00 INFO - Running pre-action listener: _resource_record_pre_action 05:10:00 INFO - Running main action method: run_tests 05:10:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:00 INFO - 2016-08-08 05:10:00.252 screenresolution[1939:15962] starting screenresolution argv=screenresolution get 05:10:00 INFO - 2016-08-08 05:10:00.255 screenresolution[1939:15962] Display 0: 1600x1200x32@60 05:10:00 INFO - 2016-08-08 05:10:00.261 screenresolution[1940:15964] starting screenresolution argv=screenresolution list 05:10:00 INFO - Available Modes on Display 0 05:10:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:00 INFO - Intel Iris: 05:10:00 INFO - Chipset Model: Intel Iris 05:10:00 INFO - Type: GPU 05:10:00 INFO - Bus: Built-In 05:10:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:10:00 INFO - Vendor: Intel (0x8086) 05:10:00 INFO - Device ID: 0x0a2e 05:10:00 INFO - Revision ID: 0x0009 05:10:00 INFO - Displays: 05:10:00 INFO - Display: 05:10:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:00 INFO - Display Serial Number: 1600x1200 60 05:10:00 INFO - Main Display: Yes 05:10:00 INFO - Mirror: Off 05:10:00 INFO - Online: Yes 05:10:00 INFO - Rotation: Supported 05:10:00 INFO - Return code: 0 05:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:00 INFO - Python 2.7.3 05:10:00 INFO - Return code: 0 05:10:00 INFO - grabbing minidump binary from tooltool 05:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:00 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103275d30>, '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 0x102fdadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:10:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:10:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:10:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:00 INFO - Return code: 0 05:10:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:10:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:10:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:00 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-0165', '--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:00 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-0165 --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:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9pahXUwXf/Render', 05:10:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:00 INFO - 'HOME': '/Users/cltbld', 05:10:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:00 INFO - 'LOGNAME': 'cltbld', 05:10:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:00 INFO - 'MOZ_NO_REMOTE': '1', 05:10:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:00 INFO - 'NO_EM_RESTART': '1', 05:10:00 INFO - 'PAGER': '/bin/cat', 05:10:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:00 INFO - 'PWD': '/builds/slave/test', 05:10:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:00 INFO - 'SHELL': '/bin/bash', 05:10:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfo4u1gb33/Listeners', 05:10:00 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:10:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:00 INFO - 'USER': 'cltbld', 05:10:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:00 INFO - 'XPC_FLAGS': '0x0', 05:10:00 INFO - 'XPC_SERVICE_NAME': '0', 05:10:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:00 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-0165', '--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:00 INFO - mozversion application_buildid: 20160808012421 05:10:00 INFO - mozversion application_changeset: f8fc21bb232095b7b4c995d259558212cb90a44b 05:10:00 INFO - mozversion application_display_name: Nightly 05:10:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:00 INFO - mozversion application_name: Firefox 05:10:00 INFO - mozversion application_remotingname: firefox 05:10:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:10:00 INFO - mozversion application_vendor: Mozilla 05:10:00 INFO - mozversion application_version: 51.0a1 05:10:00 INFO - mozversion platform_buildid: 20160808012421 05:10:00 INFO - mozversion platform_changeset: f8fc21bb232095b7b4c995d259558212cb90a44b 05:10:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:00 INFO - mozversion platform_version: 51.0a1 05:10:00 INFO - using testdate: 1470658200 05:10:00 INFO - actual date: 1470658200 05:10:00 INFO - starting webserver on 'localhost:51166' 05:10:00 INFO - SUITE-START | Running 2 tests 05:10:00 INFO - TEST-START | dromaeo_css 05:10:00 INFO - operating with platform_type : mac_ 05:10:00 INFO - Initialising browser for dromaeo_css test... 05:10:00 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmp1QzQ8Z/profile http://localhost:51166/getInfo.html) 05:10:03 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 05:10:03 INFO - PROCESS | 1950 | colorDepth:24 05:10:03 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 05:10:03 INFO - PROCESS | 1950 | __metrics 05:10:03 ERROR - PROCESS | 1950 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:10:04 INFO - TEST-INFO | 1950: exit 0 05:10:04 INFO - Browser initialized. 05:10:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:04 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmp1QzQ8Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:16 INFO - PROCESS | 1952 | RSS: Main: 254742528 05:10:16 INFO - PROCESS | 1952 | 05:11:05 INFO - PROCESS | 1952 | 1470658265963 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:18 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51166/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51166/tests/dromaeo/cssquery-ext.html) 05:13:20 INFO - PROCESS | 1952 | RSS: Main: 270114816 05:13:20 INFO - PROCESS | 1952 | 05:16:22 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51166/tests/dromaeo/cssquery-ext.html (next: http://localhost:51166/tests/dromaeo/cssquery-jquery.html) 05:16:23 INFO - PROCESS | 1952 | RSS: Main: 282271744 05:16:23 INFO - PROCESS | 1952 | 05:19:25 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51166/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51166/tests/dromaeo/cssquery-mootools.html) 05:19:25 INFO - PROCESS | 1952 | RSS: Main: 288464896 05:19:25 INFO - PROCESS | 1952 | 05:22:27 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51166/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51166/tests/dromaeo/cssquery-prototype.html) 05:22:28 INFO - PROCESS | 1952 | RSS: Main: 289779712 05:22:28 INFO - PROCESS | 1952 | 05:25:30 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51166/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51166/tests/dromaeo/cssquery-yui.html) 05:25:31 INFO - PROCESS | 1952 | RSS: Main: 293175296 05:25:31 INFO - PROCESS | 1952 | 05:28:34 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51166/tests/dromaeo/cssquery-yui.html (next: http://localhost:51166/tests/dromaeo/cssquery-dojo.html) 05:28:34 INFO - PROCESS | 1952 | RSS: Main: 292974592 05:28:34 INFO - PROCESS | 1952 | 05:28:34 INFO - PROCESS | 1952 | __start_tp_report 05:28:34 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 05:28:34 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 05:28:34 INFO - PROCESS | 1952 | |i|pagename|runs| 05:28:34 INFO - PROCESS | 1952 | |0;dojo.html;2702.9324266893327;3376.898693039208;3404.8638054477824;3413.2832105257894;3420.2646431017333;4976.676516026456;5305.018571564258;5716.8856622867515;5773.220615216945;5820.941790582098;5791.507721843638;5798.797042103527;5850.795222167225;5853.765849366031;5861.76552937883;5289.867753306169;5350.866228344284;5367.329083864517;5405.567554595643;5423.566114710814;5221.686698798066;5234.293370394986;5293.920591191135;5345.65253258537;5404.83785486436;5281.260623512711;5299.973500132474;5302.310699609065;5344.7862085516535;5351.411344752094;5283.86790330241;5293.523582877521;5298.708571028592;5330.333708286465;5353.384360798519;4242.7242229255;5155.097857874857;5187.896242075138;5221.71280579568;5268.157094864841;4269.359596060584;5825.038868586678;5829.47534721877;5852.912206316866;5888.116782482619;6142.416470435302;6230.937690623081;6235.127082208494;6242.656653884034;6255.249370075575;5728;6117.248930028882;6159.38406159385;6166.475849552793;6224.688765561704;4906.435759887623;5934.05055191176;5984.251968503937;5990.670513121733;6050.2437195350585;6302.845498074273;6303.936960630427;6360.6501642409185;6360.650164241011;6467.4179323860135;4872.975635121873;6123.557162997564;6149.96925015372;6238.469730072904;6268.247810262797;5518.841043380935;6160.168377269101;6215.316315205324;6217.626942383471;6217.875642487215;6150.0848218741185;6212.4408803207925;6263.279722831841;6271.278802937721;6272.8118156455375;5280.683159010395;6102.398363691488;6118.235220597426;6133.457080270857;6188.319284878659;5036.093503169464;5058.367704036996;5061.898762024813;5085.110105731482;5092.694438333712;4505;4515.841945531891;4543.909121817611;4552.521985191574;4588.449386073693;5679.204911312419;5774.364819869811;5870.295564532284;5978.880422391528;5980.192673988956;6131.101423540838;6186.4741496972365;6215.192025036717;6225.470834979077;6263.3736626337;5868.618539794899;5914.497267732205;5920.111983202554;5920.911186332209;5948.940510594839;5491.505764481216;5501.119820828728;5528.253685752372;5537.36320323168;5545.223668686387;6156.199694039746;6303.212098487689;6331.050342448485;6342.365763423621;6409.070684750685;6229.065640154013;6252.280987686474;6252.374762523711;6267.529935254783;6268.561200715906;6398.648074355769;6420.454261387835;6448.193975753031;6451.3226111257645;6454;6113.172264937315;6164.568480206342;6173.135760993554;6214.627122372672;6214.627122372672;6165.84585385369;6206.193194884636;6207.348228435949;6214.316425193316;6241.126242325987;6044.032954727222;6203.2245969253845;6221.129041934223;6223.564350495421;6241.968790156202;5026.572741317029;6055.666938318434;6122.459144589048;6136.32500424944;6139.171211886338;5901.704914754331;6053.910296146736;6097.207363042776;6104.572679912363;6133.8466538335115;6141.385861413823;6191.25704915413;6204.534659900435;6218.284897236876;6249.906251406142;6001.189839371804;6056.485198757979;6094.786682466092;6125.8468538285115;6140.662263575547 05:28:34 INFO - PROCESS | 1952 | |1;ext.html;471.4978547846544;513.8895137545428;527.1697077103561;531.949399935128;566.4081035318097;29853.999999999975;40875.773726788204;40892.59107408925;40927.59072409275;40959;41703.582964170346;42044;42228.94427639303;42318.36522452166;42340.153196936044;8555.828883422328;9606.471644059575;9786;9814;9845.064718851698;9351.25189984803;9708.805823883518;9727.416355018722;9751.561179746894;9754.756131096708;9681.854772178423;9719.076687714656;9797.755056123582;9800.754981125494;9819.165370943478;9726.90273097267;9740.269479788973;9741.025897410273;9748.658796942109;9756;8109.635066422025;9655.565499552467;9674.08096230857;9699.951500242525;9730.805383892353;39248.41127383091;39264.01839953996;39460.802695986335;39578.010549736486;39605;3046.8933587324336;3287.556179915705;3457.0665920201654;3476.549032931777;3521.7182625390165;29641.851790740908;30179;30646.69353306461;30762.077137685905;30765;3100.286934005169;3135.717785399302;3190.5533225348468;3272.8199949002797;3276.262840860787;452690;453697;454706;455685;460544;33108.66891331104;33834.66165338364;34127.82936085304;34157.48763768545;34241.65758342385;29333.26666833346;30926.381472370427;31130.844345778125;34949.30101397958;35588;16584.419545315857;16618.83381166197;16746;16788.832111678727;16826.41107561254;12783.360831958365;12825.166364186298;12903.548375806802;12908.35458227085;12910.870891291155;19076.80923190778;19112.713309300372;19232;19286.80713192878;19322.227110915406;7889.842203155905;7988.480748751313;8008.319292860172;8026.879596806052;8030.196980301923;867.6746220167437;872.9912700873037;946.8201041802035;955.8327292723745;1042.5517027678172;26978.460430791274;30607.69392306093;30614.081577552708;30710.846445768075;30829.845850770602;1038.2298181600354;1040.6929955663097;1076.3326737422692;1086.0822604898847;1102.9889701103048;15300;15965.680686386208;15967.920160399124;15992.440264590916;16118.435854745263;367793;370505;370758;371202;371325;57713.711431443415;57802.843943120904;57923;58135.54661133421;58164.54588635318;1323.0672375975107;1352.4319785690034;1367.1591970937802;1369.137443410645;1377.0360747476807;29039;30119.54820677648;30143.698563014965;30570.930017449282;30813.22966925845;50947;51135.48864511307;51330.23004655008;51365;51418.48581514137;550860;555370;557165;558143;561505;26807.731922681305;26968;27046.72953270442;27084;27790;47787;48140.27789583089;48712.75643621759;49105.263421047996;49199.17618124007;39726.60273397229;40190.39714404345;40211.59788402078;40332;40935.59064409318;39622;40077.79961100293;40820.38769418521;40859.79570102131;41279.58720412877;37620.81189594144;38329.23341533098;38704.6129538701;38895.8331250063;39024.21951561009;32926.83536582302;34231.31537369189;34947.825260873535;35352.11619709425;35363.823180883934;21611.00586199025;25235.48587084781;25829.3542661435;26010.95956161808;26148.477030459664 05:28:34 INFO - PROCESS | 1952 | |2;jquery.html;316.25364140628113;362.7388280438084;371.53001453161744;382.8009435093753;395.1504265828468;20046;21012.68480972785;21270.787292127075;22012.119515219372;22144.557108857814;20840.957952102373;21125.57748845022;21313.57372852542;21489.892550537224;21633.891830540866;5717.342505611846;5821.126830975367;6025.066114752199;6094.908576371358;6107.877842443148;3923.274194274054;5795.71021448928;6070.392960703938;6093.664848433335;6106.206193194901;5184.948150518503;6025.276966763994;6120.26556813183;6122.63264204147;6123.081537769348;5722.656640601577;5981.551383646222;6097.054956481752;6608.867822643544;6697.966510167418;5861.3552509223955;5911.970440147815;5918.467337939606;5935.970320148414;5939.46544810969;13337.266450345227;13410.597682069554;13569.45722171112;13750.724985500234;13865.722685546334;2297.8391512594126;2629.000979627748;2693.138195777352;2803.523401021831;2947.3073827650487;7871.567063811488;9990.750231244205;10171.288009839314;10519.63181288659;10558.841617375669;1675.656490419461;1844.4005698148155;1854.8701590888643;1920.5582715975265;1939.660559402113;112440;116138.41930790377;117926.41036794847;119118;125945;11373.488193031333;11504.482298296596;11549.422528873523;11708.824367634492;11828.88171118295;14473.348699308557;14515.92742036283;14677.706445871023;14704;14713.411463541339;7308.853822923512;8256;8638.17937295956;8710.390272680852;8797.38418310725;8518.275946544489;8636.195456451544;8646.740597782076;8811.118888111137;8827.779305517284;3718.925621487555;4562.087582483517;4573.908521829545;4576.816927322936;4675.509071547506;1641.7455294429144;1804.530821986293;1911.5794525204433;1962.077823422989;3686.8525258989876;838.6729175621513;881.5415983688574;931.8928323242778;937.3625934364698;946.5598496699068;17558.736618950727;20599.279025234344;21740.673889891663;22515.986780594914;22685.638861668354;952.0907533305676;964.2671569607149;985.2315194148575;985.9161971232382;1048.9213309001855;8064.717734879368;11545.480453379618;11675.88324116765;11808.704782380337;11830.940845295718;441950;520914;540556;554672;562702;99079;129484;130450;133422.33288833493;138848;983.2625530851861;985.4629227071264;987.2052997337069;1001.8296889528798;1005.4570531912832;18862.622747544698;19522.414327570197;19548.60902781965;19604.803951960297;19607.70588441203;31007.84496077505;36345.81827090848;40335;45575.544244558456;54750.72624636851;76095;77543.2245677536;77560.61219693866;78628;78868.60565697135;5731.656100633975;8218.424710270223;8256.050554186346;8531.616077276414;8673.653053877773;9353.672621458216;12156.088293377856;13020.28388438645;13167.60497185086;13360.198388096745;5401.945980540144;9028.55543113125;11203.551857925917;11676.299422034705;11769.293842369485;10635.415052172204;11071.335719856834;11350.205485615928;11520.596779112691;11551.826722599335;6455.644939528371;10091.091801737584;11581.015613672933;11891.405429728306;12018.879811201776;8363.62363693623;8398.41211115216;8453.196946290092;8546.188112129337;8633.56832158377;9805.362651427635;11884;11896.881031189578;11937.343446110548;11945.82081268799 05:28:34 INFO - PROCESS | 1952 | |3;mootools.html;1540.4916377595391;1551.8137823461184;1745.3193254630696;1822;1868.2900497810829;7901.565413902247;8393.11872253413;8427.662893484268;8936.463812171258;8956.955215223923;8560;8763.605637746301;8780.253678437324;8792.69225577105;8815.382923195379;2375.228050883461;2414.2033129067368;2417.1660777031984;2417.5527527407485;2441.523902838947;1866.7106598477258;2382.821288403368;2387.594109001474;2421.624648179535;2425.624028275611;1942.922283108674;2028.6348457277684;2283.178055899875;2307.8038366738847;2308.56137333906;2248.8875556222206;2255.6842042114117;2283.5318759654233;2294.8967296471615;2297.4715815362392;2326.953460930772;2345.82406319525;2346.741858395575;2349.8825058747166;2355.3169580821714;8818.514981676006;8874.733757987271;8882.644694212224;8895.911040889572;8908.955455222747;5251.159814429673;5306.071437498423;5315.946840531584;5376.193570964387;5417.6478528895495;3462;3547.396942519778;3637.108908317453;3638.126849556114;3664;975.7267964969819;1052.0268751404997;1053.3258714422775;1089.9237053406264;1096.1723898456694;11509.366984815832;11541.30752154865;11638.534458621645;11661.533538658528;11677.416129193507;3688.7417880748626;3952.9011774705286;4621.2837010263465;4795.280707893774;4800.855974320776;9777;9895.703128906145;9902.356346837432;9919.305648604673;9936.900630993598;5296.735163241822;5343.011542864582;5375.5162035417;5407.756650950717;5470.234167216593;3579.6778289954027;4457.687961842705;4837.612990960785;4887.511248875084;4925.13810083234;3967.8691572901585;4008.7995600219874;4111.218868414991;4133.2973394522405;4153.127843152912;1187.3113594115393;1235.6354875311804;1300.0964329790893;1314.0604467805374;1322.6428864206803;920.282179899666;926.972190834276;927.5547737086237;959.842119427091;982.1946004276567;5844.444777746107;5938.257717785277;6038.00372938469;6123.877522449526;6140.723667434976;438.1674817846054;440.5462373755037;448.1239177408159;455.5694868349378;456.5480174627162;3702.5556933167654;3792.60177681345;4015.9397609035886;4140.15126898991;4172.4993000840095;10336.431496267778;10527.368357898551;10540.683779486628;10574.471276436301;10650.786984260272;10478.63324783629;10569.841452378221;10585.735356616146;10606.734831629272;10610;7412.518186317872;7708.344790692742;7956.124826269222;7995.800104997305;8239.764035394619;5824.679642619527;5877;5897.115432685132;6066.3023752269055;6092.45167934888;8039.718609848627;9860.112589866947;9912.801743965225;9925.503724813587;10002;9738.902610973799;9979.800403991734;10010.399376037461;10101.747456313651;10214.08073273409;6916.100906882073;7277.854442911218;7384.704611815682;7496.0255166827965;7563.810904727426;8349.33205343559;8435.789105272417;8450.577471126297;8459.492430454193;8466.872996905175;6672.899906501503;7341.33927946466;7389;7521.962390188014;7634.312911837961;7369.852602948018;7385.224551422023;7387.741429049957;7399.741009064657;7493.138289096605;6911.516193866582;6922.10012698346;6979.40675042627;6995.300469952964;7007.334303241184;4823.1800593898415;4960.801567937387;5047.49525047507;5049.394072711299;5178.870528236825;5109.718965456936;5114;5209;5235.8481134150425;5285.048691235615 05:28:34 INFO - PROCESS | 1952 | |4;prototype.html;274.332001576162;298.4106389879989;310.95180247061705;315.0140061607169;315.94786860168074;4690.530946905308;4919.434265059519;5477.5070243678065;5711.3717491076;5724.570657200717;5497.422770609089;5597.496225339719;5619.297587801525;5654.151877218419;5683.687397193163;4246.3205887058075;4260.89347766306;4274.273373526493;4300.397944287803;4314.654827613784;4068.0643452006057;4235.216484950279;4256.7435911527555;4296.613304802567;4307.483102027761;3326.600807903055;4195.55946625603;4230.851920182794;4237.745735255895;4251.829926802924;4089.141280331134;4217.514985776629;4242.2788126018495;4270.103278311558;4292.699511034229;3235.773495855291;3697.9445308320396;3708.6662200402093;3721.441783732435;3739.8317075731657;5012.624053195988;5373.113436283009;5465.644733092376;5466.125419932791;5489;4777.163996300634;4792.616590672737;4796.304535842318;4798.536446383851;4825.589824864891;4934.703917764946;5463.535599474049;5594.944050559483;5857.970710146422;5893.705314734246;3290.6380298167182;3922.3332033554366;3925.7448265862627;3929.7445666031617;3975.2248311579256;5081.79672813087;5612.859678508029;6014.406182361634;6139.140520327158;6202.565820392574;3797.867074652374;3832.8118283332255;3997.200559888034;4014.638682518529;4061.5126184858004;3441.7074548663145;3738.887833365003;3977.6817854571564;4056.1887622475624;4119.258533463945;3988.3020471417385;4800.855974320776;4809.350737650442;4820;4840.975795121002;5226.372835259793;5668.829935101953;5977.820665380045;5988.191594134823;6004.969975150097;1332.8533861275253;1352.8511863694985;1369.2948131712176;1373.3270697358223;1384.3631929312628;704.63359053292;773.9690412383442;775.3719487215374;795.6340083561627;852.5140669818268;4176.310908700091;4236.915261694749;4328.588784065509;4536.092781443725;4721.952780472151;4438.933415998763;4745.003549254695;5099.991005306887;5110.770015349244;5174.30935913323;4005.819738111792;4169.958300416957;4582.793774280165;4627.699199552018;4661.230896902041;2267.4331417145713;2529.4941011797714;2642.484715480463;2665.640138581267;2677.906273280426;4782.95217047832;4831.710097394168;4890.435060780516;4922.926156107661;4932.950670493321;4850.781714822841;5191.480851914854;5232.764525596357;5282.947170528246;5316.362036555638;4571.977140114278;5204.375474942955;5248.923970586021;5277.313949186581;5296.629235953524;4228.89427764296;4286.914261714811;5098.768022541208;5119.897602048012;5132.3327967364;5048.873778155576;5073.046876952326;5090.796368145381;5125.384953805567;5157.716325602128;5194.013137503862;5713.657180569179;5735.881503106854;6005.699715014144;6382.138411314413;3584.0466945515277;3820.522434695663;4038.636522712852;4040.3131467649982;4058.3912413138264;5012;5692.7798158717305;5977.282726072899;6107.297660769068;6190.319064902767;5946.821595352147;5963.552733545088;5970.611910225822;6008.5493587981955;6021.518278537619;5173.7671804769625;5807.564432667482;5956.731947062306;6011.909821352596;6063.787767428119;5000.199968005102;5078.695278283167;5507.421720719267;5531.917021244765;5573.5819813513335;5579.051561234519;5630.408807075198;5963.403659634176;5983.910241346296;6021.969890150521;4724.574788269072;5644.0687286598895;5815.04051831443;5836.503897168618;5885.849287494664 05:28:34 INFO - PROCESS | 1952 | |5;yui.html;687.9587224766515;721.7077083781071;783.7452827830955;802.6227672993691;850.9064002959674;14873.256337183151;15012.699746005073;15632.140232287205;15637.765433518507;15975.440859569917;12496.375181240925;12655;12679.873201267985;12681.112322137455;12715.109942304043;678.8235058884676;709.4359983812881;830.393812516863;839.7312859884839;851.7189327521903;729.5185177782664;824.6454024769347;841.0496139362511;844.8732690096504;858.6136238692582;916.3402350307767;917.0554329041065;917.3761841947473;918.1415376622846;918.6600957645647;877.0965905117707;891.033228946597;903.5482258870564;913.4108500017452;915.8031023330016;653.0726368556661;662.592505609047;678.8133263352568;680.9897851532231;684.5618803965466;15145.394184232617;15276.236188190656;15347.61630959235;15376.077435353804;15397.923010384988;14712.558623241213;14794.40822367104;14807.185604791732;15042.548723538312;15061.397544098223;11890.524379024915;12129.757404851942;12395;12506.437210325557;12573.245605263714;3833.769973801581;3853.7880416577077;4072.694547908889;4079.8980025499304;4086.1214838809797;119994;120510;121417;121696.56606867902;125337;10442.947785261025;10766.78466430667;11389.145814063979;11423.942880285545;11484.081273498101;23462.64806027911;23700.762992369855;23851.284461466184;23931.042758289474;24070.7592924072;8154;8194.139615340422;8201.671933122727;8216.137305582948;8332.375071869634;4527.886802829889;4577.633789296849;4580.862574122782;4603.792829322689;4621.376114224604;2960.955585666217;3530.523379343807;3667.7615954963376;3676;3685.3734865073;637.8501052252717;638.5849198021323;648.8313038609901;664.1896885799317;666.5800545656302;565.8924804287172;644.3331152257391;661.1306132435832;666.9195902637758;676.5500941873697;8830.779230519289;9044.41211321262;9065.81868362629;9426.293028022927;9823.557939892722;491.25329499161074;531.4393315052579;655.5050936542975;677.7831094049857;692.5602242576;4119.299719047769;4298.634616057608;4562.877709301963;4895.443188222199;5021.648484606116;132363.21478364692;144172.837407439;165299;165350.173249133;168574;127370.72629273775;135226.323868382;137106;138527;148534;111664;122772;122996;123793.76206237823;124524.37737811434;7884.605769711607;8441.15588441151;9175.944766351955;9199.54002299869;9336.579853906725;62595.374046260775;63017.73964520776;65562.67218663877;67922.66038669775;68313;101195;104117.47941260245;106665;107008.3948740754;107788;11536.192466527262;11594.884051159717;11601.535938562363;11931.403429828648;12510;11498.252643405114;12904.09671323036;13036.413361398949;15395.461158859385;16085.517434476984;13583.660408489472;14222.431102755774;14417.63955901069;14786.178788696421;14893.627659308604;14018.78971815444;14215;14249.50126745559;14358.099733264717;14399.496017639332;13626.454941802216;13756.587302380945;14155.575332740034;14560.331671331176;14660.193689347188;11262.211645185087;11419.31484110956;11599.536018559163;11645.205309514948;11872.584459543874;9836.852447213441;10035.899641003789;10861.294015888941;11570.94214528922;11698.181127321006 05:28:34 INFO - PROCESS | 1952 | __end_tp_report 05:28:34 INFO - PROCESS | 1952 | __start_cc_report 05:28:34 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,419 05:28:34 INFO - PROCESS | 1952 | __end_cc_report 05:28:34 INFO - PROCESS | 1952 | __startTimestamp1470659314492__endTimestamp 05:28:34 INFO - PROCESS | 1952 | 05:28:34 INFO - PROCESS | 1952 | ------- Summary: start ------- 05:28:34 INFO - PROCESS | 1952 | Number of tests: 6 05:28:34 INFO - PROCESS | 1952 | 05:28:34 INFO - PROCESS | 1952 | [#0] dojo.html Cycles:165 Average:5757.42 Median:6050.24 stddev:667.78 (11.0%) stddev-sans-first:625.36 05:28:34 INFO - PROCESS | 1952 | Values: 2702.9 3376.9 3404.9 3413.3 3420.3 4976.7 5305.0 5716.9 5773.2 5820.9 5791.5 5798.8 5850.8 5853.8 5861.8 5289.9 5350.9 5367.3 5405.6 5423.6 5221.7 5234.3 5293.9 5345.7 5404.8 5281.3 5300.0 5302.3 5344.8 5351.4 5283.9 5293.5 5298.7 5330.3 5353.4 4242.7 5155.1 5187.9 5221.7 5268.2 4269.4 5825.0 5829.5 5852.9 5888.1 6142.4 6230.9 6235.1 6242.7 6255.2 5728.0 6117.2 6159.4 6166.5 6224.7 4906.4 5934.1 5984.3 5990.7 6050.2 6302.8 6303.9 6360.7 6360.7 6467.4 4873.0 6123.6 6150.0 6238.5 6268.2 5518.8 6160.2 6215.3 6217.6 6217.9 6150.1 6212.4 6263.3 6271.3 6272.8 5280.7 6102.4 6118.2 6133.5 6188.3 5036.1 5058.4 5061.9 5085.1 5092.7 4505.0 4515.8 4543.9 4552.5 4588.4 5679.2 5774.4 5870.3 5978.9 5980.2 6131.1 6186.5 6215.2 6225.5 6263.4 5868.6 5914.5 5920.1 5920.9 5948.9 5491.5 5501.1 5528.3 5537.4 5545.2 6156.2 6303.2 6331.1 6342.4 6409.1 6229.1 6252.3 6252.4 6267.5 6268.6 6398.6 6420.5 6448.2 6451.3 6454.0 6113.2 6164.6 6173.1 6214.6 6214.6 6165.8 6206.2 6207.3 6214.3 6241.1 6044.0 6203.2 6221.1 6223.6 6242.0 5026.6 6055.7 6122.5 6136.3 6139.2 5901.7 6053.9 6097.2 6104.6 6133.8 6141.4 6191.3 6204.5 6218.3 6249.9 6001.2 6056.5 6094.8 6125.8 6140.7 05:28:34 INFO - PROCESS | 1952 | 05:28:34 INFO - PROCESS | 1952 | [#1] ext.html Cycles:180 Average:59842.47 Median:38960.03 stddev:124235.04 (318.9%) stddev-sans-first:124503.58 05:28:34 INFO - PROCESS | 1952 | Values: 471.5 513.9 527.2 531.9 566.4 29854.0 40875.8 40892.6 40927.6 40959.0 41703.6 42044.0 42228.9 42318.4 42340.2 8555.8 9606.5 9786.0 9814.0 9845.1 9351.3 9708.8 9727.4 9751.6 9754.8 9681.9 9719.1 9797.8 9800.8 9819.2 9726.9 9740.3 9741.0 9748.7 9756.0 8109.6 9655.6 9674.1 9700.0 9730.8 39248.4 39264.0 39460.8 39578.0 39605.0 3046.9 3287.6 3457.1 3476.5 3521.7 29641.9 30179.0 30646.7 30762.1 30765.0 3100.3 3135.7 3190.6 3272.8 3276.3 452690.0 453697.0 454706.0 455685.0 460544.0 33108.7 33834.7 34127.8 34157.5 34241.7 29333.3 30926.4 31130.8 34949.3 35588.0 16584.4 16618.8 16746.0 16788.8 16826.4 12783.4 12825.2 12903.5 12908.4 12910.9 19076.8 19112.7 19232.0 19286.8 19322.2 7889.8 7988.5 8008.3 8026.9 8030.2 867.7 873.0 946.8 955.8 1042.6 26978.5 30607.7 30614.1 30710.8 30829.8 1038.2 1040.7 1076.3 1086.1 1103.0 15300.0 15965.7 15967.9 15992.4 16118.4 367793.0 370505.0 370758.0 371202.0 371325.0 57713.7 57802.8 57923.0 58135.5 58164.5 1323.1 1352.4 1367.2 1369.1 1377.0 29039.0 30119.5 30143.7 30570.9 30813.2 50947.0 51135.5 51330.2 51365.0 51418.5 550860.0 555370.0 557165.0 558143.0 561505.0 26807.7 26968.0 27046.7 27084.0 27790.0 47787.0 48140.3 48712.8 49105.3 49199.2 39726.6 40190.4 40211.6 40332.0 40935.6 39622.0 40077.8 40820.4 40859.8 41279.6 37620.8 38329.2 38704.6 38895.8 39024.2 32926.8 34231.3 34947.8 35352.1 35363.8 21611.0 25235.5 25829.4 26011.0 26148.5 05:28:34 INFO - PROCESS | 1952 | 05:28:34 INFO - PROCESS | 1952 | [#2] jquery.html Cycles:180 Average:32340.20 Median:18354.28 stddev:88529.30 (482.3%) stddev-sans-first:88745.00 05:28:34 INFO - PROCESS | 1952 | Values: 316.3 362.7 371.5 382.8 395.2 20046.0 21012.7 21270.8 22012.1 22144.6 20841.0 21125.6 21313.6 21489.9 21633.9 5717.3 5821.1 6025.1 6094.9 6107.9 3923.3 5795.7 6070.4 6093.7 6106.2 5184.9 6025.3 6120.3 6122.6 6123.1 5722.7 5981.6 6097.1 6608.9 6698.0 5861.4 5912.0 5918.5 5936.0 5939.5 13337.3 13410.6 13569.5 13750.7 13865.7 2297.8 2629.0 2693.1 2803.5 2947.3 7871.6 9990.8 10171.3 10519.6 10558.8 1675.7 1844.4 1854.9 1920.6 1939.7 112440.0 116138.4 117926.4 119118.0 125945.0 11373.5 11504.5 11549.4 11708.8 11828.9 14473.3 14515.9 14677.7 14704.0 14713.4 7308.9 8256.0 8638.2 8710.4 8797.4 8518.3 8636.2 8646.7 8811.1 8827.8 3718.9 4562.1 4573.9 4576.8 4675.5 1641.7 1804.5 1911.6 1962.1 3686.9 838.7 881.5 931.9 937.4 946.6 17558.7 20599.3 21740.7 22516.0 22685.6 952.1 964.3 985.2 985.9 1048.9 8064.7 11545.5 11675.9 11808.7 11830.9 441950.0 520914.0 540556.0 554672.0 562702.0 99079.0 129484.0 130450.0 133422.3 138848.0 983.3 985.5 987.2 1001.8 1005.5 18862.6 19522.4 19548.6 19604.8 19607.7 31007.8 36345.8 40335.0 45575.5 54750.7 76095.0 77543.2 77560.6 78628.0 78868.6 5731.7 8218.4 8256.1 8531.6 8673.7 9353.7 12156.1 13020.3 13167.6 13360.2 5401.9 9028.6 11203.6 11676.3 11769.3 10635.4 11071.3 11350.2 11520.6 11551.8 6455.6 10091.1 11581.0 11891.4 12018.9 8363.6 8398.4 8453.2 8546.2 8633.6 9805.4 11884.0 11896.9 11937.3 11945.8 05:28:34 INFO - PROCESS | 1952 | 05:28:34 INFO - PROCESS | 1952 | [#3] mootools.html Cycles:180 Average:5665.02 Median:5048.44 stddev:3184.99 (63.1%) stddev-sans-first:3178.84 05:28:34 INFO - PROCESS | 1952 | Values: 1540.5 1551.8 1745.3 1822.0 1868.3 7901.6 8393.1 8427.7 8936.5 8957.0 8560.0 8763.6 8780.3 8792.7 8815.4 2375.2 2414.2 2417.2 2417.6 2441.5 1866.7 2382.8 2387.6 2421.6 2425.6 1942.9 2028.6 2283.2 2307.8 2308.6 2248.9 2255.7 2283.5 2294.9 2297.5 2327.0 2345.8 2346.7 2349.9 2355.3 8818.5 8874.7 8882.6 8895.9 8909.0 5251.2 5306.1 5315.9 5376.2 5417.6 3462.0 3547.4 3637.1 3638.1 3664.0 975.7 1052.0 1053.3 1089.9 1096.2 11509.4 11541.3 11638.5 11661.5 11677.4 3688.7 3952.9 4621.3 4795.3 4800.9 9777.0 9895.7 9902.4 9919.3 9936.9 5296.7 5343.0 5375.5 5407.8 5470.2 3579.7 4457.7 4837.6 4887.5 4925.1 3967.9 4008.8 4111.2 4133.3 4153.1 1187.3 1235.6 1300.1 1314.1 1322.6 920.3 927.0 927.6 959.8 982.2 5844.4 5938.3 6038.0 6123.9 6140.7 438.2 440.5 448.1 455.6 456.5 3702.6 3792.6 4015.9 4140.2 4172.5 10336.4 10527.4 10540.7 10574.5 10650.8 10478.6 10569.8 10585.7 10606.7 10610.0 7412.5 7708.3 7956.1 7995.8 8239.8 5824.7 5877.0 5897.1 6066.3 6092.5 8039.7 9860.1 9912.8 9925.5 10002.0 9738.9 9979.8 10010.4 10101.7 10214.1 6916.1 7277.9 7384.7 7496.0 7563.8 8349.3 8435.8 8450.6 8459.5 8466.9 6672.9 7341.3 7389.0 7522.0 7634.3 7369.9 7385.2 7387.7 7399.7 7493.1 6911.5 6922.1 6979.4 6995.3 7007.3 4823.2 4960.8 5047.5 5049.4 5178.9 5109.7 5114.0 5209.0 5235.8 5285.0 05:28:34 INFO - PROCESS | 1952 | 05:28:34 INFO - PROCESS | 1952 | [#4] prototype.html Cycles:180 Average:4519.30 Median:4904.93 stddev:1396.15 (28.5%) stddev-sans-first:1363.23 05:28:34 INFO - PROCESS | 1952 | Values: 274.3 298.4 311.0 315.0 315.9 4690.5 4919.4 5477.5 5711.4 5724.6 5497.4 5597.5 5619.3 5654.2 5683.7 4246.3 4260.9 4274.3 4300.4 4314.7 4068.1 4235.2 4256.7 4296.6 4307.5 3326.6 4195.6 4230.9 4237.7 4251.8 4089.1 4217.5 4242.3 4270.1 4292.7 3235.8 3697.9 3708.7 3721.4 3739.8 5012.6 5373.1 5465.6 5466.1 5489.0 4777.2 4792.6 4796.3 4798.5 4825.6 4934.7 5463.5 5594.9 5858.0 5893.7 3290.6 3922.3 3925.7 3929.7 3975.2 5081.8 5612.9 6014.4 6139.1 6202.6 3797.9 3832.8 3997.2 4014.6 4061.5 3441.7 3738.9 3977.7 4056.2 4119.3 3988.3 4800.9 4809.4 4820.0 4841.0 5226.4 5668.8 5977.8 5988.2 6005.0 1332.9 1352.9 1369.3 1373.3 1384.4 704.6 774.0 775.4 795.6 852.5 4176.3 4236.9 4328.6 4536.1 4722.0 4438.9 4745.0 5100.0 5110.8 5174.3 4005.8 4170.0 4582.8 4627.7 4661.2 2267.4 2529.5 2642.5 2665.6 2677.9 4783.0 4831.7 4890.4 4922.9 4933.0 4850.8 5191.5 5232.8 5282.9 5316.4 4572.0 5204.4 5248.9 5277.3 5296.6 4228.9 4286.9 5098.8 5119.9 5132.3 5048.9 5073.0 5090.8 5125.4 5157.7 5194.0 5713.7 5735.9 6005.7 6382.1 3584.0 3820.5 4038.6 4040.3 4058.4 5012.0 5692.8 5977.3 6107.3 6190.3 5946.8 5963.6 5970.6 6008.5 6021.5 5173.8 5807.6 5956.7 6011.9 6063.8 5000.2 5078.7 5507.4 5531.9 5573.6 5579.1 5630.4 5963.4 5983.9 6022.0 4724.6 5644.1 5815.0 5836.5 5885.8 05:28:34 INFO - PROCESS | 1952 | 05:28:34 INFO - PROCESS | 1952 | [#5] yui.html Cycles:180 Average:26449.77 Median:23776.02 stddev:42981.19 (180.8%) stddev-sans-first:43058.24 05:28:34 INFO - PROCESS | 1952 | Values: 688.0 721.7 783.7 802.6 850.9 14873.3 15012.7 15632.1 15637.8 15975.4 12496.4 12655.0 12679.9 12681.1 12715.1 678.8 709.4 830.4 839.7 851.7 729.5 824.6 841.0 844.9 858.6 916.3 917.1 917.4 918.1 918.7 877.1 891.0 903.5 913.4 915.8 653.1 662.6 678.8 681.0 684.6 15145.4 15276.2 15347.6 15376.1 15397.9 14712.6 14794.4 14807.2 15042.5 15061.4 11890.5 12129.8 12395.0 12506.4 12573.2 3833.8 3853.8 4072.7 4079.9 4086.1 119994.0 120510.0 121417.0 121696.6 125337.0 10442.9 10766.8 11389.1 11423.9 11484.1 23462.6 23700.8 23851.3 23931.0 24070.8 8154.0 8194.1 8201.7 8216.1 8332.4 4527.9 4577.6 4580.9 4603.8 4621.4 2961.0 3530.5 3667.8 3676.0 3685.4 637.9 638.6 648.8 664.2 666.6 565.9 644.3 661.1 666.9 676.6 8830.8 9044.4 9065.8 9426.3 9823.6 491.3 531.4 655.5 677.8 692.6 4119.3 4298.6 4562.9 4895.4 5021.6 132363.2 144172.8 165299.0 165350.2 168574.0 127370.7 135226.3 137106.0 138527.0 148534.0 111664.0 122772.0 122996.0 123793.8 124524.4 7884.6 8441.2 9175.9 9199.5 9336.6 62595.4 63017.7 65562.7 67922.7 68313.0 101195.0 104117.5 106665.0 107008.4 107788.0 11536.2 11594.9 11601.5 11931.4 12510.0 11498.3 12904.1 13036.4 15395.5 16085.5 13583.7 14222.4 14417.6 14786.2 14893.6 14018.8 14215.0 14249.5 14358.1 14399.5 13626.5 13756.6 14155.6 14560.3 14660.2 11262.2 11419.3 11599.5 11645.2 11872.6 9836.9 10035.9 10861.3 11570.9 11698.2 05:28:34 INFO - PROCESS | 1952 | -------- Summary: end -------- 05:28:34 INFO - PROCESS | 1952 | 05:28:35 INFO - TEST-INFO | 1952: exit 0 05:28:35 INFO - TEST-OK | dromaeo_css | took 1114274ms 05:28:35 INFO - TEST-START | kraken 05:28:35 INFO - operating with platform_type : mac_ 05:28:35 INFO - Initialising browser for kraken test... 05:28:35 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpI8lwmX/profile http://localhost:51166/getInfo.html) 05:28:37 INFO - PROCESS | 1957 | __metrics Screen width/height:1600/1200 05:28:37 INFO - PROCESS | 1957 | colorDepth:24 05:28:37 INFO - PROCESS | 1957 | Browser inner width/height: 1024/689 05:28:37 INFO - PROCESS | 1957 | __metrics 05:28:37 ERROR - PROCESS | 1957 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:28:38 INFO - TEST-INFO | 1957: exit 0 05:28:38 INFO - Browser initialized. 05:28:38 INFO - Running cycle 1/1 for kraken test... 05:28:38 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpI8lwmX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:50 INFO - PROCESS | 1959 | RSS: Main: 254750720 05:28:50 INFO - PROCESS | 1959 | 05:28:53 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51166/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:54 INFO - PROCESS | 1959 | RSS: Main: 267948032 05:28:54 INFO - PROCESS | 1959 | 05:28:57 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51166/tests/kraken/driver.html?testName=audio-dft) 05:28:57 INFO - PROCESS | 1959 | RSS: Main: 276729856 05:28:57 INFO - PROCESS | 1959 | 05:29:01 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51166/tests/kraken/driver.html?testName=audio-fft) 05:29:01 INFO - PROCESS | 1959 | RSS: Main: 279650304 05:29:01 INFO - PROCESS | 1959 | 05:29:03 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51166/tests/kraken/driver.html?testName=audio-oscillator) 05:29:04 INFO - PROCESS | 1959 | RSS: Main: 282066944 05:29:04 INFO - PROCESS | 1959 | 05:29:06 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51166/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:07 INFO - PROCESS | 1959 | RSS: Main: 282435584 05:29:07 INFO - PROCESS | 1959 | 05:29:09 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51166/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:10 INFO - PROCESS | 1959 | RSS: Main: 282681344 05:29:10 INFO - PROCESS | 1959 | 05:29:13 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51166/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:14 INFO - PROCESS | 1959 | RSS: Main: 282103808 05:29:14 INFO - PROCESS | 1959 | 05:29:17 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51166/tests/kraken/driver.html?testName=json-parse-financial) 05:29:17 INFO - PROCESS | 1959 | RSS: Main: 283099136 05:29:17 INFO - PROCESS | 1959 | 05:29:19 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51166/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:20 INFO - PROCESS | 1959 | RSS: Main: 282816512 05:29:20 INFO - PROCESS | 1959 | 05:29:21 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51166/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:22 INFO - PROCESS | 1959 | RSS: Main: 282914816 05:29:22 INFO - PROCESS | 1959 | 05:29:24 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51166/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:25 INFO - PROCESS | 1959 | RSS: Main: 282968064 05:29:25 INFO - PROCESS | 1959 | 05:29:28 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:29 INFO - PROCESS | 1959 | RSS: Main: 283426816 05:29:29 INFO - PROCESS | 1959 | 05:29:32 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:33 INFO - PROCESS | 1959 | RSS: Main: 283152384 05:29:33 INFO - PROCESS | 1959 | 05:29:34 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51166/tests/kraken/driver.html?testName=ai-astar) 05:29:35 INFO - PROCESS | 1959 | RSS: Main: 284213248 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | __start_tp_report 05:29:35 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 05:29:35 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 05:29:35 INFO - PROCESS | 1959 | |i|pagename|runs| 05:29:35 INFO - PROCESS | 1959 | |0;ai-astar;106;118;115;173;162;119;115;117;118;118 05:29:35 INFO - PROCESS | 1959 | |1;audio-beat-detection;143;107;133;159;96;137;163;145;183;112 05:29:35 INFO - PROCESS | 1959 | |2;audio-dft;201;208;242;255;252;201;195;203;196;195 05:29:35 INFO - PROCESS | 1959 | |3;audio-fft;69;86;76;153;60;60;59;59;136;61 05:29:35 INFO - PROCESS | 1959 | |4;audio-oscillator;70;72;123;82;102;126;134;71;73;114 05:29:35 INFO - PROCESS | 1959 | |5;imaging-gaussian-blur;91;90;90;88;91;88;91;89;92;88 05:29:35 INFO - PROCESS | 1959 | |6;imaging-darkroom;94;98;97;97;96;97;96;97;97;97 05:29:35 INFO - PROCESS | 1959 | |7;imaging-desaturate;92;98;94;89;94;92;120;107;146;102 05:29:35 INFO - PROCESS | 1959 | |8;json-parse-financial;56;56;57;57;55;60;69;88;89;85 05:29:35 INFO - PROCESS | 1959 | |9;json-stringify-tinderbox;68;72;77;77;80;76;71;71;71;72 05:29:35 INFO - PROCESS | 1959 | |10;stanford-crypto-aes;90;87;82;84;86;88;102;108;110;105 05:29:35 INFO - PROCESS | 1959 | |11;stanford-crypto-ccm;149;130;154;148;144;141;148;133;164;156 05:29:35 INFO - PROCESS | 1959 | |12;stanford-crypto-pbkdf2;240;185;169;197;192;182;162;226;231;206 05:29:35 INFO - PROCESS | 1959 | |13;stanford-crypto-sha256-iterative;68;70;69;67;69;78;89;83;70;64 05:29:35 INFO - PROCESS | 1959 | __end_tp_report 05:29:35 INFO - PROCESS | 1959 | __start_cc_report 05:29:35 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,1075 05:29:35 INFO - PROCESS | 1959 | __end_cc_report 05:29:35 INFO - PROCESS | 1959 | __startTimestamp1470659375022__endTimestamp 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | ------- Summary: start ------- 05:29:35 INFO - PROCESS | 1959 | Number of tests: 14 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#0] ai-astar Cycles:10 Average:126.10 Median:118.00 stddev:22.28 (18.9%) stddev-sans-first:22.42 05:29:35 INFO - PROCESS | 1959 | Values: 106.0 118.0 115.0 173.0 162.0 119.0 115.0 117.0 118.0 118.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:152.00 stddev:27.06 (17.8%) stddev-sans-first:28.64 05:29:35 INFO - PROCESS | 1959 | Values: 143.0 107.0 133.0 159.0 96.0 137.0 163.0 145.0 183.0 112.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#2] audio-dft Cycles:10 Average:214.80 Median:205.50 stddev:24.59 (12.0%) stddev-sans-first:25.57 05:29:35 INFO - PROCESS | 1959 | Values: 201.0 208.0 242.0 255.0 252.0 201.0 195.0 203.0 196.0 195.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#3] audio-fft Cycles:10 Average:81.90 Median:60.50 stddev:34.39 (56.8%) stddev-sans-first:36.16 05:29:35 INFO - PROCESS | 1959 | Values: 69.0 86.0 76.0 153.0 60.0 60.0 59.0 59.0 136.0 61.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:70.50 stddev:25.88 (36.7%) stddev-sans-first:25.59 05:29:35 INFO - PROCESS | 1959 | Values: 70.0 72.0 123.0 82.0 102.0 126.0 134.0 71.0 73.0 114.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:90.50 stddev:1.48 (1.6%) stddev-sans-first:1.50 05:29:35 INFO - PROCESS | 1959 | Values: 91.0 90.0 90.0 88.0 91.0 88.0 91.0 89.0 92.0 88.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:97.00 stddev:1.07 (1.1%) stddev-sans-first:0.60 05:29:35 INFO - PROCESS | 1959 | Values: 94.0 98.0 97.0 97.0 96.0 97.0 96.0 97.0 97.0 97.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#7] imaging-desaturate Cycles:10 Average:103.40 Median:92.00 stddev:17.57 (19.1%) stddev-sans-first:18.15 05:29:35 INFO - PROCESS | 1959 | Values: 92.0 98.0 94.0 89.0 94.0 92.0 120.0 107.0 146.0 102.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:64.50 stddev:14.48 (22.5%) stddev-sans-first:14.78 05:29:35 INFO - PROCESS | 1959 | Values: 56.0 56.0 57.0 57.0 55.0 60.0 69.0 88.0 89.0 85.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:74.00 stddev:3.75 (5.1%) stddev-sans-first:3.41 05:29:35 INFO - PROCESS | 1959 | Values: 68.0 72.0 77.0 77.0 80.0 76.0 71.0 71.0 71.0 72.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#10] stanford-crypto-aes Cycles:10 Average:94.20 Median:85.00 stddev:10.78 (12.7%) stddev-sans-first:11.32 05:29:35 INFO - PROCESS | 1959 | Values: 90.0 87.0 82.0 84.0 86.0 88.0 102.0 108.0 110.0 105.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:148.50 stddev:10.30 (6.9%) stddev-sans-first:10.89 05:29:35 INFO - PROCESS | 1959 | Values: 149.0 130.0 154.0 148.0 144.0 141.0 148.0 133.0 164.0 156.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.00 Median:201.50 stddev:26.44 (13.1%) stddev-sans-first:23.51 05:29:35 INFO - PROCESS | 1959 | Values: 240.0 185.0 169.0 197.0 192.0 182.0 162.0 226.0 231.0 206.0 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - PROCESS | 1959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:70.00 stddev:7.97 (11.4%) stddev-sans-first:8.27 05:29:35 INFO - PROCESS | 1959 | Values: 68.0 70.0 69.0 67.0 69.0 78.0 89.0 83.0 70.0 64.0 05:29:35 INFO - PROCESS | 1959 | -------- Summary: end -------- 05:29:35 INFO - PROCESS | 1959 | 05:29:35 INFO - TEST-INFO | 1959: exit 0 05:29:35 INFO - TEST-OK | kraken | took 60728ms 05:29:35 INFO - SUITE-END | took 1175s 05:29:36 INFO - Completed test suite (00:19:35) 05:29:36 INFO - javascript benchmark 05:29:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7275.635637932086, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2702.9324266893327, 3376.898693039208, 3404.8638054477824, 3413.2832105257894, 3420.2646431017333, 4976.676516026456, 5305.018571564258, 5716.8856622867515, 5773.220615216945, 5820.941790582098, 5791.507721843638, 5798.797042103527, 5850.795222167225, 5853.765849366031, 5861.76552937883, 5289.867753306169, 5350.866228344284, 5367.329083864517, 5405.567554595643, 5423.566114710814, 5221.686698798066, 5234.293370394986, 5293.920591191135, 5345.65253258537, 5404.83785486436, 5281.260623512711, 5299.973500132474, 5302.310699609065, 5344.7862085516535, 5351.411344752094, 5283.86790330241, 5293.523582877521, 5298.708571028592, 5330.333708286465, 5353.384360798519, 4242.7242229255, 5155.097857874857, 5187.896242075138, 5221.71280579568, 5268.157094864841, 4269.359596060584, 5825.038868586678, 5829.47534721877, 5852.912206316866, 5888.116782482619, 6142.416470435302, 6230.937690623081, 6235.127082208494, 6242.656653884034, 6255.249370075575, 5728.0, 6117.248930028882, 6159.38406159385, 6166.475849552793, 6224.688765561704, 4906.435759887623, 5934.05055191176, 5984.251968503937, 5990.670513121733, 6050.2437195350585, 6302.845498074273, 6303.936960630427, 6360.6501642409185, 6360.650164241011, 6467.4179323860135, 4872.975635121873, 6123.557162997564, 6149.96925015372, 6238.469730072904, 6268.247810262797, 5518.841043380935, 6160.168377269101, 6215.316315205324, 6217.626942383471, 6217.875642487215, 6150.0848218741185, 6212.4408803207925, 6263.279722831841, 6271.278802937721, 6272.8118156455375, 5280.683159010395, 6102.398363691488, 6118.235220597426, 6133.457080270857, 6188.319284878659, 5036.093503169464, 5058.367704036996, 5061.898762024813, 5085.110105731482, 5092.694438333712, 4505.0, 4515.841945531891, 4543.909121817611, 4552.521985191574, 4588.449386073693, 5679.204911312419, 5774.364819869811, 5870.295564532284, 5978.880422391528, 5980.192673988956, 6131.101423540838, 6186.4741496972365, 6215.192025036717, 6225.470834979077, 6263.3736626337, 5868.618539794899, 5914.497267732205, 5920.111983202554, 5920.911186332209, 5948.940510594839, 5491.505764481216, 5501.119820828728, 5528.253685752372, 5537.36320323168, 5545.223668686387, 6156.199694039746, 6303.212098487689, 6331.050342448485, 6342.365763423621, 6409.070684750685, 6229.065640154013, 6252.280987686474, 6252.374762523711, 6267.529935254783, 6268.561200715906, 6398.648074355769, 6420.454261387835, 6448.193975753031, 6451.3226111257645, 6454.0, 6113.172264937315, 6164.568480206342, 6173.135760993554, 6214.627122372672, 6214.627122372672, 6165.84585385369, 6206.193194884636, 6207.348228435949, 6214.316425193316, 6241.126242325987, 6044.032954727222, 6203.2245969253845, 6221.129041934223, 6223.564350495421, 6241.968790156202, 5026.572741317029, 6055.666938318434, 6122.459144589048, 6136.32500424944, 6139.171211886338, 5901.704914754331, 6053.910296146736, 6097.207363042776, 6104.572679912363, 6133.8466538335115, 6141.385861413823, 6191.25704915413, 6204.534659900435, 6218.284897236876, 6249.906251406142, 6001.189839371804, 6056.485198757979, 6094.786682466092, 6125.8468538285115, 6140.662263575547], "value": 5715.853903153895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.4978547846544, 513.8895137545428, 527.1697077103561, 531.949399935128, 566.4081035318097, 29853.999999999975, 40875.773726788204, 40892.59107408925, 40927.59072409275, 40959.0, 41703.582964170346, 42044.0, 42228.94427639303, 42318.36522452166, 42340.153196936044, 8555.828883422328, 9606.471644059575, 9786.0, 9814.0, 9845.064718851698, 9351.25189984803, 9708.805823883518, 9727.416355018722, 9751.561179746894, 9754.756131096708, 9681.854772178423, 9719.076687714656, 9797.755056123582, 9800.754981125494, 9819.165370943478, 9726.90273097267, 9740.269479788973, 9741.025897410273, 9748.658796942109, 9756.0, 8109.635066422025, 9655.565499552467, 9674.08096230857, 9699.951500242525, 9730.805383892353, 39248.41127383091, 39264.01839953996, 39460.802695986335, 39578.010549736486, 39605.0, 3046.8933587324336, 3287.556179915705, 3457.0665920201654, 3476.549032931777, 3521.7182625390165, 29641.851790740908, 30179.0, 30646.69353306461, 30762.077137685905, 30765.0, 3100.286934005169, 3135.717785399302, 3190.5533225348468, 3272.8199949002797, 3276.262840860787, 452690.0, 453697.0, 454706.0, 455685.0, 460544.0, 33108.66891331104, 33834.66165338364, 34127.82936085304, 34157.48763768545, 34241.65758342385, 29333.26666833346, 30926.381472370427, 31130.844345778125, 34949.30101397958, 35588.0, 16584.419545315857, 16618.83381166197, 16746.0, 16788.832111678727, 16826.41107561254, 12783.360831958365, 12825.166364186298, 12903.548375806802, 12908.35458227085, 12910.870891291155, 19076.80923190778, 19112.713309300372, 19232.0, 19286.80713192878, 19322.227110915406, 7889.842203155905, 7988.480748751313, 8008.319292860172, 8026.879596806052, 8030.196980301923, 867.6746220167437, 872.9912700873037, 946.8201041802035, 955.8327292723745, 1042.5517027678172, 26978.460430791274, 30607.69392306093, 30614.081577552708, 30710.846445768075, 30829.845850770602, 1038.2298181600354, 1040.6929955663097, 1076.3326737422692, 1086.0822604898847, 1102.9889701103048, 15300.0, 15965.680686386208, 15967.920160399124, 15992.440264590916, 16118.435854745263, 367793.0, 370505.0, 370758.0, 371202.0, 371325.0, 57713.711431443415, 57802.843943120904, 57923.0, 58135.54661133421, 58164.54588635318, 1323.0672375975107, 1352.4319785690034, 1367.1591970937802, 1369.137443410645, 1377.0360747476807, 29039.0, 30119.54820677648, 30143.698563014965, 30570.930017449282, 30813.22966925845, 50947.0, 51135.48864511307, 51330.23004655008, 51365.0, 51418.48581514137, 550860.0, 555370.0, 557165.0, 558143.0, 561505.0, 26807.731922681305, 26968.0, 27046.72953270442, 27084.0, 27790.0, 47787.0, 48140.27789583089, 48712.75643621759, 49105.263421047996, 49199.17618124007, 39726.60273397229, 40190.39714404345, 40211.59788402078, 40332.0, 40935.59064409318, 39622.0, 40077.79961100293, 40820.38769418521, 40859.79570102131, 41279.58720412877, 37620.81189594144, 38329.23341533098, 38704.6129538701, 38895.8331250063, 39024.21951561009, 32926.83536582302, 34231.31537369189, 34947.825260873535, 35352.11619709425, 35363.823180883934, 21611.00586199025, 25235.48587084781, 25829.3542661435, 26010.95956161808, 26148.477030459664], "value": 19083.42148033412, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.25364140628113, 362.7388280438084, 371.53001453161744, 382.8009435093753, 395.1504265828468, 20046.0, 21012.68480972785, 21270.787292127075, 22012.119515219372, 22144.557108857814, 20840.957952102373, 21125.57748845022, 21313.57372852542, 21489.892550537224, 21633.891830540866, 5717.342505611846, 5821.126830975367, 6025.066114752199, 6094.908576371358, 6107.877842443148, 3923.274194274054, 5795.71021448928, 6070.392960703938, 6093.664848433335, 6106.206193194901, 5184.948150518503, 6025.276966763994, 6120.26556813183, 6122.63264204147, 6123.081537769348, 5722.656640601577, 5981.551383646222, 6097.054956481752, 6608.867822643544, 6697.966510167418, 5861.3552509223955, 5911.970440147815, 5918.467337939606, 5935.970320148414, 5939.46544810969, 13337.266450345227, 13410.597682069554, 13569.45722171112, 13750.724985500234, 13865.722685546334, 2297.8391512594126, 2629.000979627748, 2693.138195777352, 2803.523401021831, 2947.3073827650487, 7871.567063811488, 9990.750231244205, 10171.288009839314, 10519.63181288659, 10558.841617375669, 1675.656490419461, 1844.4005698148155, 1854.8701590888643, 1920.5582715975265, 1939.660559402113, 112440.0, 116138.41930790377, 117926.41036794847, 119118.0, 125945.0, 11373.488193031333, 11504.482298296596, 11549.422528873523, 11708.824367634492, 11828.88171118295, 14473.348699308557, 14515.92742036283, 14677.706445871023, 14704.0, 14713.411463541339, 7308.853822923512, 8256.0, 8638.17937295956, 8710.390272680852, 8797.38418310725, 8518.275946544489, 8636.195456451544, 8646.740597782076, 8811.118888111137, 8827.779305517284, 3718.925621487555, 4562.087582483517, 4573.908521829545, 4576.816927322936, 4675.509071547506, 1641.7455294429144, 1804.530821986293, 1911.5794525204433, 1962.077823422989, 3686.8525258989876, 838.6729175621513, 881.5415983688574, 931.8928323242778, 937.3625934364698, 946.5598496699068, 17558.736618950727, 20599.279025234344, 21740.673889891663, 22515.986780594914, 22685.638861668354, 952.0907533305676, 964.2671569607149, 985.2315194148575, 985.9161971232382, 1048.9213309001855, 8064.717734879368, 11545.480453379618, 11675.88324116765, 11808.704782380337, 11830.940845295718, 441950.0, 520914.0, 540556.0, 554672.0, 562702.0, 99079.0, 129484.0, 130450.0, 133422.33288833493, 138848.0, 983.2625530851861, 985.4629227071264, 987.2052997337069, 1001.8296889528798, 1005.4570531912832, 18862.622747544698, 19522.414327570197, 19548.60902781965, 19604.803951960297, 19607.70588441203, 31007.84496077505, 36345.81827090848, 40335.0, 45575.544244558456, 54750.72624636851, 76095.0, 77543.2245677536, 77560.61219693866, 78628.0, 78868.60565697135, 5731.656100633975, 8218.424710270223, 8256.050554186346, 8531.616077276414, 8673.653053877773, 9353.672621458216, 12156.088293377856, 13020.28388438645, 13167.60497185086, 13360.198388096745, 5401.945980540144, 9028.55543113125, 11203.551857925917, 11676.299422034705, 11769.293842369485, 10635.415052172204, 11071.335719856834, 11350.205485615928, 11520.596779112691, 11551.826722599335, 6455.644939528371, 10091.091801737584, 11581.015613672933, 11891.405429728306, 12018.879811201776, 8363.62363693623, 8398.41211115216, 8453.196946290092, 8546.188112129337, 8633.56832158377, 9805.362651427635, 11884.0, 11896.881031189578, 11937.343446110548, 11945.82081268799], "value": 9389.511129958513, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.4916377595391, 1551.8137823461184, 1745.3193254630696, 1822.0, 1868.2900497810829, 7901.565413902247, 8393.11872253413, 8427.662893484268, 8936.463812171258, 8956.955215223923, 8560.0, 8763.605637746301, 8780.253678437324, 8792.69225577105, 8815.382923195379, 2375.228050883461, 2414.2033129067368, 2417.1660777031984, 2417.5527527407485, 2441.523902838947, 1866.7106598477258, 2382.821288403368, 2387.594109001474, 2421.624648179535, 2425.624028275611, 1942.922283108674, 2028.6348457277684, 2283.178055899875, 2307.8038366738847, 2308.56137333906, 2248.8875556222206, 2255.6842042114117, 2283.5318759654233, 2294.8967296471615, 2297.4715815362392, 2326.953460930772, 2345.82406319525, 2346.741858395575, 2349.8825058747166, 2355.3169580821714, 8818.514981676006, 8874.733757987271, 8882.644694212224, 8895.911040889572, 8908.955455222747, 5251.159814429673, 5306.071437498423, 5315.946840531584, 5376.193570964387, 5417.6478528895495, 3462.0, 3547.396942519778, 3637.108908317453, 3638.126849556114, 3664.0, 975.7267964969819, 1052.0268751404997, 1053.3258714422775, 1089.9237053406264, 1096.1723898456694, 11509.366984815832, 11541.30752154865, 11638.534458621645, 11661.533538658528, 11677.416129193507, 3688.7417880748626, 3952.9011774705286, 4621.2837010263465, 4795.280707893774, 4800.855974320776, 9777.0, 9895.703128906145, 9902.356346837432, 9919.305648604673, 9936.900630993598, 5296.735163241822, 5343.011542864582, 5375.5162035417, 5407.756650950717, 5470.234167216593, 3579.6778289954027, 4457.687961842705, 4837.612990960785, 4887.511248875084, 4925.13810083234, 3967.8691572901585, 4008.7995600219874, 4111.218868414991, 4133.2973394522405, 4153.127843152912, 1187.3113594115393, 1235.6354875311804, 1300.0964329790893, 1314.0604467805374, 1322.6428864206803, 920.282179899666, 926.972190834276, 927.5547737086237, 959.842119427091, 982.1946004276567, 5844.444777746107, 5938.257717785277, 6038.00372938469, 6123.877522449526, 6140.723667434976, 438.1674817846054, 440.5462373755037, 448.1239177408159, 455.5694868349378, 456.5480174627162, 3702.5556933167654, 3792.60177681345, 4015.9397609035886, 4140.15126898991, 4172.4993000840095, 10336.431496267778, 10527.368357898551, 10540.683779486628, 10574.471276436301, 10650.786984260272, 10478.63324783629, 10569.841452378221, 10585.735356616146, 10606.734831629272, 10610.0, 7412.518186317872, 7708.344790692742, 7956.124826269222, 7995.800104997305, 8239.764035394619, 5824.679642619527, 5877.0, 5897.115432685132, 6066.3023752269055, 6092.45167934888, 8039.718609848627, 9860.112589866947, 9912.801743965225, 9925.503724813587, 10002.0, 9738.902610973799, 9979.800403991734, 10010.399376037461, 10101.747456313651, 10214.08073273409, 6916.100906882073, 7277.854442911218, 7384.704611815682, 7496.0255166827965, 7563.810904727426, 8349.33205343559, 8435.789105272417, 8450.577471126297, 8459.492430454193, 8466.872996905175, 6672.899906501503, 7341.33927946466, 7389.0, 7521.962390188014, 7634.312911837961, 7369.852602948018, 7385.224551422023, 7387.741429049957, 7399.741009064657, 7493.138289096605, 6911.516193866582, 6922.10012698346, 6979.40675042627, 6995.300469952964, 7007.334303241184, 4823.1800593898415, 4960.801567937387, 5047.49525047507, 5049.394072711299, 5178.870528236825, 5109.718965456936, 5114.0, 5209.0, 5235.8481134150425, 5285.048691235615], "value": 4481.794081211582, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.332001576162, 298.4106389879989, 310.95180247061705, 315.0140061607169, 315.94786860168074, 4690.530946905308, 4919.434265059519, 5477.5070243678065, 5711.3717491076, 5724.570657200717, 5497.422770609089, 5597.496225339719, 5619.297587801525, 5654.151877218419, 5683.687397193163, 4246.3205887058075, 4260.89347766306, 4274.273373526493, 4300.397944287803, 4314.654827613784, 4068.0643452006057, 4235.216484950279, 4256.7435911527555, 4296.613304802567, 4307.483102027761, 3326.600807903055, 4195.55946625603, 4230.851920182794, 4237.745735255895, 4251.829926802924, 4089.141280331134, 4217.514985776629, 4242.2788126018495, 4270.103278311558, 4292.699511034229, 3235.773495855291, 3697.9445308320396, 3708.6662200402093, 3721.441783732435, 3739.8317075731657, 5012.624053195988, 5373.113436283009, 5465.644733092376, 5466.125419932791, 5489.0, 4777.163996300634, 4792.616590672737, 4796.304535842318, 4798.536446383851, 4825.589824864891, 4934.703917764946, 5463.535599474049, 5594.944050559483, 5857.970710146422, 5893.705314734246, 3290.6380298167182, 3922.3332033554366, 3925.7448265862627, 3929.7445666031617, 3975.2248311579256, 5081.79672813087, 5612.859678508029, 6014.406182361634, 6139.140520327158, 6202.565820392574, 3797.867074652374, 3832.8118283332255, 3997.200559888034, 4014.638682518529, 4061.5126184858004, 3441.7074548663145, 3738.887833365003, 3977.6817854571564, 4056.1887622475624, 4119.258533463945, 3988.3020471417385, 4800.855974320776, 4809.350737650442, 4820.0, 4840.975795121002, 5226.372835259793, 5668.829935101953, 5977.820665380045, 5988.191594134823, 6004.969975150097, 1332.8533861275253, 1352.8511863694985, 1369.2948131712176, 1373.3270697358223, 1384.3631929312628, 704.63359053292, 773.9690412383442, 775.3719487215374, 795.6340083561627, 852.5140669818268, 4176.310908700091, 4236.915261694749, 4328.588784065509, 4536.092781443725, 4721.952780472151, 4438.933415998763, 4745.003549254695, 5099.991005306887, 5110.770015349244, 5174.30935913323, 4005.819738111792, 4169.958300416957, 4582.793774280165, 4627.699199552018, 4661.230896902041, 2267.4331417145713, 2529.4941011797714, 2642.484715480463, 2665.640138581267, 2677.906273280426, 4782.95217047832, 4831.710097394168, 4890.435060780516, 4922.926156107661, 4932.950670493321, 4850.781714822841, 5191.480851914854, 5232.764525596357, 5282.947170528246, 5316.362036555638, 4571.977140114278, 5204.375474942955, 5248.923970586021, 5277.313949186581, 5296.629235953524, 4228.89427764296, 4286.914261714811, 5098.768022541208, 5119.897602048012, 5132.3327967364, 5048.873778155576, 5073.046876952326, 5090.796368145381, 5125.384953805567, 5157.716325602128, 5194.013137503862, 5713.657180569179, 5735.881503106854, 6005.699715014144, 6382.138411314413, 3584.0466945515277, 3820.522434695663, 4038.636522712852, 4040.3131467649982, 4058.3912413138264, 5012.0, 5692.7798158717305, 5977.282726072899, 6107.297660769068, 6190.319064902767, 5946.821595352147, 5963.552733545088, 5970.611910225822, 6008.5493587981955, 6021.518278537619, 5173.7671804769625, 5807.564432667482, 5956.731947062306, 6011.909821352596, 6063.787767428119, 5000.199968005102, 5078.695278283167, 5507.421720719267, 5531.917021244765, 5573.5819813513335, 5579.051561234519, 5630.408807075198, 5963.403659634176, 5983.910241346296, 6021.969890150521, 4724.574788269072, 5644.0687286598895, 5815.04051831443, 5836.503897168618, 5885.849287494664], "value": 4065.5272338546188, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.9587224766515, 721.7077083781071, 783.7452827830955, 802.6227672993691, 850.9064002959674, 14873.256337183151, 15012.699746005073, 15632.140232287205, 15637.765433518507, 15975.440859569917, 12496.375181240925, 12655.0, 12679.873201267985, 12681.112322137455, 12715.109942304043, 678.8235058884676, 709.4359983812881, 830.393812516863, 839.7312859884839, 851.7189327521903, 729.5185177782664, 824.6454024769347, 841.0496139362511, 844.8732690096504, 858.6136238692582, 916.3402350307767, 917.0554329041065, 917.3761841947473, 918.1415376622846, 918.6600957645647, 877.0965905117707, 891.033228946597, 903.5482258870564, 913.4108500017452, 915.8031023330016, 653.0726368556661, 662.592505609047, 678.8133263352568, 680.9897851532231, 684.5618803965466, 15145.394184232617, 15276.236188190656, 15347.61630959235, 15376.077435353804, 15397.923010384988, 14712.558623241213, 14794.40822367104, 14807.185604791732, 15042.548723538312, 15061.397544098223, 11890.524379024915, 12129.757404851942, 12395.0, 12506.437210325557, 12573.245605263714, 3833.769973801581, 3853.7880416577077, 4072.694547908889, 4079.8980025499304, 4086.1214838809797, 119994.0, 120510.0, 121417.0, 121696.56606867902, 125337.0, 10442.947785261025, 10766.78466430667, 11389.145814063979, 11423.942880285545, 11484.081273498101, 23462.64806027911, 23700.762992369855, 23851.284461466184, 23931.042758289474, 24070.7592924072, 8154.0, 8194.139615340422, 8201.671933122727, 8216.137305582948, 8332.375071869634, 4527.886802829889, 4577.633789296849, 4580.862574122782, 4603.792829322689, 4621.376114224604, 2960.955585666217, 3530.523379343807, 3667.7615954963376, 3676.0, 3685.3734865073, 637.8501052252717, 638.5849198021323, 648.8313038609901, 664.1896885799317, 666.5800545656302, 565.8924804287172, 644.3331152257391, 661.1306132435832, 666.9195902637758, 676.5500941873697, 8830.779230519289, 9044.41211321262, 9065.81868362629, 9426.293028022927, 9823.557939892722, 491.25329499161074, 531.4393315052579, 655.5050936542975, 677.7831094049857, 692.5602242576, 4119.299719047769, 4298.634616057608, 4562.877709301963, 4895.443188222199, 5021.648484606116, 132363.21478364692, 144172.837407439, 165299.0, 165350.173249133, 168574.0, 127370.72629273775, 135226.323868382, 137106.0, 138527.0, 148534.0, 111664.0, 122772.0, 122996.0, 123793.76206237823, 124524.37737811434, 7884.605769711607, 8441.15588441151, 9175.944766351955, 9199.54002299869, 9336.579853906725, 62595.374046260775, 63017.73964520776, 65562.67218663877, 67922.66038669775, 68313.0, 101195.0, 104117.47941260245, 106665.0, 107008.3948740754, 107788.0, 11536.192466527262, 11594.884051159717, 11601.535938562363, 11931.403429828648, 12510.0, 11498.252643405114, 12904.09671323036, 13036.413361398949, 15395.461158859385, 16085.517434476984, 13583.660408489472, 14222.431102755774, 14417.63955901069, 14786.178788696421, 14893.627659308604, 14018.78971815444, 14215.0, 14249.50126745559, 14358.099733264717, 14399.496017639332, 13626.454941802216, 13756.587302380945, 14155.575332740034, 14560.331671331176, 14660.193689347188, 11262.211645185087, 11419.31484110956, 11599.536018559163, 11645.205309514948, 11872.584459543874, 9836.852447213441, 10035.899641003789, 10861.294015888941, 11570.94214528922, 11698.181127321006], "value": 7947.514569528909, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 115.0, 173.0, 162.0, 119.0, 115.0, 117.0, 118.0, 118.0], "value": 126.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 133.0, 159.0, 96.0, 137.0, 163.0, 145.0, 183.0, 112.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 208.0, 242.0, 255.0, 252.0, 201.0, 195.0, 203.0, 196.0, 195.0], "value": 214.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 86.0, 76.0, 153.0, 60.0, 60.0, 59.0, 59.0, 136.0, 61.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 123.0, 82.0, 102.0, 126.0, 134.0, 71.0, 73.0, 114.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 90.0, 88.0, 91.0, 88.0, 91.0, 89.0, 92.0, 88.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 98.0, 94.0, 89.0, 94.0, 92.0, 120.0, 107.0, 146.0, 102.0], "value": 103.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 55.0, 60.0, 69.0, 88.0, 89.0, 85.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 77.0, 77.0, 80.0, 76.0, 71.0, 71.0, 71.0, 72.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 82.0, 84.0, 86.0, 88.0, 102.0, 108.0, 110.0, 105.0], "value": 94.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 130.0, 154.0, 148.0, 144.0, 141.0, 148.0, 133.0, 164.0, 156.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [240.0, 185.0, 169.0, 197.0, 192.0, 182.0, 162.0, 226.0, 231.0, 206.0], "value": 199.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 67.0, 69.0, 78.0, 89.0, 83.0, 70.0, 64.0], "value": 72.7, "unit": "score"}]}]} 05:29:36 INFO - Return code: 0 05:29:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:29:36 ERROR - # TBPL SUCCESS # 05:29:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:29:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:29:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:29:36 INFO - 2016-08-08 05:29:36.373 screenresolution[1964:18563] starting screenresolution argv=screenresolution get 05:29:36 INFO - 2016-08-08 05:29:36.375 screenresolution[1964:18563] Display 0: 1600x1200x32@60 05:29:36 INFO - 2016-08-08 05:29:36.381 screenresolution[1965:18566] starting screenresolution argv=screenresolution list 05:29:36 INFO - Available Modes on Display 0 05:29:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:29:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:29:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:29:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:29:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:29:36 INFO - Intel Iris: 05:29:36 INFO - Chipset Model: Intel Iris 05:29:36 INFO - Type: GPU 05:29:36 INFO - Bus: Built-In 05:29:36 INFO - VRAM (Dynamic, Max): 1536 MB 05:29:36 INFO - Vendor: Intel (0x8086) 05:29:36 INFO - Device ID: 0x0a2e 05:29:36 INFO - Revision ID: 0x0009 05:29:36 INFO - Displays: 05:29:36 INFO - Display: 05:29:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:29:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:29:36 INFO - Display Serial Number: 1600x1200 60 05:29:36 INFO - Main Display: Yes 05:29:36 INFO - Mirror: Off 05:29:36 INFO - Online: Yes 05:29:36 INFO - Rotation: Supported 05:29:36 INFO - Return code: 0 05:29:36 INFO - Running post-action listener: _resource_record_post_action 05:29:36 INFO - [mozharness: 2016-08-08 12:29:36.620501Z] Finished run-tests step (success) 05:29:36 INFO - Running post-run listener: _resource_record_post_run 05:29:36 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 684032; Write bytes: 704760320; Read time: 12; Write time: 2220 05:29:36 INFO - TinderboxPrint: CPU usage
54.4% 05:29:36 INFO - TinderboxPrint: I/O read bytes / time
684,032 / 12 05:29:36 INFO - TinderboxPrint: I/O write bytes / time
704,760,320 / 2,220 05:29:36 INFO - TinderboxPrint: CPU idle
2,206.3 (45.6%) 05:29:36 INFO - TinderboxPrint: CPU system
978.6 (20.2%) 05:29:36 INFO - TinderboxPrint: CPU user
1,656.7 (34.2%) 05:29:36 INFO - TinderboxPrint: Swap in / out
408,059,904 / 0 05:29:36 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391950848; Write bytes: 386856448; Read time: 29500; Write time: 680 05:29:36 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 671744; Write bytes: 294720512; Read time: 11; Write time: 1492 05:29:37 INFO - Running post-run listener: _upload_blobber_files 05:29:37 INFO - Blob upload gear active. 05:29:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:29:37 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:38 INFO - (blobuploader) - INFO - Done attempting. 05:29:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:39 INFO - (blobuploader) - INFO - Done attempting. 05:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:29:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:41 INFO - (blobuploader) - INFO - Done attempting. 05:29:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:41 INFO - Return code: 0 05:29:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5400ccffab9fe55f6fbc740ead426ef184e5a765bffa38da5a8135624689205ef8fb269374008e4211e63aec670309658a33e53352caec0d41c47fc8512a701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9e82e5ad45e7190f373f29b523b996014122a2774ed1e3f80f1c0e1816173e66b9c5614459b6c00f1ef3251e0f176c902601d52f37dc56234ff65c8ca6fbc6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a454d8631d1c53472a7ed8eea15f4cd68f4d18947a5d84b68cae460dcd80f2286e6ed8ff3d21f81335ca7efe7c8b21f1e0d0a0ac734b5b4e5e47beafcb780440"} 05:29:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:41 INFO - Contents: 05:29:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5400ccffab9fe55f6fbc740ead426ef184e5a765bffa38da5a8135624689205ef8fb269374008e4211e63aec670309658a33e53352caec0d41c47fc8512a701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9e82e5ad45e7190f373f29b523b996014122a2774ed1e3f80f1c0e1816173e66b9c5614459b6c00f1ef3251e0f176c902601d52f37dc56234ff65c8ca6fbc6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a454d8631d1c53472a7ed8eea15f4cd68f4d18947a5d84b68cae460dcd80f2286e6ed8ff3d21f81335ca7efe7c8b21f1e0d0a0ac734b5b4e5e47beafcb780440"} 05:29:41 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:41 INFO - Copying logs to upload dir... 05:29:41 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.830679 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-08 05:29:42.028172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-08 05:29:42.031326) ========= 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.V9pahXUwXf/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.Sfo4u1gb33/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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/f5400ccffab9fe55f6fbc740ead426ef184e5a765bffa38da5a8135624689205ef8fb269374008e4211e63aec670309658a33e53352caec0d41c47fc8512a701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9e82e5ad45e7190f373f29b523b996014122a2774ed1e3f80f1c0e1816173e66b9c5614459b6c00f1ef3251e0f176c902601d52f37dc56234ff65c8ca6fbc6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a454d8631d1c53472a7ed8eea15f4cd68f4d18947a5d84b68cae460dcd80f2286e6ed8ff3d21f81335ca7efe7c8b21f1e0d0a0ac734b5b4e5e47beafcb780440"} 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.011207 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/f5400ccffab9fe55f6fbc740ead426ef184e5a765bffa38da5a8135624689205ef8fb269374008e4211e63aec670309658a33e53352caec0d41c47fc8512a701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9e82e5ad45e7190f373f29b523b996014122a2774ed1e3f80f1c0e1816173e66b9c5614459b6c00f1ef3251e0f176c902601d52f37dc56234ff65c8ca6fbc6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a454d8631d1c53472a7ed8eea15f4cd68f4d18947a5d84b68cae460dcd80f2286e6ed8ff3d21f81335ca7efe7c8b21f1e0d0a0ac734b5b4e5e47beafcb780440"}' ========= master_lag: 1.59 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-08 05:29:43.631457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:29:43.631804) ========= 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.V9pahXUwXf/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.Sfo4u1gb33/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005108 ========= master_lag: 0.91 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:29:44.548760) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:29:44.549116) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:29:44.549725) ========= ========= Total master_lag: 2.62 =========