builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0387 starttime: 1486731033.79 results: success (0) buildid: 20170210033723 builduid: 0de97d8d1cd347f98784d51f93114db7 revision: 9a08294a8eb8cea3683c6355decebce1d1876fa1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 04:50:33.793028) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 04:50:33.793510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 15 secs) (at 2017-02-10 04:50:33.793879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 15 secs) (at 2017-02-10 04:50:49.208282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 04:50:49.208728) ========= 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.hVEn8GRbHc/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.wgUxxGycai/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-10 04:50:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-02-10 04:50:49 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109815 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 04:50:49.347027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 04:50:49.347351) ========= 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.hVEn8GRbHc/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.wgUxxGycai/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.020762 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 04:50:49.396434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 04:50:49.398842) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a08294a8eb8cea3683c6355decebce1d1876fa1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a08294a8eb8cea3683c6355decebce1d1876fa1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hVEn8GRbHc/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.wgUxxGycai/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-10 04:50:49,506 truncating revision to first 12 chars 2017-02-10 04:50:49,506 Setting DEBUG logging. 2017-02-10 04:50:49,506 attempt 1/10 2017-02-10 04:50:49,506 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a08294a8eb8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 04:50:50,693 unpacking tar archive at: mozilla-aurora-9a08294a8eb8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.457518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 04:50:50.881300) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 04:50:50.881785) ========= script_repo_revision: 9a08294a8eb8cea3683c6355decebce1d1876fa1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 04:50:50.882280) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 04:50:50.882666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 04:50:50.903418) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-10 04:50:50.904161) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hVEn8GRbHc/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.wgUxxGycai/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:50:51 INFO - MultiFileLogger online at 20170210 04:50:51 in /builds/slave/test 04:50:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:50:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:50:51 INFO - {'append_to_log': False, 04:50:51 INFO - 'base_work_dir': '/builds/slave/test', 04:50:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:50:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:50:51 INFO - 'branch': 'Mozilla-Aurora', 04:50:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:50:51 INFO - 'config_files': ('talos/mac_config.py',), 04:50:51 INFO - 'default_actions': ('clobber', 04:50:51 INFO - 'read-buildbot-config', 04:50:51 INFO - 'download-and-extract', 04:50:51 INFO - 'populate-webroot', 04:50:51 INFO - 'create-virtualenv', 04:50:51 INFO - 'install', 04:50:51 INFO - 'run-tests'), 04:50:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:50:51 INFO - 'download_minidump_stackwalk': True, 04:50:51 INFO - 'download_symbols': 'ondemand', 04:50:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:50:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:50:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:50:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:50:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:50:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:50:51 INFO - 'installer_path': 'installer.exe', 04:50:51 INFO - 'log_level': 'info', 04:50:51 INFO - 'log_name': 'talos', 04:50:51 INFO - 'log_to_console': True, 04:50:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:50:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:50:51 INFO - 'opt_config_files': (), 04:50:51 INFO - 'pip_index': False, 04:50:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:50:51 INFO - 'cmd': ('bash', 04:50:51 INFO - '-c', 04:50:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:50:51 INFO - 'enabled': True, 04:50:51 INFO - 'halt_on_failure': False, 04:50:51 INFO - 'name': 'check_screen_resolution'},), 04:50:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:50:51 INFO - 'cmd': ('bash', 04:50:51 INFO - '-c', 04:50:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:50:51 INFO - 'enabled': True, 04:50:51 INFO - 'halt_on_failure': False, 04:50:51 INFO - 'name': 'check_screen_resolution'},), 04:50:51 INFO - 'run_cmd_checks_enabled': True, 04:50:51 INFO - 'sps_profile': False, 04:50:51 INFO - 'sps_profile_interval': 0, 04:50:51 INFO - 'suite': 'dromaeojs', 04:50:51 INFO - 'system_bits': '32', 04:50:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:50:51 INFO - 'title': 't-yosemite-r7-0387', 04:50:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:50:51 INFO - 'use_talos_json': True, 04:50:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:50:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:50:51 INFO - 'work_dir': 'build'} 04:50:51 INFO - [mozharness: 2017-02-10 12:50:51.135639Z] Running clobber step. 04:50:51 INFO - Running pre-action listener: _resource_record_pre_action 04:50:51 INFO - Running main action method: clobber 04:50:51 INFO - rmtree: /builds/slave/test/build 04:50:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:50:52 INFO - Running post-action listener: _resource_record_post_action 04:50:52 INFO - [mozharness: 2017-02-10 12:50:52.892430Z] Finished clobber step (success) 04:50:52 INFO - [mozharness: 2017-02-10 12:50:52.892577Z] Running read-buildbot-config step. 04:50:52 INFO - Running pre-action listener: _resource_record_pre_action 04:50:52 INFO - Running main action method: read_buildbot_config 04:50:52 INFO - Using buildbot properties: 04:50:52 INFO - { 04:50:52 INFO - "project": "", 04:50:52 INFO - "product": "firefox", 04:50:52 INFO - "script_repo_revision": "production", 04:50:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:50:52 INFO - "repository": "", 04:50:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:50:52 INFO - "buildid": "20170210033723", 04:50:52 INFO - "pgo_build": "False", 04:50:52 INFO - "basedir": "/builds/slave/test", 04:50:52 INFO - "buildnumber": 67, 04:50:52 INFO - "slavename": "t-yosemite-r7-0387", 04:50:52 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:50:52 INFO - "platform": "yosemite_r7", 04:50:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:50:52 INFO - "branch": "mozilla-aurora", 04:50:52 INFO - "repo_path": "releases/mozilla-aurora", 04:50:52 INFO - "revision": "9a08294a8eb8cea3683c6355decebce1d1876fa1", 04:50:52 INFO - "stage_platform": "macosx64", 04:50:52 INFO - "builduid": "0de97d8d1cd347f98784d51f93114db7", 04:50:52 INFO - "slavebuilddir": "test" 04:50:52 INFO - } 04:50:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 04:50:52 INFO - Running post-action listener: _resource_record_post_action 04:50:52 INFO - [mozharness: 2017-02-10 12:50:52.895751Z] Finished read-buildbot-config step (success) 04:50:52 INFO - [mozharness: 2017-02-10 12:50:52.895885Z] Running download-and-extract step. 04:50:52 INFO - Running pre-action listener: _resource_record_pre_action 04:50:52 INFO - Running main action method: download_and_extract 04:50:52 INFO - mkdir: /builds/slave/test/build/tests 04:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:52 INFO - trying https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 04:50:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 04:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 04:50:54 INFO - Downloaded 1199 bytes. 04:50:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 04:50:54 INFO - Using the following test package requirements: 04:50:54 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 04:50:54 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:50:54 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 04:50:54 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:50:54 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 04:50:54 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:50:54 INFO - u'jsshell-mac.zip'], 04:50:54 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:50:54 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 04:50:54 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 04:50:54 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:50:54 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 04:50:54 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:50:54 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 04:50:54 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:50:54 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 04:50:54 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 04:50:54 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 04:50:54 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:50:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 04:50:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:50:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 04:50:55 INFO - Expected file size: 16357919 04:50:55 INFO - Obtained file size: 16357919 04:51:01 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 04:51:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 04:51:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:51:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 04:51:02 INFO - Expected file size: 16357919 04:51:02 INFO - Obtained file size: 16357919 04:51:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 04:51:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:51:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 04:51:10 INFO - Expected file size: 14403485 04:51:10 INFO - Obtained file size: 14403485 04:51: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')]} 04:51:10 INFO - trying https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 04:51:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 04:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 04:51:12 INFO - Downloaded 73827337 bytes. 04:51:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 04:51:12 INFO - mkdir: /builds/slave/test/properties 04:51:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:51:12 INFO - Writing to file /builds/slave/test/properties/build_url 04:51:12 INFO - Contents: 04:51:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 04:51:13 INFO - Running post-action listener: _resource_record_post_action 04:51:13 INFO - Running post-action listener: set_extra_try_arguments 04:51:13 INFO - [mozharness: 2017-02-10 12:51:13.247137Z] Finished download-and-extract step (success) 04:51:13 INFO - [mozharness: 2017-02-10 12:51:13.247297Z] Running populate-webroot step. 04:51:13 INFO - Running pre-action listener: _resource_record_pre_action 04:51:13 INFO - Running main action method: populate_webroot 04:51:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:51:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:51:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:51:13 INFO - '--tppagecycles', 04:51:13 INFO - '7'], 04:51:13 INFO - 'tests': ['tsvgm']}}, 04:51:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:51:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:51:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:51:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:51:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:51:13 INFO - 'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:51:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:51:13 INFO - 'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['damp', 'tps']}, 04:51:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:51:13 INFO - 'tests': ['damp', 'tps']}, 04:51:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['dromaeo_dom']}, 04:51:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:51:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['basic_compositor_video']}, 04:51:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:51:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['a11yr', 04:51:13 INFO - 'ts_paint', 04:51:13 INFO - 'tpaint', 04:51:13 INFO - 'sessionrestore', 04:51:13 INFO - 'sessionrestore_no_auto_restore', 04:51:13 INFO - 'tabpaint']}, 04:51:13 INFO - 'other-e10s': {'tests': ['a11yr', 04:51:13 INFO - 'ts_paint', 04:51:13 INFO - 'tpaint', 04:51:13 INFO - 'sessionrestore', 04:51:13 INFO - 'sessionrestore_no_auto_restore', 04:51:13 INFO - 'tabpaint']}, 04:51:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:51:13 INFO - 'ts_paint', 04:51:13 INFO - 'tpaint', 04:51:13 INFO - 'sessionrestore', 04:51:13 INFO - 'sessionrestore_no_auto_restore', 04:51:13 INFO - 'tabpaint']}, 04:51:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:51:13 INFO - 'ts_paint', 04:51:13 INFO - 'tpaint', 04:51:13 INFO - 'sessionrestore', 04:51:13 INFO - 'sessionrestore_no_auto_restore', 04:51:13 INFO - 'tabpaint']}, 04:51:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['a11yr', 04:51:13 INFO - 'ts_paint', 04:51:13 INFO - 'tpaint', 04:51:13 INFO - 'sessionrestore', 04:51:13 INFO - 'sessionrestore_no_auto_restore', 04:51:13 INFO - 'tabpaint']}, 04:51:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['a11yr', 04:51:13 INFO - 'ts_paint', 04:51:13 INFO - 'tpaint', 04:51:13 INFO - 'sessionrestore', 04:51:13 INFO - 'sessionrestore_no_auto_restore', 04:51:13 INFO - 'tabpaint']}, 04:51:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['tsvgx', 04:51:13 INFO - 'tsvgr_opacity', 04:51:13 INFO - 'tart', 04:51:13 INFO - 'tscrollx', 04:51:13 INFO - 'cart', 04:51:13 INFO - 'tsvg_static']}, 04:51:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:51:13 INFO - 'tsvgr_opacity', 04:51:13 INFO - 'tart', 04:51:13 INFO - 'tscrollx', 04:51:13 INFO - 'cart', 04:51:13 INFO - 'tsvg_static']}, 04:51:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:51:13 INFO - 'talos_options': ['--disable-e10s'], 04:51:13 INFO - 'tests': ['tp5o']}, 04:51:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:51:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:51:13 INFO - 'talos_options': ['--disable-e10s', 04:51:13 INFO - '--xperf_path', 04:51:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:13 INFO - 'tests': ['tp5n']}, 04:51:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:51:13 INFO - 'talos_options': ['--xperf_path', 04:51:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:13 INFO - 'tests': ['tp5n']}}, 04:51:13 INFO - 'talos.zip': {'path': '', 04:51:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:51:13 INFO - Running post-action listener: _resource_record_post_action 04:51:13 INFO - [mozharness: 2017-02-10 12:51:13.265866Z] Finished populate-webroot step (success) 04:51:13 INFO - [mozharness: 2017-02-10 12:51:13.266001Z] Running create-virtualenv step. 04:51:13 INFO - Running pre-action listener: _resource_record_pre_action 04:51:13 INFO - Running main action method: create_virtualenv 04:51:13 INFO - Creating virtualenv /builds/slave/test/build/venv 04:51:13 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 04:51:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:51:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:51:13 INFO - Using real prefix '/tools/python27' 04:51:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:51:14 INFO - Installing distribute.............................................................................................................................................................................................done. 04:51:17 INFO - Installing pip.................done. 04:51:17 INFO - Return code: 0 04:51:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:51:17 INFO - Reading from file tmpfile_stdout 04:51:17 INFO - Output received: 04:51:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:51:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:17 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 0x107372b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107375768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa55b567d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, '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.hVEn8GRbHc/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.wgUxxGycai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:51:17 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 04:51:17 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 04:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:17 INFO - 'HOME': '/Users/cltbld', 04:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:17 INFO - 'LOGNAME': 'cltbld', 04:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:17 INFO - 'MOZ_NO_REMOTE': '1', 04:51:17 INFO - 'NO_EM_RESTART': '1', 04:51:17 INFO - 'PAGER': '/bin/cat', 04:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:17 INFO - 'PWD': '/builds/slave/test', 04:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:17 INFO - 'SHELL': '/bin/bash', 04:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:51:17 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:17 INFO - 'USER': 'cltbld', 04:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:17 INFO - 'XPC_FLAGS': '0x0', 04:51:17 INFO - 'XPC_SERVICE_NAME': '0', 04:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:17 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 04:51:17 INFO - Cleaning up... 04:51:17 INFO - Return code: 0 04:51:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:17 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 0x107372b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107375768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa55b567d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, '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.hVEn8GRbHc/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.wgUxxGycai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:51:17 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 04:51:17 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 04:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:17 INFO - 'HOME': '/Users/cltbld', 04:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:17 INFO - 'LOGNAME': 'cltbld', 04:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:17 INFO - 'MOZ_NO_REMOTE': '1', 04:51:17 INFO - 'NO_EM_RESTART': '1', 04:51:17 INFO - 'PAGER': '/bin/cat', 04:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:17 INFO - 'PWD': '/builds/slave/test', 04:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:17 INFO - 'SHELL': '/bin/bash', 04:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:51:17 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:17 INFO - 'USER': 'cltbld', 04:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:17 INFO - 'XPC_FLAGS': '0x0', 04:51:17 INFO - 'XPC_SERVICE_NAME': '0', 04:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:17 INFO - Downloading/unpacking psutil>=3.1.1 04:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:21 INFO - Installing collected packages: psutil 04:51:21 INFO - Running setup.py install for psutil 04:51:21 INFO - building 'psutil._psutil_osx' extension 04:51:21 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 04:51:21 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 04:51:22 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 04:51:22 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 04:51:22 INFO - building 'psutil._psutil_posix' extension 04:51:22 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 04:51:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:51:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:51:22 INFO - ^ 04:51:22 INFO - 1 warning generated. 04:51:22 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 04:51:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:22 INFO - Successfully installed psutil 04:51:22 INFO - Cleaning up... 04:51:22 INFO - Return code: 0 04:51:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:51:22 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')]} 04:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:22 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')]} 04:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:23 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 0x107372b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107375768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa55b567d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, '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.hVEn8GRbHc/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.wgUxxGycai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:51:23 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 04:51:23 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 04:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:23 INFO - 'HOME': '/Users/cltbld', 04:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:23 INFO - 'LOGNAME': 'cltbld', 04:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:23 INFO - 'MOZ_NO_REMOTE': '1', 04:51:23 INFO - 'NO_EM_RESTART': '1', 04:51:23 INFO - 'PAGER': '/bin/cat', 04:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:23 INFO - 'PWD': '/builds/slave/test', 04:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:23 INFO - 'SHELL': '/bin/bash', 04:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:51:23 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:23 INFO - 'USER': 'cltbld', 04:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:23 INFO - 'XPC_FLAGS': '0x0', 04:51:23 INFO - 'XPC_SERVICE_NAME': '0', 04:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:51:23 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 04:51:23 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 04:51:23 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 04:51:23 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 04:51:23 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 04:51:23 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 04:51:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:51:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:51:26 INFO - Installing collected packages: mozsystemmonitor 04:51:26 INFO - Running setup.py install for mozsystemmonitor 04:51:26 INFO - Successfully installed mozsystemmonitor 04:51:26 INFO - Cleaning up... 04:51:26 INFO - Return code: 0 04:51:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107372b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107375768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa55b567d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, '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.hVEn8GRbHc/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.wgUxxGycai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:26 INFO - 'HOME': '/Users/cltbld', 04:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:26 INFO - 'LOGNAME': 'cltbld', 04:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:26 INFO - 'MOZ_NO_REMOTE': '1', 04:51:26 INFO - 'NO_EM_RESTART': '1', 04:51:26 INFO - 'PAGER': '/bin/cat', 04:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:26 INFO - 'PWD': '/builds/slave/test', 04:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:26 INFO - 'SHELL': '/bin/bash', 04:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:51:26 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:26 INFO - 'USER': 'cltbld', 04:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:26 INFO - 'XPC_FLAGS': '0x0', 04:51:26 INFO - 'XPC_SERVICE_NAME': '0', 04:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:26 INFO - Downloading/unpacking jsonschema==2.5.1 04:51:26 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 04:51:26 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 04:51:26 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 04:51:26 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 04:51:26 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 04:51:26 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 04:51:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:51:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:51:29 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 04:51:29 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 04:51:29 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 04:51:29 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 04:51:29 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 04:51:29 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 04:51:29 INFO - Downloading functools32-3.2.3-2.tar.gz 04:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:51:29 INFO - warning: no files found matching '*.txt' 04:51:29 INFO - no previously-included directories found matching 'build' 04:51:29 INFO - no previously-included directories found matching 'dist' 04:51:29 INFO - no previously-included directories found matching '.git*' 04:51:29 INFO - Installing collected packages: jsonschema, functools32 04:51:29 INFO - Running setup.py install for functools32 04:51:30 INFO - warning: no files found matching '*.txt' 04:51:30 INFO - no previously-included directories found matching 'build' 04:51:30 INFO - no previously-included directories found matching 'dist' 04:51:30 INFO - no previously-included directories found matching '.git*' 04:51:30 INFO - Successfully installed jsonschema functools32 04:51:30 INFO - Cleaning up... 04:51:30 INFO - Return code: 0 04:51:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:51:30 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')]} 04:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:30 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')]} 04:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:30 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 0x107372b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107375768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa55b567d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, '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.hVEn8GRbHc/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.wgUxxGycai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:51:30 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 04:51:30 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 04:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:30 INFO - 'HOME': '/Users/cltbld', 04:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:30 INFO - 'LOGNAME': 'cltbld', 04:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:30 INFO - 'MOZ_NO_REMOTE': '1', 04:51:30 INFO - 'NO_EM_RESTART': '1', 04:51:30 INFO - 'PAGER': '/bin/cat', 04:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:30 INFO - 'PWD': '/builds/slave/test', 04:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:30 INFO - 'SHELL': '/bin/bash', 04:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:51:30 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:30 INFO - 'USER': 'cltbld', 04:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:30 INFO - 'XPC_FLAGS': '0x0', 04:51:30 INFO - 'XPC_SERVICE_NAME': '0', 04:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:51:30 INFO - Cleaning up... 04:51:30 INFO - Return code: 0 04:51:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:51:30 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')]} 04:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:30 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')]} 04:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:30 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 0x107372b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107375768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa55b567d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, '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.hVEn8GRbHc/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.wgUxxGycai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:51:30 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 04:51:30 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 04:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:30 INFO - 'HOME': '/Users/cltbld', 04:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:30 INFO - 'LOGNAME': 'cltbld', 04:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:30 INFO - 'MOZ_NO_REMOTE': '1', 04:51:30 INFO - 'NO_EM_RESTART': '1', 04:51:30 INFO - 'PAGER': '/bin/cat', 04:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:30 INFO - 'PWD': '/builds/slave/test', 04:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:30 INFO - 'SHELL': '/bin/bash', 04:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:51:30 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:30 INFO - 'USER': 'cltbld', 04:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:30 INFO - 'XPC_FLAGS': '0x0', 04:51:30 INFO - 'XPC_SERVICE_NAME': '0', 04:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:30 INFO - Downloading/unpacking blobuploader==1.2.4 04:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:51:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:51:33 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 04:51:33 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 04:51:33 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 04:51:33 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 04:51:33 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 04:51:33 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 04:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:51:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:34 INFO - Downloading docopt-0.6.1.tar.gz 04:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:51:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:51:34 INFO - Running setup.py install for blobuploader 04:51:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:51:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:51:34 INFO - Running setup.py install for requests 04:51:35 INFO - Running setup.py install for docopt 04:51:35 INFO - Successfully installed blobuploader requests docopt 04:51:35 INFO - Cleaning up... 04:51:35 INFO - Return code: 0 04:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:35 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')]} 04:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:35 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')]} 04:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:35 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 0x107372b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107375768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa55b567d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, '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.hVEn8GRbHc/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.wgUxxGycai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:51:35 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 04:51:35 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 04:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:35 INFO - 'HOME': '/Users/cltbld', 04:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:35 INFO - 'LOGNAME': 'cltbld', 04:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:35 INFO - 'MOZ_NO_REMOTE': '1', 04:51:35 INFO - 'NO_EM_RESTART': '1', 04:51:35 INFO - 'PAGER': '/bin/cat', 04:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:35 INFO - 'PWD': '/builds/slave/test', 04:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:35 INFO - 'SHELL': '/bin/bash', 04:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:51:35 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:35 INFO - 'USER': 'cltbld', 04:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:35 INFO - 'XPC_FLAGS': '0x0', 04:51:35 INFO - 'XPC_SERVICE_NAME': '0', 04:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:35 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-UTqIdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:35 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-OaIFAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:36 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-hqgEOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:36 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Aci1pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:36 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-0wShY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:36 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-9INAUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:36 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-_k_6jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:36 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-79324f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:36 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-OprxPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:36 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-YIMZL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:36 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-fLv_JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:36 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-YetEU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:37 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-fVXNd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:37 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-EUwtAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:37 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-JHUqey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:37 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-RW9G2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:37 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-zXw23N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:51:37 INFO - Running setup.py install for manifestparser 04:51:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:51:37 INFO - Running setup.py install for mozcrash 04:51:37 INFO - Running setup.py install for mozdebug 04:51:38 INFO - Running setup.py install for mozdevice 04:51:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Running setup.py install for mozfile 04:51:38 INFO - Running setup.py install for mozhttpd 04:51:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Running setup.py install for mozinfo 04:51:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Running setup.py install for mozInstall 04:51:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:51:38 INFO - Running setup.py install for mozleak 04:51:38 INFO - Running setup.py install for mozlog 04:51:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Running setup.py install for moznetwork 04:51:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Running setup.py install for mozprocess 04:51:39 INFO - Running setup.py install for mozprofile 04:51:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Running setup.py install for mozrunner 04:51:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:51:39 INFO - Running setup.py install for mozscreenshot 04:51:39 INFO - Running setup.py install for moztest 04:51:40 INFO - Running setup.py install for mozversion 04:51:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:51:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:51:40 INFO - Cleaning up... 04:51:40 INFO - Return code: 0 04:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107372b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107375768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa55b567d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, '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.hVEn8GRbHc/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.wgUxxGycai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:40 INFO - 'HOME': '/Users/cltbld', 04:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:40 INFO - 'LOGNAME': 'cltbld', 04:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:40 INFO - 'MOZ_NO_REMOTE': '1', 04:51:40 INFO - 'NO_EM_RESTART': '1', 04:51:40 INFO - 'PAGER': '/bin/cat', 04:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:40 INFO - 'PWD': '/builds/slave/test', 04:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:40 INFO - 'SHELL': '/bin/bash', 04:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:51:40 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:40 INFO - 'USER': 'cltbld', 04:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:40 INFO - 'XPC_FLAGS': '0x0', 04:51:40 INFO - 'XPC_SERVICE_NAME': '0', 04:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:40 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-lurvKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:40 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)) 04:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:40 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-iKvdJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:40 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-hNp_4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:40 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)) 04:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:40 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-fBZhnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:40 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-LwRqU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:40 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)) 04:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:40 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-MQXljF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:41 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-NXzQYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:41 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-MWp0qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:41 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)) 04:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:41 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-tQoC0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:41 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)) 04:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:41 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-WNGOV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:41 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-UFVbHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:41 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)) 04:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:41 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-VmDlCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:41 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Yx_0i7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:41 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)) 04:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:41 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-lkUyjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:41 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-UHKccq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:42 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-2Ito3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:42 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Ng0Clu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:42 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)) 04:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:51:42 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)) 04:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:51:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:51:42 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 04:51:42 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 04:51:42 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 04:51:42 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 04:51:42 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 04:51:42 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 04:51:44 INFO - Downloading blessings-1.6.tar.gz 04:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:51:45 INFO - Installing collected packages: blessings 04:51:45 INFO - Running setup.py install for blessings 04:51:45 INFO - Successfully installed blessings 04:51:45 INFO - Cleaning up... 04:51:45 INFO - Return code: 0 04:51:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:45 INFO - Reading from file tmpfile_stdout 04:51:45 INFO - Current package versions: 04:51:45 INFO - blessings == 1.6 04:51:45 INFO - blobuploader == 1.2.4 04:51:45 INFO - docopt == 0.6.1 04:51:45 INFO - functools32 == 3.2.3-2 04:51:45 INFO - jsonschema == 2.5.1 04:51:45 INFO - manifestparser == 1.1 04:51:45 INFO - mozInstall == 1.12 04:51:45 INFO - mozcrash == 1.0 04:51:45 INFO - mozdebug == 0.1 04:51:45 INFO - mozdevice == 0.49 04:51:45 INFO - mozfile == 1.2 04:51:45 INFO - mozhttpd == 0.7 04:51:45 INFO - mozinfo == 0.9 04:51:45 INFO - mozleak == 0.1 04:51:45 INFO - mozlog == 3.4 04:51:45 INFO - moznetwork == 0.27 04:51:45 INFO - mozprocess == 0.24 04:51:45 INFO - mozprofile == 0.28 04:51:45 INFO - mozrunner == 6.13 04:51:45 INFO - mozscreenshot == 0.1 04:51:45 INFO - mozsystemmonitor == 0.3 04:51:45 INFO - moztest == 0.8 04:51:45 INFO - mozversion == 1.4 04:51:45 INFO - psutil == 3.1.1 04:51:45 INFO - requests == 1.2.3 04:51:45 INFO - wsgiref == 0.1.2 04:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:45 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')]} 04:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:45 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')]} 04:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:45 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 0x107372b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107375768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa55b567d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, '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.hVEn8GRbHc/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.wgUxxGycai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:51:45 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 04:51:45 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 04:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:45 INFO - 'HOME': '/Users/cltbld', 04:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:45 INFO - 'LOGNAME': 'cltbld', 04:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:45 INFO - 'MOZ_NO_REMOTE': '1', 04:51:45 INFO - 'NO_EM_RESTART': '1', 04:51:45 INFO - 'PAGER': '/bin/cat', 04:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:45 INFO - 'PWD': '/builds/slave/test', 04:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:45 INFO - 'SHELL': '/bin/bash', 04:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:51:45 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:45 INFO - 'USER': 'cltbld', 04:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:45 INFO - 'XPC_FLAGS': '0x0', 04:51:45 INFO - 'XPC_SERVICE_NAME': '0', 04:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:45 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)) 04:51:45 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)) 04:51:45 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)) 04:51:45 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)) 04:51:45 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)) 04:51:45 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)) 04:51:45 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)) 04:51:45 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)) 04:51:45 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)) 04:51:45 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)) 04:51:45 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)) 04:51:45 INFO - Cleaning up... 04:51:45 INFO - Return code: 0 04:51:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:51:45 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')]} 04:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:45 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')]} 04:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:45 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 0x107372b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107375768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa55b567d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, '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.hVEn8GRbHc/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.wgUxxGycai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 04:51:45 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 04:51:45 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 04:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:45 INFO - 'HOME': '/Users/cltbld', 04:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:45 INFO - 'LOGNAME': 'cltbld', 04:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:45 INFO - 'MOZ_NO_REMOTE': '1', 04:51:45 INFO - 'NO_EM_RESTART': '1', 04:51:45 INFO - 'PAGER': '/bin/cat', 04:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:45 INFO - 'PWD': '/builds/slave/test', 04:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:45 INFO - 'SHELL': '/bin/bash', 04:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:51:45 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:45 INFO - 'USER': 'cltbld', 04:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:45 INFO - 'XPC_FLAGS': '0x0', 04:51:45 INFO - 'XPC_SERVICE_NAME': '0', 04:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:51:46 INFO - Cleaning up... 04:51:46 INFO - Return code: 0 04:51:46 INFO - Running post-action listener: _resource_record_post_action 04:51:46 INFO - Running post-action listener: _start_resource_monitoring 04:51:46 INFO - Starting resource monitoring. 04:51:46 INFO - [mozharness: 2017-02-10 12:51:46.199475Z] Finished create-virtualenv step (success) 04:51:46 INFO - [mozharness: 2017-02-10 12:51:46.200484Z] Running install step. 04:51:46 INFO - Running pre-action listener: _resource_record_pre_action 04:51:46 INFO - Running main action method: install 04:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:46 INFO - Reading from file tmpfile_stdout 04:51:46 INFO - Detecting whether we're running mozinstall >=1.0... 04:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:51:46 INFO - Reading from file tmpfile_stdout 04:51:46 INFO - Output received: 04:51:46 INFO - Usage: mozinstall [options] installer 04:51:46 INFO - Options: 04:51:46 INFO - -h, --help show this help message and exit 04:51:46 INFO - -d DEST, --destination=DEST 04:51:46 INFO - Directory to install application into. [default: 04:51:46 INFO - "/builds/slave/test"] 04:51:46 INFO - --app=APP Application being installed. [default: firefox] 04:51:46 INFO - mkdir: /builds/slave/test/build/application 04:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 04:52:06 INFO - Reading from file tmpfile_stdout 04:52:06 INFO - Output received: 04:52:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:52:06 INFO - Running post-action listener: _resource_record_post_action 04:52:06 INFO - [mozharness: 2017-02-10 12:52:06.393011Z] Finished install step (success) 04:52:06 INFO - [mozharness: 2017-02-10 12:52:06.393184Z] Running run-tests step. 04:52:06 INFO - Running pre-action listener: _resource_record_pre_action 04:52:06 INFO - Running main action method: run_tests 04:52:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:06 INFO - 2017-02-10 04:52:06.407 screenresolution[1898:17183] starting screenresolution argv=screenresolution get 04:52:06 INFO - 2017-02-10 04:52:06.410 screenresolution[1898:17183] Display 0: 1600x1200x32@60 04:52:06 INFO - 2017-02-10 04:52:06.416 screenresolution[1899:17186] starting screenresolution argv=screenresolution list 04:52:06 INFO - Available Modes on Display 0 04:52:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:06 INFO - Intel Iris: 04:52:06 INFO - Chipset Model: Intel Iris 04:52:06 INFO - Type: GPU 04:52:06 INFO - Bus: Built-In 04:52:06 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:06 INFO - Vendor: Intel (0x8086) 04:52:06 INFO - Device ID: 0x0a2e 04:52:06 INFO - Revision ID: 0x0009 04:52:06 INFO - Displays: 04:52:06 INFO - Display: 04:52:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:06 INFO - Display Serial Number: 1600x1200 60 04:52:06 INFO - Main Display: Yes 04:52:06 INFO - Mirror: Off 04:52:06 INFO - Online: Yes 04:52:06 INFO - Rotation: Supported 04:52:06 INFO - Return code: 0 04:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:06 INFO - Python 2.7.3 04:52:06 INFO - Return code: 0 04:52:06 INFO - grabbing minidump binary from tooltool 04:52: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')]} 04:52:06 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 0x107150d30>, '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 0x107077db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107145be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:06 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 04:52:06 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 04:52:06 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 04:52:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:06 INFO - Return code: 0 04:52:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:52:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:52:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0387 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:52:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hVEn8GRbHc/Render', 04:52:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:06 INFO - 'HOME': '/Users/cltbld', 04:52:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:06 INFO - 'LOGNAME': 'cltbld', 04:52:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:06 INFO - 'MOZ_NO_REMOTE': '1', 04:52:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:06 INFO - 'NO_EM_RESTART': '1', 04:52:06 INFO - 'PAGER': '/bin/cat', 04:52:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:06 INFO - 'PWD': '/builds/slave/test', 04:52:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:06 INFO - 'SHELL': '/bin/bash', 04:52:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wgUxxGycai/Listeners', 04:52:06 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 04:52:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:06 INFO - 'USER': 'cltbld', 04:52:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:06 INFO - 'XPC_FLAGS': '0x0', 04:52:06 INFO - 'XPC_SERVICE_NAME': '0', 04:52:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:52:07 INFO - mozversion application_buildid: 20170210033723 04:52:07 INFO - mozversion application_changeset: 9a08294a8eb8cea3683c6355decebce1d1876fa1 04:52:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:52:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:07 INFO - mozversion application_name: Firefox 04:52:07 INFO - mozversion application_remotingname: firefox-dev 04:52:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:52:07 INFO - mozversion application_vendor: Mozilla 04:52:07 INFO - mozversion application_version: 53.0a2 04:52:07 INFO - mozversion platform_buildid: 20170210033723 04:52:07 INFO - mozversion platform_changeset: 9a08294a8eb8cea3683c6355decebce1d1876fa1 04:52:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:52:07 INFO - mozversion platform_version: 53.0a2 04:52:07 INFO - using testdate: 1486731127 04:52:07 INFO - actual date: 1486731127 04:52:07 INFO - starting webserver on 'localhost:54077' 04:52:07 INFO - SUITE-START | Running 2 tests 04:52:07 INFO - TEST-START | dromaeo_css 04:52:07 INFO - operating with platform_type : mac_ 04:52:07 INFO - Initialising browser for dromaeo_css test... 04:52:07 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpSPkEAM/profile http://localhost:54077/getInfo.html) 04:52:09 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 04:52:09 INFO - PROCESS | 1909 | colorDepth:24 04:52:09 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 04:52:09 INFO - PROCESS | 1909 | __metrics 04:52:09 INFO - PROCESS | 1909 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:52:09 INFO - PROCESS | 1909 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:52:10 INFO - TEST-INFO | 1909: exit 0 04:52:10 INFO - Browser initialized. 04:52:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:52:10 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpSPkEAM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:22 INFO - PROCESS | 1911 | RSS: Main: 213057536 04:52:22 INFO - PROCESS | 1911 | 04:55:26 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54077/tests/dromaeo/cssquery-ext.html) 04:55:28 INFO - PROCESS | 1911 | RSS: Main: 386568192 04:55:28 INFO - PROCESS | 1911 | 04:57:12 INFO - PROCESS | 1911 | ************************* 04:57:12 INFO - PROCESS | 1911 | A coding exception was thrown and uncaught in a Task. 04:57:12 INFO - PROCESS | 1911 | 04:57:12 ERROR - PROCESS | 1911 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:57:12 INFO - PROCESS | 1911 | Full stack: 04:57:12 INFO - PROCESS | 1911 | ************************* 04:58:31 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-ext.html (next: http://localhost:54077/tests/dromaeo/cssquery-jquery.html) 04:58:31 INFO - PROCESS | 1911 | RSS: Main: 350543872 04:58:31 INFO - PROCESS | 1911 | 05:01:34 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54077/tests/dromaeo/cssquery-mootools.html) 05:01:34 INFO - PROCESS | 1911 | RSS: Main: 349159424 05:01:34 INFO - PROCESS | 1911 | 05:04:37 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54077/tests/dromaeo/cssquery-prototype.html) 05:04:37 INFO - PROCESS | 1911 | RSS: Main: 320290816 05:04:37 INFO - PROCESS | 1911 | 05:07:41 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54077/tests/dromaeo/cssquery-yui.html) 05:07:41 INFO - PROCESS | 1911 | RSS: Main: 312434688 05:07:41 INFO - PROCESS | 1911 | 05:10:44 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-yui.html (next: http://localhost:54077/tests/dromaeo/cssquery-dojo.html) 05:10:45 INFO - PROCESS | 1911 | RSS: Main: 441036800 05:10:45 INFO - PROCESS | 1911 | 05:10:45 INFO - PROCESS | 1911 | __start_tp_report 05:10:45 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 05:10:45 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 05:10:45 INFO - PROCESS | 1911 | |i|pagename|runs| 05:10:45 INFO - PROCESS | 1911 | |0;dojo.html;3325.7339412846973;3363.865445382183;3376.1897144685254;3378.206121561433;3397.303552771682;5698.25922630058;5730.656160630365;5738.483536481715;5742.2247996520455;5755.6546607203545;5678.943210567893;5710.2862142232225;5754.683492407927;5770.422957704228;5774.2782152230975;5229.869253268661;5262.500062494076;5266.210068489729;5274.077036518613;5310.92033619496;5188.403333616645;5191.195364718475;5198.2722418861385;5319.148936170213;5324.387695415019;5291.708956007418;5303.522682958533;5315.14957606783;5318.468153184689;5332.546733527654;5205.167173252262;5254.500822421864;5271.5782737381305;5323.494268044549;5334.466553344654;5196.45437229093;5263.26314315996;5277.076511610453;5278.1291086970605;5314.468553144693;5762;5841.941580584183;5882.735276912506;5883.588148829584;5891;6120.883718150473;6172.012478003498;6186.350433204539;6236;6322.873542529123;4584.564466375689;6184.56708030438;6259.937400625981;6276.184096067527;6284.811455656338;4888.462269150462;5848.356680765112;5882.205902203191;5892.057270836645;5892.234009578728;6278.6546739929745;6281.403266689657;6285.465735412449;6287.937120628827;6296.087067375205;6020.789272375446;6032.879342413127;6069.332373438918;6245.6252624842655;6258.155149054819;6215;6226.315105338409;6245.875082498324;6261.96869015652;6282.685865706696;6230.501559875199;6281.905771413432;6304.148939893147;6310.652914089769;6311.558190926683;6275.090111933744;6277.121203031579;6289.371062893674;6291.087792270096;6297.055441683692;4889.902201955941;4937.136001199776;4946.727929963815;4957.504249575014;4983.90032199354;4468.910621787546;4476.283794592915;4483.2602620567895;4489.6408287336935;4502.639788816887;5887.793927212527;5887.970560147258;5895.528357731371;5904.7342869570975;5910.083936989773;6118.80192544137;6209.130721698965;6214.937850621526;6236;6271.498280137578;5824.242848429677;5861.208736820475;5949.2266005419015;5959.880802383928;5974.820755377345;4562.771861406916;5420.4850539198715;5433.755481003364;5440.075187218183;5510.752016159283;6262.5929314594405;6315.463185629089;6327.272363678144;6329.651869147241;6346.238451385863;6171.413715697002;6190.7523699051535;6227.844303892439;6313.6843157841;6326.905096423649;6205.596636218631;6217.658028808459;6236.251649802053;6311.053341998737;6341.397567231105;6230.408111229426;6239.06414037898;6255.843603909939;6282.1519094921605;6293.937060629518;5525.972370138124;6087.939120608914;6289.96855015722;6292;6304.65324407162;6032.155498230339;6082.2701275847185;6111.54163437735;6114.57197996136;6180.320164781961;6140.754369825157;6141.263048434216;6146.385361463817;6154.599951003171;6154.907676384768;5925.733341999707;5974.984252676968;5995.820125396245;6019.398060193946;6022.126791615279;6036.486898613667;6103.267607887082;6118.143459915526;6118.143459915705;6161.537884658579;6042.093685947143;6068.878622427438;6092.421219984094;6105.206323177958;6129.233845769279 05:10:45 INFO - PROCESS | 1911 | |1;ext.html;490.3380436410846;492.6896055485044;499.99999999999994;507.41647105828304;511.57539242428766;29641;38870.61129388705;41276.38085428721;41431.378529322006;41653.58346416542;41799.79100104495;42112.15775684485;42241.15517689644;42262;42305;9108.59011344491;9311.95344023279;9323.254139668845;9344.065593440635;9346.906530934706;8195.508269503849;8388.454750441233;10928.180386471047;11169.497372618252;11183.83224251637;11096.278741881792;11171.045067113264;11180.66458006257;11185.105191584695;11203.719907002349;8179.345652347798;11059.004689577936;11142.610008649659;11164.162687798447;11169.385683787428;8301.626426810808;10772.515236814363;11034.006939375495;11042.613508527244;11218.990290873779;33154.668453315644;39767.20465590701;39977;40612.984675383355;40685.79657101725;3946.842126314944;3948.4274780157;3965.1474932889278;3969.6282143141284;3993.0616305168264;28528.28679283014;29081.09189081096;30210.54684179739;31086.22284442907;31333.37333253322;3023.4557779599663;3183.8248896310693;3274.590676165479;3329.3840639481773;3335.5997280326274;497982;498418;498658;499577.9999999964;499931;59759.10361344583;60150.699246503485;60158;60175.09737353943;60282.69858650678;62365.064524032176;63184;63310;63344.36655633477;63386.6830665853;16361.590960226089;16588.50234492967;16595.6680866382;16612.83387166137;16621.335146594;9647;11818.822717659243;12961;13062.150960187557;13083.869161308456;13642.931785341209;15314.463993760164;15401.614959625875;15621.843781562038;15793.052416855026;6485.902711459332;6516.283208847023;6528.1187039749975;6559.934400656028;6582.407583317525;801.8757092650649;878.1876763993281;878.4992554244147;890.7060669978891;893.9776505587413;24576.87711561431;27129.593056104175;29676.951430942016;29815.956441524875;29995.250118746768;1076.5155679944057;1077.235163034239;1081.2431298091367;1109.450821843193;1213.0719999200442;14903.552893413214;15085.622859428382;15173.393064277527;15322;15414.537563873102;628722.8563857243;635044;635345.8232708807;636113;636672;58479.70760146257;58644;58674;58732.30141588663;58873.82252354929;1247.214255019332;1440.279860069965;1448.6450819549277;1464.3410465290874;1467.325030485967;28477.145685629464;29168.7083129166;29218.415631687672;29242.976495822542;29863.402731945673;48474.75762621164;48797.512024880714;48811.779705506226;48899.755501222266;49104.508954909994;519666;520828;523641;524429;525169;31740.523892141173;37276.44085338668;38463.03842403962;38887.6111238884;39056.41415378828;44376.77811610921;46268.537314626425;46821.765891170326;47297;47299.763501183654;37524.6247537532;37533.49598048143;37924;38256.426153607164;40023.599764001985;37400.06499837526;37525;37643.43534846925;38464.423033655075;38470.80764596159;31394.68605314009;31464.37071258608;31553.21116972094;31584.894528691384;31643.050708478782;31151.376972460876;33101.503477447375;33890.32219355649;33976.98069057932;34043;19584.80415195887;22020.33938981833;22415.313560292663;22913.427164321027;24952 05:10:45 INFO - PROCESS | 1911 | |2;jquery.html;387.4865802811276;388.84706844206954;392.88802691233;393.71455694621386;429.7185343599941;13557.728845423086;17843.910780446095;21157.57684846302;21210.151593936225;21243.57512849742;21378.46553836155;21448.356549303506;21827.454313642167;22165.22421715236;22293.55412891745;5049.419316778581;5518.696471694056;5836.124581312794;5849.005669036253;5849.093390524455;4131.772752498611;4244.808983595745;5790.044642633981;5812.564057695668;6263.874722505547;6463.062855885893;6545.639989800559;6568.704408301638;6571.835704107411;6577;6331.2719037310835;6413.358664133572;6479.967600161969;6491.93508064918;6491.967540162316;5540.972295138539;5563.833085007456;5567.4432556744405;5619.494245517923;5669.121286200645;21703.782962170335;26905.0583229586;26937.46125077507;27278;27312.180634580993;2758.475889580993;2758.613794068832;2759.296379423254;2761.654793150856;2781.3741908070724;10242;10353.689389318333;13010.349482525931;13209.603711888658;14090.577282681536;1838.6506563752844;1841.7421560981472;1936.5836345185853;1960.3824795189612;1961.9313324033733;147412;152053;152230.47769522385;152581.2676859077;153765.23117384454;11824.822627660593;11867.465964031639;11981.963066278753;11999.64001079969;12013.459394327276;13733.656658583415;14262.928685356714;15227.390904363701;15582.987105838085;15648.92175539115;8076.798080047928;8208.302294305051;8499.362547808816;8603.397762156588;8637.654493820302;8429.662813487514;8435.451695639764;8475.703350382708;8546.658133674584;8561.871571926426;4473.613179914237;4656.3713898623255;4741.881452963704;4770.475247722748;4895.681780684244;1817;1954.1240409207037;1989.3634037108277;2041.3161590866928;2110.1559376249315;940.2149205413556;1012.6202673997251;1012.6911292055994;1023.8566600675912;1038.99480502597;21203.68194477084;22120.446988825086;22125.225617103326;22218.44453888666;22252.888735556542;1025.4411345816548;1039.896010398969;1046.984295235572;1065.1053115383115;1065.8507808906759;10640.04239618438;11398.373089480157;11496.712582185344;11499.482523286471;11555.959963603316;718627;741200;741775;744349;773714;151155;154810.45189548185;159779;163022;165239;968.4237878462303;969.9418034917927;973.3770386952356;997.9051990061078;1001.2690735762934;15671.529854104396;17944.013079280765;18695.719564206818;18969.33607323737;19358.516037099183;55735.44264557303;57066.85866282734;58165.70917145387;58299;58480;81469;83130.58434707788;84068.15931840848;84227.15772842194;84659.5767021161;6988.825279368057;7117.75087871922;7483.513571617827;7610.885836712343;8346.707865224687;10629.267392508003;12812.103152779217;13229.933850330686;13414.664633384244;13671.453141874214;11162.944185279022;11231.101511878867;11319.886801131883;11357.716057098638;11581.24721893108;10011.899881001387;11207.495662695035;11367;11610.6516804496;11730.589429369931;11563.768724625628;11566;11973.10201734856;12058;12130.393480325773;7506.474546781673;7531.774046778605;7604.391648668204;7753.65108570127;7826.647800849089;10859.565617375532;11262.211645185087;11426.228934515164;11704.122190835891;11870.109741769229 05:10:45 INFO - PROCESS | 1911 | |3;mootools.html;1426.9286535673214;1441.4234306277488;1447.8407375188733;1450.8113945187124;1453.186215719197;8135.145809689986;8547.914520854789;8551.78620534487;8574.314054875611;8578.613962371692;7441.479096463249;7682.6542805573745;7684;8040.31657309128;8369.874451883226;2266.5240299537077;2306.7808558186944;2344.1678204237505;2346.6480027995767;2347.366211122996;2339.5671800716923;2361.89371478283;2369.7393286738443;2382.6068698664785;2383.7497062808416;2041.1631231195213;2117.280124757582;2244.2033078257227;2315.050829160045;2322.756110608387;1961.8234358907696;2340.2745149003695;2340.461693810416;2342.10999820069;2342.7305859825997;2268.387535365442;2318.8144948404256;2323.4423738302853;2341.309313752447;2345.753695861944;8434.578271086482;8538;8539.146085391474;8548.57257137147;8566.357523185787;5083.364579427572;5227.921581176285;5230.189320655304;5239.187925871496;5247.2653828464045;3229.515572664119;3414.351273258098;3493.8951831445097;3496.527968724215;3501.1772233525103;1124.4658787076073;1192.7793358228669;1212.030375699437;1216.385725208764;1238.8203710461933;10243.948780256125;10835.891641083646;11020.834687479693;11092.667219983414;11109.888901111048;4048.5344185419053;4198.5591512890705;4510.120526497367;4571.9314210286875;4580.198465268565;8854.86717699235;8860.202581767671;8860.468371897707;8872.93524777018;8877.600507977157;5092.083424983464;5096.541311282002;5170.224466330005;5176.5858731301405;5181.4041385240425;4646.953530464652;4833.927491087637;4842.297866809293;4869.537393947569;4896.677896967799;3669.1377526281303;3728.366177749789;3749.4000959846294;3796;3824.972764434854;1150.3558007515817;1158.29922896648;1161.2393882007298;1171.9941400292944;1173.1084375874398;767.5586537740821;775.6936010276022;798.4091772088728;801.3669201330883;803.3733687723585;4514.70654407469;5391.946080539223;5562.9986602411955;5664.291963504562;5668.234788303609;543.1499702964848;547.4580165636071;564.9717514124277;574.9367569567344;580.196427947296;3563.9329586710887;3746.7377283589885;3755.3615885299564;3756.7039371416818;3777.4522694209186;9932.652357167464;10125.696229113139;10321.380717156844;10333.173346132291;10358.482075896174;10242.743931401625;10269.845952310721;10270.845937310947;10277.588896444058;10292.433916134685;7689.154193038761;7889.487183333065;7901.446898717035;8082;8090.635921383552;5356.250124982584;5427.375851777097;5465.508104270635;5562.082256427806;5634.295713035871;9174.577940419245;9196.26429885621;9242.168204861326;9383.671571494964;9403.01268366839;8500.829983400421;8671.609777560152;8976.237019853386;9282.489463079326;9352.766180845534;7066.116735408074;7351.889721654286;7357.153927298429;7365.558066516026;7395;7635.923640763522;7931.286184243446;8007.83984320322;8115.83768324642;8121.066077401175;7042.014118023379;7126.964365178141;7177.641117943977;7212.74755383559;7328.193898671036;7008.684609192496;7054.365107140382;7056.294370563108;7058.306006558491;7079.716811327695;6386.680665966776;6410.903836442364;6418;6421.518386120966;6487.481001519962;4283.507396649301;4883.243097319921;4981;5035.823746168867;5054.545090941833;4754;5011.774470148925;5021.698698078127;5090.974545127251;5143.202803565453 05:10:45 INFO - PROCESS | 1911 | |4;prototype.html;357.5798436836717;364.80665247418875;368.6810908564092;379.5881468606562;380.78295371638177;4230.534641189467;5015.473375295596;5227.353383684142;5246.580273578114;5295.655782374148;4236.555161708023;4296.763677997709;5056.469070747574;5120.359955005624;5125.410577783547;4044.939325910099;4051.149258655686;4069.351912475452;4069.8779036628875;4076.7757773322455;3397.1442412861456;3773.5094437723055;3896.9346246489263;4060.817263223147;4111.506619205699;3334.266181585574;3989;4031.052702614883;4043;4092.386142078682;3995.6603688686496;4033.97983010086;4038.9192216155807;4046.9967366153796;4052.2908491013955;3135.278885856266;3491.5635545556806;3564.429691249388;3587.892363229107;3602.3335682898746;4281.593248641405;5032.144535428986;5059.406287019577;5136.508793235278;5155.922661160085;4271.444712187426;4280.850170244058;4450.688451808374;4671.065786842645;4701.48283688794;4611.608013318838;4828.686135401188;5452.864602853375;5459.481349271813;5480.205370221295;3484.63411341808;3504.7721898076543;3570.696490798285;3960.3069462843887;3995.380715989026;4983.878627308863;5581.469760372758;5759.913601295984;5778.566607504454;5784.190213370173;3811.6468653628117;3831.1571454280015;3842.8270727816757;3847.3074846527893;3893.53277606689;3714.591394946554;3847.5960024197057;3863.9227215455535;3872.7482713623526;3874.5156855393075;3867.903302417462;4365.541618130114;4444.911101777946;4467.642588592905;4480.843170489083;4514.322851572225;5507.834764956978;5513.862153446196;5529.447055294519;5540.722963851791;1050.2490719135856;1202.4949521201117;1225.9640603689868;1234.2409418207917;1260.9495620175273;763.1605234242289;832.8375966686559;841.5035129273635;850.7918755367393;853.8206976534997;4579.740841017819;4841.588464980446;4880.341153944172;4881.780319885614;4905.9754701226975;4972.975135124374;5213.905079933256;5365.6244062916;5407.945920540823;5427.945720542744;4509.301058335963;4703.64722645803;4808.8797780055775;4824.396950381202;4866.245731911559;2485.2792690119663;2580.2904201344404;2685.462907418524;2772.057500449857;2793.3296008957705;5272.340957380327;5354.812581559627;5493.862653433696;5498.1752737088955;5532;4435.6229720473475;5330.227117068003;5349.893002140013;5399.865003374868;5437.728113594384;5456.399796022434;5476.32971943561;5528.585356098309;5537.944620553823;5563.554915606661;4456.395697548945;5047.87380315495;5323.893522129613;5329.7068661224;5367.409584945731;4723.976380118077;5092.388913330424;5113.15632920564;5247.842564722911;5265.183896496049;4809.95190048109;4968.540572416677;5015.695919060998;5129.897402052013;5496.945030549643;3426.4003799335514;3573.5890372607482;3590.425531914881;3593.964060359363;3647.9817600911824;4883.633727470383;4896.583790377857;5123.386133367977;5296.569926120003;5328.547073498796;5121.795128194831;5149.9227511586605;5150.6137039721425;5178.482151784791;5251.317328747238;4811.65273723358;5095.757866538711;5120.974395128001;5123.769430375568;5153.418374230024;4839.782209800497;5018.322526458881;5080.618953578422;5266.709656134271;5313;4260.680448966402;4950.331705219894;5520.176214094169;5531.917021244765;5547.334319881478;4478.843240486567;5294.444083371191;5393.757280922289;5398.2982212312145;5422.566194704335 05:10:45 INFO - PROCESS | 1911 | |5;yui.html;706.3360441185285;774.5778550689873;786.6695987685173;828.9502629842207;835.7158566087531;15180.544583662493;15825.446109386145;15841.445549405773;15858.841411585896;15875.682486350295;14382.065165764217;14489.347979340928;14543.418263269457;14548.781768273484;14558.563243102697;684.6131935456451;700.7687463137153;856.9057403685605;860.1742327365737;895.1764376773384;879.6613303877989;881.5107615273521;888.9821154777776;889.5863423508067;892.6117139044504;887.0198430734043;911.7447114807832;925.7176561148847;939.6523286384047;953.3136141977765;721.4661150748461;748.6069813347981;946.3895787217241;947.8957314695378;949.3544389814923;665.0456594786497;687.9759208427681;692.9064576282187;693.2824526614929;693.6358411833777;15164.393424263017;15273.465428709942;15306.617334566614;15361.615959600987;15364.385424583003;13378.264195469244;13425;13444.663883402894;13488.5279015234;13720;10938.835917461245;12139.210951288138;12329.383530823423;12486.81269780954;12549.749005019848;4190.099128687317;4229.407882896397;4386.342048692722;4399.934000989988;4569.994601187734;100931.99068009299;101247;103029;103734.48132759363;105659;10547.894521054692;10956.890431095588;10966.506507207196;11020.889791101987;11366.602168924213;21514.354569362633;22048.228312009003;22143.782091984773;22500.32499025032;22590.88704556467;7312.341889229889;7451.478396512301;7584.2036586158765;7623.313901748869;7843.05883293997;3639.6906262967414;4161.313383291723;4233.915321693549;4327.891802704958;4372.978135109304;3437.1922598189403;3530.223350862806;3536.451849963208;3537.876174333886;3540.91147721309;612.8039027511243;624.9718762655691;639.6034458635582;640.3372509452694;643.5270076493773;570.9486146246858;578.988420231593;608.7260732670228;632.5983000794529;695.6486974078058;9721.222302215805;10220.080192782685;10336.689899303034;10522.842157367646;10592.629257975934;572.802383177803;572.8625129968777;586.9471747542742;633.7940169444856;660.957037792542;4835.395575553056;4978.427480839678;4987.526185012418;4998.900021999612;5000.62495312853;101990.49004754929;106453.4677326624;108491.45754271178;110131.44934275278;110822.44588777165;98360;98498;101731.4913425443;102627;102923.97076029144;72103.27896720966;74449.25550744531;79364.60317698374;81838;83182.58408707917;9545.856812147962;9826.5086745661;9864.408135511892;9876.061774131445;9917.256205784452;38661.61338386693;42901.570984289756;51983.74008129935;53774.73112634568;54491.72754136204;73361.6331918337;74504.62747686227;76572;77209.84185237113;79995.60002199952;11392.487338069972;11525.077993760648;11715.648530544097;11821.172517924007;11875.643730688093;11812.742762506996;12307.507699691912;12692.301923393932;12872.098953073195;13302;11028.944855275673;12184.329861857683;12506.937465312616;13523.661908452368;13689.657758556115;12559.246445213317;12832.871671283541;13628.182309061489;13815.51487687106;13822.30888455553;12604.684882877635;12959.287239201934;13440.059195856196;13568.59294221175;13603.387847547083;10834.295770774874;10993.945030274797;11086;11389.430528473378;11711.824322635337;10778.658615829117;10872.728181795519;10958.958819036476;10965;11022.118230541377 05:10:45 INFO - PROCESS | 1911 | __end_tp_report 05:10:45 INFO - PROCESS | 1911 | __start_cc_report 05:10:45 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,1790 05:10:45 INFO - PROCESS | 1911 | __end_cc_report 05:10:45 INFO - PROCESS | 1911 | __startTimestamp1486732245221__endTimestamp 05:10:45 INFO - PROCESS | 1911 | 05:10:45 INFO - PROCESS | 1911 | ------- Summary: start ------- 05:10:45 INFO - PROCESS | 1911 | Number of tests: 6 05:10:45 INFO - PROCESS | 1911 | 05:10:45 INFO - PROCESS | 1911 | [#0] dojo.html Cycles:165 Average:5770.89 Median:6022.13 stddev:646.40 (10.7%) stddev-sans-first:619.27 05:10:45 INFO - PROCESS | 1911 | Values: 3325.7 3363.9 3376.2 3378.2 3397.3 5698.3 5730.7 5738.5 5742.2 5755.7 5678.9 5710.3 5754.7 5770.4 5774.3 5229.9 5262.5 5266.2 5274.1 5310.9 5188.4 5191.2 5198.3 5319.1 5324.4 5291.7 5303.5 5315.1 5318.5 5332.5 5205.2 5254.5 5271.6 5323.5 5334.5 5196.5 5263.3 5277.1 5278.1 5314.5 5762.0 5841.9 5882.7 5883.6 5891.0 6120.9 6172.0 6186.4 6236.0 6322.9 4584.6 6184.6 6259.9 6276.2 6284.8 4888.5 5848.4 5882.2 5892.1 5892.2 6278.7 6281.4 6285.5 6287.9 6296.1 6020.8 6032.9 6069.3 6245.6 6258.2 6215.0 6226.3 6245.9 6262.0 6282.7 6230.5 6281.9 6304.1 6310.7 6311.6 6275.1 6277.1 6289.4 6291.1 6297.1 4889.9 4937.1 4946.7 4957.5 4983.9 4468.9 4476.3 4483.3 4489.6 4502.6 5887.8 5888.0 5895.5 5904.7 5910.1 6118.8 6209.1 6214.9 6236.0 6271.5 5824.2 5861.2 5949.2 5959.9 5974.8 4562.8 5420.5 5433.8 5440.1 5510.8 6262.6 6315.5 6327.3 6329.7 6346.2 6171.4 6190.8 6227.8 6313.7 6326.9 6205.6 6217.7 6236.3 6311.1 6341.4 6230.4 6239.1 6255.8 6282.2 6293.9 5526.0 6087.9 6290.0 6292.0 6304.7 6032.2 6082.3 6111.5 6114.6 6180.3 6140.8 6141.3 6146.4 6154.6 6154.9 5925.7 5975.0 5995.8 6019.4 6022.1 6036.5 6103.3 6118.1 6118.1 6161.5 6042.1 6068.9 6092.4 6105.2 6129.2 05:10:45 INFO - PROCESS | 1911 | 05:10:45 INFO - PROCESS | 1911 | [#1] ext.html Cycles:180 Average:68573.91 Median:38359.73 stddev:148235.60 (386.4%) stddev-sans-first:148563.30 05:10:45 INFO - PROCESS | 1911 | Values: 490.3 492.7 500.0 507.4 511.6 29641.0 38870.6 41276.4 41431.4 41653.6 41799.8 42112.2 42241.2 42262.0 42305.0 9108.6 9312.0 9323.3 9344.1 9346.9 8195.5 8388.5 10928.2 11169.5 11183.8 11096.3 11171.0 11180.7 11185.1 11203.7 8179.3 11059.0 11142.6 11164.2 11169.4 8301.6 10772.5 11034.0 11042.6 11219.0 33154.7 39767.2 39977.0 40613.0 40685.8 3946.8 3948.4 3965.1 3969.6 3993.1 28528.3 29081.1 30210.5 31086.2 31333.4 3023.5 3183.8 3274.6 3329.4 3335.6 497982.0 498418.0 498658.0 499578.0 499931.0 59759.1 60150.7 60158.0 60175.1 60282.7 62365.1 63184.0 63310.0 63344.4 63386.7 16361.6 16588.5 16595.7 16612.8 16621.3 9647.0 11818.8 12961.0 13062.2 13083.9 13642.9 15314.5 15401.6 15621.8 15793.1 6485.9 6516.3 6528.1 6559.9 6582.4 801.9 878.2 878.5 890.7 894.0 24576.9 27129.6 29677.0 29816.0 29995.3 1076.5 1077.2 1081.2 1109.5 1213.1 14903.6 15085.6 15173.4 15322.0 15414.5 628722.9 635044.0 635345.8 636113.0 636672.0 58479.7 58644.0 58674.0 58732.3 58873.8 1247.2 1440.3 1448.6 1464.3 1467.3 28477.1 29168.7 29218.4 29243.0 29863.4 48474.8 48797.5 48811.8 48899.8 49104.5 519666.0 520828.0 523641.0 524429.0 525169.0 31740.5 37276.4 38463.0 38887.6 39056.4 44376.8 46268.5 46821.8 47297.0 47299.8 37524.6 37533.5 37924.0 38256.4 40023.6 37400.1 37525.0 37643.4 38464.4 38470.8 31394.7 31464.4 31553.2 31584.9 31643.1 31151.4 33101.5 33890.3 33977.0 34043.0 19584.8 22020.3 22415.3 22913.4 24952.0 05:10:45 INFO - PROCESS | 1911 | 05:10:45 INFO - PROCESS | 1911 | [#2] jquery.html Cycles:180 Average:41320.54 Median:22122.84 stddev:124504.69 (562.8%) stddev-sans-first:124816.02 05:10:45 INFO - PROCESS | 1911 | Values: 387.5 388.8 392.9 393.7 429.7 13557.7 17843.9 21157.6 21210.2 21243.6 21378.5 21448.4 21827.5 22165.2 22293.6 5049.4 5518.7 5836.1 5849.0 5849.1 4131.8 4244.8 5790.0 5812.6 6263.9 6463.1 6545.6 6568.7 6571.8 6577.0 6331.3 6413.4 6480.0 6491.9 6492.0 5541.0 5563.8 5567.4 5619.5 5669.1 21703.8 26905.1 26937.5 27278.0 27312.2 2758.5 2758.6 2759.3 2761.7 2781.4 10242.0 10353.7 13010.3 13209.6 14090.6 1838.7 1841.7 1936.6 1960.4 1961.9 147412.0 152053.0 152230.5 152581.3 153765.2 11824.8 11867.5 11982.0 11999.6 12013.5 13733.7 14262.9 15227.4 15583.0 15648.9 8076.8 8208.3 8499.4 8603.4 8637.7 8429.7 8435.5 8475.7 8546.7 8561.9 4473.6 4656.4 4741.9 4770.5 4895.7 1817.0 1954.1 1989.4 2041.3 2110.2 940.2 1012.6 1012.7 1023.9 1039.0 21203.7 22120.4 22125.2 22218.4 22252.9 1025.4 1039.9 1047.0 1065.1 1065.9 10640.0 11398.4 11496.7 11499.5 11556.0 718627.0 741200.0 741775.0 744349.0 773714.0 151155.0 154810.5 159779.0 163022.0 165239.0 968.4 969.9 973.4 997.9 1001.3 15671.5 17944.0 18695.7 18969.3 19358.5 55735.4 57066.9 58165.7 58299.0 58480.0 81469.0 83130.6 84068.2 84227.2 84659.6 6988.8 7117.8 7483.5 7610.9 8346.7 10629.3 12812.1 13229.9 13414.7 13671.5 11162.9 11231.1 11319.9 11357.7 11581.2 10011.9 11207.5 11367.0 11610.7 11730.6 11563.8 11566.0 11973.1 12058.0 12130.4 7506.5 7531.8 7604.4 7753.7 7826.6 10859.6 11262.2 11426.2 11704.1 11870.1 05:10:45 INFO - PROCESS | 1911 | 05:10:45 INFO - PROCESS | 1911 | [#3] mootools.html Cycles:180 Average:5414.92 Median:5094.31 stddev:2996.94 (58.8%) stddev-sans-first:2990.36 05:10:45 INFO - PROCESS | 1911 | Values: 1426.9 1441.4 1447.8 1450.8 1453.2 8135.1 8547.9 8551.8 8574.3 8578.6 7441.5 7682.7 7684.0 8040.3 8369.9 2266.5 2306.8 2344.2 2346.6 2347.4 2339.6 2361.9 2369.7 2382.6 2383.7 2041.2 2117.3 2244.2 2315.1 2322.8 1961.8 2340.3 2340.5 2342.1 2342.7 2268.4 2318.8 2323.4 2341.3 2345.8 8434.6 8538.0 8539.1 8548.6 8566.4 5083.4 5227.9 5230.2 5239.2 5247.3 3229.5 3414.4 3493.9 3496.5 3501.2 1124.5 1192.8 1212.0 1216.4 1238.8 10243.9 10835.9 11020.8 11092.7 11109.9 4048.5 4198.6 4510.1 4571.9 4580.2 8854.9 8860.2 8860.5 8872.9 8877.6 5092.1 5096.5 5170.2 5176.6 5181.4 4647.0 4833.9 4842.3 4869.5 4896.7 3669.1 3728.4 3749.4 3796.0 3825.0 1150.4 1158.3 1161.2 1172.0 1173.1 767.6 775.7 798.4 801.4 803.4 4514.7 5391.9 5563.0 5664.3 5668.2 543.1 547.5 565.0 574.9 580.2 3563.9 3746.7 3755.4 3756.7 3777.5 9932.7 10125.7 10321.4 10333.2 10358.5 10242.7 10269.8 10270.8 10277.6 10292.4 7689.2 7889.5 7901.4 8082.0 8090.6 5356.3 5427.4 5465.5 5562.1 5634.3 9174.6 9196.3 9242.2 9383.7 9403.0 8500.8 8671.6 8976.2 9282.5 9352.8 7066.1 7351.9 7357.2 7365.6 7395.0 7635.9 7931.3 8007.8 8115.8 8121.1 7042.0 7127.0 7177.6 7212.7 7328.2 7008.7 7054.4 7056.3 7058.3 7079.7 6386.7 6410.9 6418.0 6421.5 6487.5 4283.5 4883.2 4981.0 5035.8 5054.5 4754.0 5011.8 5021.7 5091.0 5143.2 05:10:45 INFO - PROCESS | 1911 | 05:10:45 INFO - PROCESS | 1911 | [#4] prototype.html Cycles:180 Average:4331.77 Median:4853.92 stddev:1293.89 (26.7%) stddev-sans-first:1262.67 05:10:45 INFO - PROCESS | 1911 | Values: 357.6 364.8 368.7 379.6 380.8 4230.5 5015.5 5227.4 5246.6 5295.7 4236.6 4296.8 5056.5 5120.4 5125.4 4044.9 4051.1 4069.4 4069.9 4076.8 3397.1 3773.5 3896.9 4060.8 4111.5 3334.3 3989.0 4031.1 4043.0 4092.4 3995.7 4034.0 4038.9 4047.0 4052.3 3135.3 3491.6 3564.4 3587.9 3602.3 4281.6 5032.1 5059.4 5136.5 5155.9 4271.4 4280.9 4450.7 4671.1 4701.5 4611.6 4828.7 5452.9 5459.5 5480.2 3484.6 3504.8 3570.7 3960.3 3995.4 4983.9 5581.5 5759.9 5778.6 5784.2 3811.6 3831.2 3842.8 3847.3 3893.5 3714.6 3847.6 3863.9 3872.7 3874.5 3867.9 4365.5 4444.9 4467.6 4480.8 4514.3 5507.8 5513.9 5529.4 5540.7 1050.2 1202.5 1226.0 1234.2 1260.9 763.2 832.8 841.5 850.8 853.8 4579.7 4841.6 4880.3 4881.8 4906.0 4973.0 5213.9 5365.6 5407.9 5427.9 4509.3 4703.6 4808.9 4824.4 4866.2 2485.3 2580.3 2685.5 2772.1 2793.3 5272.3 5354.8 5493.9 5498.2 5532.0 4435.6 5330.2 5349.9 5399.9 5437.7 5456.4 5476.3 5528.6 5537.9 5563.6 4456.4 5047.9 5323.9 5329.7 5367.4 4724.0 5092.4 5113.2 5247.8 5265.2 4810.0 4968.5 5015.7 5129.9 5496.9 3426.4 3573.6 3590.4 3594.0 3648.0 4883.6 4896.6 5123.4 5296.6 5328.5 5121.8 5149.9 5150.6 5178.5 5251.3 4811.7 5095.8 5121.0 5123.8 5153.4 4839.8 5018.3 5080.6 5266.7 5313.0 4260.7 4950.3 5520.2 5531.9 5547.3 4478.8 5294.4 5393.8 5398.3 5422.6 05:10:45 INFO - PROCESS | 1911 | 05:10:45 INFO - PROCESS | 1911 | [#5] yui.html Cycles:180 Average:20983.28 Median:3539.39 stddev:30755.18 (868.9%) stddev-sans-first:30803.77 05:10:45 INFO - PROCESS | 1911 | Values: 706.3 774.6 786.7 829.0 835.7 15180.5 15825.4 15841.4 15858.8 15875.7 14382.1 14489.3 14543.4 14548.8 14558.6 684.6 700.8 856.9 860.2 895.2 879.7 881.5 889.0 889.6 892.6 887.0 911.7 925.7 939.7 953.3 721.5 748.6 946.4 947.9 949.4 665.0 688.0 692.9 693.3 693.6 15164.4 15273.5 15306.6 15361.6 15364.4 13378.3 13425.0 13444.7 13488.5 13720.0 10938.8 12139.2 12329.4 12486.8 12549.7 4190.1 4229.4 4386.3 4399.9 4570.0 100932.0 101247.0 103029.0 103734.5 105659.0 10547.9 10956.9 10966.5 11020.9 11366.6 21514.4 22048.2 22143.8 22500.3 22590.9 7312.3 7451.5 7584.2 7623.3 7843.1 3639.7 4161.3 4233.9 4327.9 4373.0 3437.2 3530.2 3536.5 3537.9 3540.9 612.8 625.0 639.6 640.3 643.5 570.9 579.0 608.7 632.6 695.6 9721.2 10220.1 10336.7 10522.8 10592.6 572.8 572.9 586.9 633.8 661.0 4835.4 4978.4 4987.5 4998.9 5000.6 101990.5 106453.5 108491.5 110131.4 110822.4 98360.0 98498.0 101731.5 102627.0 102924.0 72103.3 74449.3 79364.6 81838.0 83182.6 9545.9 9826.5 9864.4 9876.1 9917.3 38661.6 42901.6 51983.7 53774.7 54491.7 73361.6 74504.6 76572.0 77209.8 79995.6 11392.5 11525.1 11715.6 11821.2 11875.6 11812.7 12307.5 12692.3 12872.1 13302.0 11028.9 12184.3 12506.9 13523.7 13689.7 12559.2 12832.9 13628.2 13815.5 13822.3 12604.7 12959.3 13440.1 13568.6 13603.4 10834.3 10993.9 11086.0 11389.4 11711.8 10778.7 10872.7 10959.0 10965.0 11022.1 05:10:45 INFO - PROCESS | 1911 | -------- Summary: end -------- 05:10:45 INFO - PROCESS | 1911 | 05:10:45 INFO - TEST-INFO | 1911: exit 0 05:10:45 INFO - TEST-OK | dromaeo_css | took 1118854ms 05:10:45 INFO - TEST-START | kraken 05:10:45 INFO - operating with platform_type : mac_ 05:10:45 INFO - Initialising browser for kraken test... 05:10:45 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmp3k6HJy/profile http://localhost:54077/getInfo.html) 05:10:48 INFO - PROCESS | 1915 | __metrics Screen width/height:1600/1200 05:10:48 INFO - PROCESS | 1915 | colorDepth:24 05:10:48 INFO - PROCESS | 1915 | Browser inner width/height: 1024/689 05:10:48 INFO - PROCESS | 1915 | __metrics 05:10:48 INFO - PROCESS | 1915 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:10:48 INFO - PROCESS | 1915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:10:49 INFO - TEST-INFO | 1915: exit 0 05:10:49 INFO - Browser initialized. 05:10:49 INFO - Running cycle 1/1 for kraken test... 05:10:49 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmp3k6HJy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:01 INFO - PROCESS | 1916 | RSS: Main: 213233664 05:11:01 INFO - PROCESS | 1916 | 05:11:04 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54077/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:05 INFO - PROCESS | 1916 | RSS: Main: 264179712 05:11:05 INFO - PROCESS | 1916 | 05:11:07 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54077/tests/kraken/driver.html?testName=audio-dft) 05:11:08 INFO - PROCESS | 1916 | RSS: Main: 277241856 05:11:08 INFO - PROCESS | 1916 | 05:11:11 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54077/tests/kraken/driver.html?testName=audio-fft) 05:11:12 INFO - PROCESS | 1916 | RSS: Main: 376246272 05:11:12 INFO - PROCESS | 1916 | 05:11:14 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54077/tests/kraken/driver.html?testName=audio-oscillator) 05:11:14 INFO - PROCESS | 1916 | RSS: Main: 278142976 05:11:14 INFO - PROCESS | 1916 | 05:11:16 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:11:17 INFO - PROCESS | 1916 | RSS: Main: 279719936 05:11:17 INFO - PROCESS | 1916 | 05:11:20 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54077/tests/kraken/driver.html?testName=imaging-darkroom) 05:11:20 INFO - PROCESS | 1916 | RSS: Main: 319946752 05:11:20 INFO - PROCESS | 1916 | 05:11:24 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54077/tests/kraken/driver.html?testName=imaging-desaturate) 05:11:24 INFO - PROCESS | 1916 | RSS: Main: 320077824 05:11:24 INFO - PROCESS | 1916 | 05:11:27 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54077/tests/kraken/driver.html?testName=json-parse-financial) 05:11:28 INFO - PROCESS | 1916 | RSS: Main: 317870080 05:11:28 INFO - PROCESS | 1916 | 05:11:29 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:11:30 INFO - PROCESS | 1916 | RSS: Main: 295227392 05:11:30 INFO - PROCESS | 1916 | 05:11:32 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:11:32 INFO - PROCESS | 1916 | RSS: Main: 297680896 05:11:32 INFO - PROCESS | 1916 | 05:11:34 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:11:35 INFO - PROCESS | 1916 | RSS: Main: 299831296 05:11:35 INFO - PROCESS | 1916 | 05:11:38 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:11:39 INFO - PROCESS | 1916 | RSS: Main: 316170240 05:11:39 INFO - PROCESS | 1916 | 05:11:42 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:11:42 INFO - PROCESS | 1916 | RSS: Main: 310042624 05:11:42 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54077/tests/kraken/driver.html?testName=ai-astar) 05:11:44 INFO - PROCESS | 1916 | RSS: Main: 354598912 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | __start_tp_report 05:11:44 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 05:11:44 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 05:11:44 INFO - PROCESS | 1916 | |i|pagename|runs| 05:11:44 INFO - PROCESS | 1916 | |0;ai-astar;114;116;114;115;114;116;113;115;113;115 05:11:44 INFO - PROCESS | 1916 | |1;audio-beat-detection;143;99;90;123;128;139;141;106;126;110 05:11:44 INFO - PROCESS | 1916 | |2;audio-dft;187;183;183;186;183;182;185;186;182;182 05:11:44 INFO - PROCESS | 1916 | |3;audio-fft;82;58;60;91;60;57;58;58;74;58 05:11:44 INFO - PROCESS | 1916 | |4;audio-oscillator;88;69;86;94;72;55;106;94;100;112 05:11:44 INFO - PROCESS | 1916 | |5;imaging-gaussian-blur;87;85;87;85;86;83;87;84;87;86 05:11:44 INFO - PROCESS | 1916 | |6;imaging-darkroom;142;98;138;154;112;93;93;94;93;118 05:11:44 INFO - PROCESS | 1916 | |7;imaging-desaturate;86;86;85;88;86;85;85;86;85;85 05:11:44 INFO - PROCESS | 1916 | |8;json-parse-financial;56;52;53;54;54;56;55;57;58;57 05:11:44 INFO - PROCESS | 1916 | |9;json-stringify-tinderbox;64;72;69;83;73;71;68;71;69;75 05:11:44 INFO - PROCESS | 1916 | |10;stanford-crypto-aes;83;84;84;90;103;81;81;92;84;84 05:11:44 INFO - PROCESS | 1916 | |11;stanford-crypto-ccm;138;139;138;137;137;139;138;152;209;144 05:11:44 INFO - PROCESS | 1916 | |12;stanford-crypto-pbkdf2;167;171;168;165;166;168;166;164;166;169 05:11:44 INFO - PROCESS | 1916 | |13;stanford-crypto-sha256-iterative;66;69;66;67;67;65;65;66;66;66 05:11:44 INFO - PROCESS | 1916 | __end_tp_report 05:11:44 INFO - PROCESS | 1916 | __start_cc_report 05:11:44 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,2038 05:11:44 INFO - PROCESS | 1916 | __end_cc_report 05:11:44 INFO - PROCESS | 1916 | __startTimestamp1486732304852__endTimestamp 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | ------- Summary: start ------- 05:11:44 INFO - PROCESS | 1916 | Number of tests: 14 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:1.08 (0.9%) stddev-sans-first:1.13 05:11:44 INFO - PROCESS | 1916 | Values: 114.0 116.0 114.0 115.0 114.0 116.0 113.0 115.0 113.0 115.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:140.00 stddev:18.48 (13.2%) stddev-sans-first:17.72 05:11:44 INFO - PROCESS | 1916 | Values: 143.0 99.0 90.0 123.0 128.0 139.0 141.0 106.0 126.0 110.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.91 (1.0%) stddev-sans-first:1.67 05:11:44 INFO - PROCESS | 1916 | Values: 187.0 183.0 183.0 186.0 183.0 182.0 185.0 186.0 182.0 182.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.00 stddev:12.26 (20.4%) stddev-sans-first:11.48 05:11:44 INFO - PROCESS | 1916 | Values: 82.0 58.0 60.0 91.0 60.0 57.0 58.0 58.0 74.0 58.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:79.00 stddev:17.72 (22.4%) stddev-sans-first:18.79 05:11:44 INFO - PROCESS | 1916 | Values: 88.0 69.0 86.0 94.0 72.0 55.0 106.0 94.0 100.0 112.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.50 stddev:1.42 (1.6%) stddev-sans-first:1.42 05:11:44 INFO - PROCESS | 1916 | Values: 87.0 85.0 87.0 85.0 86.0 83.0 87.0 84.0 87.0 86.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#6] imaging-darkroom Cycles:10 Average:113.50 Median:93.00 stddev:23.47 (25.2%) stddev-sans-first:22.51 05:11:44 INFO - PROCESS | 1916 | Values: 142.0 98.0 138.0 154.0 112.0 93.0 93.0 94.0 93.0 118.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:0.95 (1.1%) stddev-sans-first:1.00 05:11:44 INFO - PROCESS | 1916 | Values: 86.0 86.0 85.0 88.0 86.0 85.0 85.0 86.0 85.0 85.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.93 (3.5%) stddev-sans-first:2.03 05:11:44 INFO - PROCESS | 1916 | Values: 56.0 52.0 53.0 54.0 54.0 56.0 55.0 57.0 58.0 57.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.50 stddev:5.04 (7.0%) stddev-sans-first:4.56 05:11:44 INFO - PROCESS | 1916 | Values: 64.0 72.0 69.0 83.0 73.0 71.0 68.0 71.0 69.0 75.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:84.00 stddev:6.77 (8.1%) stddev-sans-first:7.05 05:11:44 INFO - PROCESS | 1916 | Values: 83.0 84.0 84.0 90.0 103.0 81.0 81.0 92.0 84.0 84.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:139.00 stddev:22.23 (16.0%) stddev-sans-first:23.34 05:11:44 INFO - PROCESS | 1916 | Values: 138.0 139.0 138.0 137.0 137.0 139.0 138.0 152.0 209.0 144.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.50 stddev:2.05 (1.2%) stddev-sans-first:2.18 05:11:44 INFO - PROCESS | 1916 | Values: 167.0 171.0 168.0 165.0 166.0 168.0 166.0 164.0 166.0 169.0 05:11:44 INFO - PROCESS | 1916 | 05:11:44 INFO - PROCESS | 1916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 05:11:44 INFO - PROCESS | 1916 | Values: 66.0 69.0 66.0 67.0 67.0 65.0 65.0 66.0 66.0 66.0 05:11:44 INFO - PROCESS | 1916 | -------- Summary: end -------- 05:11:44 INFO - PROCESS | 1916 | 05:11:45 INFO - TEST-INFO | 1916: exit 0 05:11:45 INFO - TEST-OK | kraken | took 59977ms 05:11:45 INFO - SUITE-END | took 1178s 05:11:46 INFO - Completed test suite (00:19:39) 05:11:46 INFO - javascript benchmark 05:11:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.7339412846973, 3363.865445382183, 3376.1897144685254, 3378.206121561433, 3397.303552771682, 5698.25922630058, 5730.656160630365, 5738.483536481715, 5742.2247996520455, 5755.6546607203545, 5678.943210567893, 5710.2862142232225, 5754.683492407927, 5770.422957704228, 5774.2782152230975, 5229.869253268661, 5262.500062494076, 5266.210068489729, 5274.077036518613, 5310.92033619496, 5188.403333616645, 5191.195364718475, 5198.2722418861385, 5319.148936170213, 5324.387695415019, 5291.708956007418, 5303.522682958533, 5315.14957606783, 5318.468153184689, 5332.546733527654, 5205.167173252262, 5254.500822421864, 5271.5782737381305, 5323.494268044549, 5334.466553344654, 5196.45437229093, 5263.26314315996, 5277.076511610453, 5278.1291086970605, 5314.468553144693, 5762.0, 5841.941580584183, 5882.735276912506, 5883.588148829584, 5891.0, 6120.883718150473, 6172.012478003498, 6186.350433204539, 6236.0, 6322.873542529123, 4584.564466375689, 6184.56708030438, 6259.937400625981, 6276.184096067527, 6284.811455656338, 4888.462269150462, 5848.356680765112, 5882.205902203191, 5892.057270836645, 5892.234009578728, 6278.6546739929745, 6281.403266689657, 6285.465735412449, 6287.937120628827, 6296.087067375205, 6020.789272375446, 6032.879342413127, 6069.332373438918, 6245.6252624842655, 6258.155149054819, 6215.0, 6226.315105338409, 6245.875082498324, 6261.96869015652, 6282.685865706696, 6230.501559875199, 6281.905771413432, 6304.148939893147, 6310.652914089769, 6311.558190926683, 6275.090111933744, 6277.121203031579, 6289.371062893674, 6291.087792270096, 6297.055441683692, 4889.902201955941, 4937.136001199776, 4946.727929963815, 4957.504249575014, 4983.90032199354, 4468.910621787546, 4476.283794592915, 4483.2602620567895, 4489.6408287336935, 4502.639788816887, 5887.793927212527, 5887.970560147258, 5895.528357731371, 5904.7342869570975, 5910.083936989773, 6118.80192544137, 6209.130721698965, 6214.937850621526, 6236.0, 6271.498280137578, 5824.242848429677, 5861.208736820475, 5949.2266005419015, 5959.880802383928, 5974.820755377345, 4562.771861406916, 5420.4850539198715, 5433.755481003364, 5440.075187218183, 5510.752016159283, 6262.5929314594405, 6315.463185629089, 6327.272363678144, 6329.651869147241, 6346.238451385863, 6171.413715697002, 6190.7523699051535, 6227.844303892439, 6313.6843157841, 6326.905096423649, 6205.596636218631, 6217.658028808459, 6236.251649802053, 6311.053341998737, 6341.397567231105, 6230.408111229426, 6239.06414037898, 6255.843603909939, 6282.1519094921605, 6293.937060629518, 5525.972370138124, 6087.939120608914, 6289.96855015722, 6292.0, 6304.65324407162, 6032.155498230339, 6082.2701275847185, 6111.54163437735, 6114.57197996136, 6180.320164781961, 6140.754369825157, 6141.263048434216, 6146.385361463817, 6154.599951003171, 6154.907676384768, 5925.733341999707, 5974.984252676968, 5995.820125396245, 6019.398060193946, 6022.126791615279, 6036.486898613667, 6103.267607887082, 6118.143459915526, 6118.143459915705, 6161.537884658579, 6042.093685947143, 6068.878622427438, 6092.421219984094, 6105.206323177958, 6129.233845769279], "value": 5730.357570407274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.3380436410846, 492.6896055485044, 499.99999999999994, 507.41647105828304, 511.57539242428766, 29641.0, 38870.61129388705, 41276.38085428721, 41431.378529322006, 41653.58346416542, 41799.79100104495, 42112.15775684485, 42241.15517689644, 42262.0, 42305.0, 9108.59011344491, 9311.95344023279, 9323.254139668845, 9344.065593440635, 9346.906530934706, 8195.508269503849, 8388.454750441233, 10928.180386471047, 11169.497372618252, 11183.83224251637, 11096.278741881792, 11171.045067113264, 11180.66458006257, 11185.105191584695, 11203.719907002349, 8179.345652347798, 11059.004689577936, 11142.610008649659, 11164.162687798447, 11169.385683787428, 8301.626426810808, 10772.515236814363, 11034.006939375495, 11042.613508527244, 11218.990290873779, 33154.668453315644, 39767.20465590701, 39977.0, 40612.984675383355, 40685.79657101725, 3946.842126314944, 3948.4274780157, 3965.1474932889278, 3969.6282143141284, 3993.0616305168264, 28528.28679283014, 29081.09189081096, 30210.54684179739, 31086.22284442907, 31333.37333253322, 3023.4557779599663, 3183.8248896310693, 3274.590676165479, 3329.3840639481773, 3335.5997280326274, 497982.0, 498418.0, 498658.0, 499577.9999999964, 499931.0, 59759.10361344583, 60150.699246503485, 60158.0, 60175.09737353943, 60282.69858650678, 62365.064524032176, 63184.0, 63310.0, 63344.36655633477, 63386.6830665853, 16361.590960226089, 16588.50234492967, 16595.6680866382, 16612.83387166137, 16621.335146594, 9647.0, 11818.822717659243, 12961.0, 13062.150960187557, 13083.869161308456, 13642.931785341209, 15314.463993760164, 15401.614959625875, 15621.843781562038, 15793.052416855026, 6485.902711459332, 6516.283208847023, 6528.1187039749975, 6559.934400656028, 6582.407583317525, 801.8757092650649, 878.1876763993281, 878.4992554244147, 890.7060669978891, 893.9776505587413, 24576.87711561431, 27129.593056104175, 29676.951430942016, 29815.956441524875, 29995.250118746768, 1076.5155679944057, 1077.235163034239, 1081.2431298091367, 1109.450821843193, 1213.0719999200442, 14903.552893413214, 15085.622859428382, 15173.393064277527, 15322.0, 15414.537563873102, 628722.8563857243, 635044.0, 635345.8232708807, 636113.0, 636672.0, 58479.70760146257, 58644.0, 58674.0, 58732.30141588663, 58873.82252354929, 1247.214255019332, 1440.279860069965, 1448.6450819549277, 1464.3410465290874, 1467.325030485967, 28477.145685629464, 29168.7083129166, 29218.415631687672, 29242.976495822542, 29863.402731945673, 48474.75762621164, 48797.512024880714, 48811.779705506226, 48899.755501222266, 49104.508954909994, 519666.0, 520828.0, 523641.0, 524429.0, 525169.0, 31740.523892141173, 37276.44085338668, 38463.03842403962, 38887.6111238884, 39056.41415378828, 44376.77811610921, 46268.537314626425, 46821.765891170326, 47297.0, 47299.763501183654, 37524.6247537532, 37533.49598048143, 37924.0, 38256.426153607164, 40023.599764001985, 37400.06499837526, 37525.0, 37643.43534846925, 38464.423033655075, 38470.80764596159, 31394.68605314009, 31464.37071258608, 31553.21116972094, 31584.894528691384, 31643.050708478782, 31151.376972460876, 33101.503477447375, 33890.32219355649, 33976.98069057932, 34043.0, 19584.80415195887, 22020.33938981833, 22415.313560292663, 22913.427164321027, 24952.0], "value": 19821.76759907364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.4865802811276, 388.84706844206954, 392.88802691233, 393.71455694621386, 429.7185343599941, 13557.728845423086, 17843.910780446095, 21157.57684846302, 21210.151593936225, 21243.57512849742, 21378.46553836155, 21448.356549303506, 21827.454313642167, 22165.22421715236, 22293.55412891745, 5049.419316778581, 5518.696471694056, 5836.124581312794, 5849.005669036253, 5849.093390524455, 4131.772752498611, 4244.808983595745, 5790.044642633981, 5812.564057695668, 6263.874722505547, 6463.062855885893, 6545.639989800559, 6568.704408301638, 6571.835704107411, 6577.0, 6331.2719037310835, 6413.358664133572, 6479.967600161969, 6491.93508064918, 6491.967540162316, 5540.972295138539, 5563.833085007456, 5567.4432556744405, 5619.494245517923, 5669.121286200645, 21703.782962170335, 26905.0583229586, 26937.46125077507, 27278.0, 27312.180634580993, 2758.475889580993, 2758.613794068832, 2759.296379423254, 2761.654793150856, 2781.3741908070724, 10242.0, 10353.689389318333, 13010.349482525931, 13209.603711888658, 14090.577282681536, 1838.6506563752844, 1841.7421560981472, 1936.5836345185853, 1960.3824795189612, 1961.9313324033733, 147412.0, 152053.0, 152230.47769522385, 152581.2676859077, 153765.23117384454, 11824.822627660593, 11867.465964031639, 11981.963066278753, 11999.64001079969, 12013.459394327276, 13733.656658583415, 14262.928685356714, 15227.390904363701, 15582.987105838085, 15648.92175539115, 8076.798080047928, 8208.302294305051, 8499.362547808816, 8603.397762156588, 8637.654493820302, 8429.662813487514, 8435.451695639764, 8475.703350382708, 8546.658133674584, 8561.871571926426, 4473.613179914237, 4656.3713898623255, 4741.881452963704, 4770.475247722748, 4895.681780684244, 1817.0, 1954.1240409207037, 1989.3634037108277, 2041.3161590866928, 2110.1559376249315, 940.2149205413556, 1012.6202673997251, 1012.6911292055994, 1023.8566600675912, 1038.99480502597, 21203.68194477084, 22120.446988825086, 22125.225617103326, 22218.44453888666, 22252.888735556542, 1025.4411345816548, 1039.896010398969, 1046.984295235572, 1065.1053115383115, 1065.8507808906759, 10640.04239618438, 11398.373089480157, 11496.712582185344, 11499.482523286471, 11555.959963603316, 718627.0, 741200.0, 741775.0, 744349.0, 773714.0, 151155.0, 154810.45189548185, 159779.0, 163022.0, 165239.0, 968.4237878462303, 969.9418034917927, 973.3770386952356, 997.9051990061078, 1001.2690735762934, 15671.529854104396, 17944.013079280765, 18695.719564206818, 18969.33607323737, 19358.516037099183, 55735.44264557303, 57066.85866282734, 58165.70917145387, 58299.0, 58480.0, 81469.0, 83130.58434707788, 84068.15931840848, 84227.15772842194, 84659.5767021161, 6988.825279368057, 7117.75087871922, 7483.513571617827, 7610.885836712343, 8346.707865224687, 10629.267392508003, 12812.103152779217, 13229.933850330686, 13414.664633384244, 13671.453141874214, 11162.944185279022, 11231.101511878867, 11319.886801131883, 11357.716057098638, 11581.24721893108, 10011.899881001387, 11207.495662695035, 11367.0, 11610.6516804496, 11730.589429369931, 11563.768724625628, 11566.0, 11973.10201734856, 12058.0, 12130.393480325773, 7506.474546781673, 7531.774046778605, 7604.391648668204, 7753.65108570127, 7826.647800849089, 10859.565617375532, 11262.211645185087, 11426.228934515164, 11704.122190835891, 11870.109741769229], "value": 10040.516311352894, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.9286535673214, 1441.4234306277488, 1447.8407375188733, 1450.8113945187124, 1453.186215719197, 8135.145809689986, 8547.914520854789, 8551.78620534487, 8574.314054875611, 8578.613962371692, 7441.479096463249, 7682.6542805573745, 7684.0, 8040.31657309128, 8369.874451883226, 2266.5240299537077, 2306.7808558186944, 2344.1678204237505, 2346.6480027995767, 2347.366211122996, 2339.5671800716923, 2361.89371478283, 2369.7393286738443, 2382.6068698664785, 2383.7497062808416, 2041.1631231195213, 2117.280124757582, 2244.2033078257227, 2315.050829160045, 2322.756110608387, 1961.8234358907696, 2340.2745149003695, 2340.461693810416, 2342.10999820069, 2342.7305859825997, 2268.387535365442, 2318.8144948404256, 2323.4423738302853, 2341.309313752447, 2345.753695861944, 8434.578271086482, 8538.0, 8539.146085391474, 8548.57257137147, 8566.357523185787, 5083.364579427572, 5227.921581176285, 5230.189320655304, 5239.187925871496, 5247.2653828464045, 3229.515572664119, 3414.351273258098, 3493.8951831445097, 3496.527968724215, 3501.1772233525103, 1124.4658787076073, 1192.7793358228669, 1212.030375699437, 1216.385725208764, 1238.8203710461933, 10243.948780256125, 10835.891641083646, 11020.834687479693, 11092.667219983414, 11109.888901111048, 4048.5344185419053, 4198.5591512890705, 4510.120526497367, 4571.9314210286875, 4580.198465268565, 8854.86717699235, 8860.202581767671, 8860.468371897707, 8872.93524777018, 8877.600507977157, 5092.083424983464, 5096.541311282002, 5170.224466330005, 5176.5858731301405, 5181.4041385240425, 4646.953530464652, 4833.927491087637, 4842.297866809293, 4869.537393947569, 4896.677896967799, 3669.1377526281303, 3728.366177749789, 3749.4000959846294, 3796.0, 3824.972764434854, 1150.3558007515817, 1158.29922896648, 1161.2393882007298, 1171.9941400292944, 1173.1084375874398, 767.5586537740821, 775.6936010276022, 798.4091772088728, 801.3669201330883, 803.3733687723585, 4514.70654407469, 5391.946080539223, 5562.9986602411955, 5664.291963504562, 5668.234788303609, 543.1499702964848, 547.4580165636071, 564.9717514124277, 574.9367569567344, 580.196427947296, 3563.9329586710887, 3746.7377283589885, 3755.3615885299564, 3756.7039371416818, 3777.4522694209186, 9932.652357167464, 10125.696229113139, 10321.380717156844, 10333.173346132291, 10358.482075896174, 10242.743931401625, 10269.845952310721, 10270.845937310947, 10277.588896444058, 10292.433916134685, 7689.154193038761, 7889.487183333065, 7901.446898717035, 8082.0, 8090.635921383552, 5356.250124982584, 5427.375851777097, 5465.508104270635, 5562.082256427806, 5634.295713035871, 9174.577940419245, 9196.26429885621, 9242.168204861326, 9383.671571494964, 9403.01268366839, 8500.829983400421, 8671.609777560152, 8976.237019853386, 9282.489463079326, 9352.766180845534, 7066.116735408074, 7351.889721654286, 7357.153927298429, 7365.558066516026, 7395.0, 7635.923640763522, 7931.286184243446, 8007.83984320322, 8115.83768324642, 8121.066077401175, 7042.014118023379, 7126.964365178141, 7177.641117943977, 7212.74755383559, 7328.193898671036, 7008.684609192496, 7054.365107140382, 7056.294370563108, 7058.306006558491, 7079.716811327695, 6386.680665966776, 6410.903836442364, 6418.0, 6421.518386120966, 6487.481001519962, 4283.507396649301, 4883.243097319921, 4981.0, 5035.823746168867, 5054.545090941833, 4754.0, 5011.774470148925, 5021.698698078127, 5090.974545127251, 5143.202803565453], "value": 4325.166605454662, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.5798436836717, 364.80665247418875, 368.6810908564092, 379.5881468606562, 380.78295371638177, 4230.534641189467, 5015.473375295596, 5227.353383684142, 5246.580273578114, 5295.655782374148, 4236.555161708023, 4296.763677997709, 5056.469070747574, 5120.359955005624, 5125.410577783547, 4044.939325910099, 4051.149258655686, 4069.351912475452, 4069.8779036628875, 4076.7757773322455, 3397.1442412861456, 3773.5094437723055, 3896.9346246489263, 4060.817263223147, 4111.506619205699, 3334.266181585574, 3989.0, 4031.052702614883, 4043.0, 4092.386142078682, 3995.6603688686496, 4033.97983010086, 4038.9192216155807, 4046.9967366153796, 4052.2908491013955, 3135.278885856266, 3491.5635545556806, 3564.429691249388, 3587.892363229107, 3602.3335682898746, 4281.593248641405, 5032.144535428986, 5059.406287019577, 5136.508793235278, 5155.922661160085, 4271.444712187426, 4280.850170244058, 4450.688451808374, 4671.065786842645, 4701.48283688794, 4611.608013318838, 4828.686135401188, 5452.864602853375, 5459.481349271813, 5480.205370221295, 3484.63411341808, 3504.7721898076543, 3570.696490798285, 3960.3069462843887, 3995.380715989026, 4983.878627308863, 5581.469760372758, 5759.913601295984, 5778.566607504454, 5784.190213370173, 3811.6468653628117, 3831.1571454280015, 3842.8270727816757, 3847.3074846527893, 3893.53277606689, 3714.591394946554, 3847.5960024197057, 3863.9227215455535, 3872.7482713623526, 3874.5156855393075, 3867.903302417462, 4365.541618130114, 4444.911101777946, 4467.642588592905, 4480.843170489083, 4514.322851572225, 5507.834764956978, 5513.862153446196, 5529.447055294519, 5540.722963851791, 1050.2490719135856, 1202.4949521201117, 1225.9640603689868, 1234.2409418207917, 1260.9495620175273, 763.1605234242289, 832.8375966686559, 841.5035129273635, 850.7918755367393, 853.8206976534997, 4579.740841017819, 4841.588464980446, 4880.341153944172, 4881.780319885614, 4905.9754701226975, 4972.975135124374, 5213.905079933256, 5365.6244062916, 5407.945920540823, 5427.945720542744, 4509.301058335963, 4703.64722645803, 4808.8797780055775, 4824.396950381202, 4866.245731911559, 2485.2792690119663, 2580.2904201344404, 2685.462907418524, 2772.057500449857, 2793.3296008957705, 5272.340957380327, 5354.812581559627, 5493.862653433696, 5498.1752737088955, 5532.0, 4435.6229720473475, 5330.227117068003, 5349.893002140013, 5399.865003374868, 5437.728113594384, 5456.399796022434, 5476.32971943561, 5528.585356098309, 5537.944620553823, 5563.554915606661, 4456.395697548945, 5047.87380315495, 5323.893522129613, 5329.7068661224, 5367.409584945731, 4723.976380118077, 5092.388913330424, 5113.15632920564, 5247.842564722911, 5265.183896496049, 4809.95190048109, 4968.540572416677, 5015.695919060998, 5129.897402052013, 5496.945030549643, 3426.4003799335514, 3573.5890372607482, 3590.425531914881, 3593.964060359363, 3647.9817600911824, 4883.633727470383, 4896.583790377857, 5123.386133367977, 5296.569926120003, 5328.547073498796, 5121.795128194831, 5149.9227511586605, 5150.6137039721425, 5178.482151784791, 5251.317328747238, 4811.65273723358, 5095.757866538711, 5120.974395128001, 5123.769430375568, 5153.418374230024, 4839.782209800497, 5018.322526458881, 5080.618953578422, 5266.709656134271, 5313.0, 4260.680448966402, 4950.331705219894, 5520.176214094169, 5531.917021244765, 5547.334319881478, 4478.843240486567, 5294.444083371191, 5393.757280922289, 5398.2982212312145, 5422.566194704335], "value": 3933.196509435229, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.3360441185285, 774.5778550689873, 786.6695987685173, 828.9502629842207, 835.7158566087531, 15180.544583662493, 15825.446109386145, 15841.445549405773, 15858.841411585896, 15875.682486350295, 14382.065165764217, 14489.347979340928, 14543.418263269457, 14548.781768273484, 14558.563243102697, 684.6131935456451, 700.7687463137153, 856.9057403685605, 860.1742327365737, 895.1764376773384, 879.6613303877989, 881.5107615273521, 888.9821154777776, 889.5863423508067, 892.6117139044504, 887.0198430734043, 911.7447114807832, 925.7176561148847, 939.6523286384047, 953.3136141977765, 721.4661150748461, 748.6069813347981, 946.3895787217241, 947.8957314695378, 949.3544389814923, 665.0456594786497, 687.9759208427681, 692.9064576282187, 693.2824526614929, 693.6358411833777, 15164.393424263017, 15273.465428709942, 15306.617334566614, 15361.615959600987, 15364.385424583003, 13378.264195469244, 13425.0, 13444.663883402894, 13488.5279015234, 13720.0, 10938.835917461245, 12139.210951288138, 12329.383530823423, 12486.81269780954, 12549.749005019848, 4190.099128687317, 4229.407882896397, 4386.342048692722, 4399.934000989988, 4569.994601187734, 100931.99068009299, 101247.0, 103029.0, 103734.48132759363, 105659.0, 10547.894521054692, 10956.890431095588, 10966.506507207196, 11020.889791101987, 11366.602168924213, 21514.354569362633, 22048.228312009003, 22143.782091984773, 22500.32499025032, 22590.88704556467, 7312.341889229889, 7451.478396512301, 7584.2036586158765, 7623.313901748869, 7843.05883293997, 3639.6906262967414, 4161.313383291723, 4233.915321693549, 4327.891802704958, 4372.978135109304, 3437.1922598189403, 3530.223350862806, 3536.451849963208, 3537.876174333886, 3540.91147721309, 612.8039027511243, 624.9718762655691, 639.6034458635582, 640.3372509452694, 643.5270076493773, 570.9486146246858, 578.988420231593, 608.7260732670228, 632.5983000794529, 695.6486974078058, 9721.222302215805, 10220.080192782685, 10336.689899303034, 10522.842157367646, 10592.629257975934, 572.802383177803, 572.8625129968777, 586.9471747542742, 633.7940169444856, 660.957037792542, 4835.395575553056, 4978.427480839678, 4987.526185012418, 4998.900021999612, 5000.62495312853, 101990.49004754929, 106453.4677326624, 108491.45754271178, 110131.44934275278, 110822.44588777165, 98360.0, 98498.0, 101731.4913425443, 102627.0, 102923.97076029144, 72103.27896720966, 74449.25550744531, 79364.60317698374, 81838.0, 83182.58408707917, 9545.856812147962, 9826.5086745661, 9864.408135511892, 9876.061774131445, 9917.256205784452, 38661.61338386693, 42901.570984289756, 51983.74008129935, 53774.73112634568, 54491.72754136204, 73361.6331918337, 74504.62747686227, 76572.0, 77209.84185237113, 79995.60002199952, 11392.487338069972, 11525.077993760648, 11715.648530544097, 11821.172517924007, 11875.643730688093, 11812.742762506996, 12307.507699691912, 12692.301923393932, 12872.098953073195, 13302.0, 11028.944855275673, 12184.329861857683, 12506.937465312616, 13523.661908452368, 13689.657758556115, 12559.246445213317, 12832.871671283541, 13628.182309061489, 13815.51487687106, 13822.30888455553, 12604.684882877635, 12959.287239201934, 13440.059195856196, 13568.59294221175, 13603.387847547083, 10834.295770774874, 10993.945030274797, 11086.0, 11389.430528473378, 11711.824322635337, 10778.658615829117, 10872.728181795519, 10958.958819036476, 10965.0, 11022.118230541377], "value": 7495.350844053367, "unit": "score"}], "name": "dromaeo_css", "value": 7251.789075008149, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 115.0, 114.0, 116.0, 113.0, 115.0, 113.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 99.0, 90.0, 123.0, 128.0, 139.0, 141.0, 106.0, 126.0, 110.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 183.0, 186.0, 183.0, 182.0, 185.0, 186.0, 182.0, 182.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 91.0, 60.0, 57.0, 58.0, 58.0, 74.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 86.0, 94.0, 72.0, 55.0, 106.0, 94.0, 100.0, 112.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 86.0, 83.0, 87.0, 84.0, 87.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 98.0, 138.0, 154.0, 112.0, 93.0, 93.0, 94.0, 93.0, 118.0], "value": 113.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 88.0, 86.0, 85.0, 85.0, 86.0, 85.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 53.0, 54.0, 54.0, 56.0, 55.0, 57.0, 58.0, 57.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 69.0, 83.0, 73.0, 71.0, 68.0, 71.0, 69.0, 75.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 90.0, 103.0, 81.0, 81.0, 92.0, 84.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 138.0, 137.0, 137.0, 139.0, 138.0, 152.0, 209.0, 144.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 168.0, 165.0, 166.0, 168.0, 166.0, 164.0, 166.0, 169.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 67.0, 67.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1450.7, "alertThreshold": 2.0}]} 05:11:46 INFO - Return code: 0 05:11:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:11:46 ERROR - # TBPL SUCCESS # 05:11:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:11:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:11:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:11:46 INFO - 2017-02-10 05:11:46.173 screenresolution[1920:19331] starting screenresolution argv=screenresolution get 05:11:46 INFO - 2017-02-10 05:11:46.175 screenresolution[1920:19331] Display 0: 1600x1200x32@60 05:11:46 INFO - 2017-02-10 05:11:46.182 screenresolution[1921:19334] starting screenresolution argv=screenresolution list 05:11:46 INFO - Available Modes on Display 0 05:11:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:11:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:11:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:11:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:11:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:11:46 INFO - Intel Iris: 05:11:46 INFO - Chipset Model: Intel Iris 05:11:46 INFO - Type: GPU 05:11:46 INFO - Bus: Built-In 05:11:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:11:46 INFO - Vendor: Intel (0x8086) 05:11:46 INFO - Device ID: 0x0a2e 05:11:46 INFO - Revision ID: 0x0009 05:11:46 INFO - Displays: 05:11:46 INFO - Display: 05:11:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:11:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:11:46 INFO - Display Serial Number: 1600x1200 60 05:11:46 INFO - Main Display: Yes 05:11:46 INFO - Mirror: Off 05:11:46 INFO - Online: Yes 05:11:46 INFO - Rotation: Supported 05:11:46 INFO - Return code: 0 05:11:46 INFO - Running post-action listener: _resource_record_post_action 05:11:46 INFO - [mozharness: 2017-02-10 13:11:46.428581Z] Finished run-tests step (success) 05:11:46 INFO - Running post-run listener: _resource_record_post_run 05:11:46 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 737280; Write bytes: 505589760; Read time: 10; Write time: 1579 05:11:46 INFO - TinderboxPrint: CPU usage
53.7% 05:11:46 INFO - TinderboxPrint: I/O read bytes / time
737,280 / 10 05:11:46 INFO - TinderboxPrint: I/O write bytes / time
505,589,760 / 1,579 05:11:46 INFO - TinderboxPrint: CPU idle
2,220.3 (46.3%) 05:11:46 INFO - TinderboxPrint: CPU system
961.4 (20.0%) 05:11:46 INFO - TinderboxPrint: CPU user
1,616.0 (33.7%) 05:11:46 INFO - TinderboxPrint: Swap in / out
208,715,776 / 0 05:11:46 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207262208; Write bytes: 201725952; Read time: 16198; Write time: 450 05:11:46 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 606208; Write bytes: 293853184; Read time: 8; Write time: 1094 05:11:46 INFO - Running post-run listener: _upload_blobber_files 05:11:46 INFO - Blob upload gear active. 05:11:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:11:46 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:11:46 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:11:46 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:11:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:11:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:48 INFO - (blobuploader) - INFO - Done attempting. 05:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:49 INFO - (blobuploader) - INFO - Done attempting. 05:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:50 INFO - (blobuploader) - INFO - Done attempting. 05:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:52 INFO - (blobuploader) - INFO - Done attempting. 05:11:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:11:52 INFO - Return code: 0 05:11:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:11:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:11:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5401149dc6f77ff5d53d4146d180c189badfffc6e1268d706bfe638b2bf4dc8e301e8f5b63d15788ba1fcaa2f8449855b11311d815a57ad8a237fb51fd77615", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2674a710620db86357bed817307000e8c6a9718c5fe9e6d0a1173c2dab6be7008de231dab28fe03ed8d95304f1bc067cae63deac297bd50dc4f2b309b2404b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4191765662093eafee24d1615d46cce6eba1a4583e2db600d09db44f6e4e823633dd9a6c6166829918396c1ffbb907597866b86e7201c4c62f1ab9565070b2a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/293f5c2ea3b05018eb50be72987a8082280b9861a5847907e55f792ddf4da88ba3fff52984e874eb7e714e6cff8ac2d5a9693b5ca05e8333bb298d89df056571"} 05:11:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:11:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:11:52 INFO - Contents: 05:11:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5401149dc6f77ff5d53d4146d180c189badfffc6e1268d706bfe638b2bf4dc8e301e8f5b63d15788ba1fcaa2f8449855b11311d815a57ad8a237fb51fd77615", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2674a710620db86357bed817307000e8c6a9718c5fe9e6d0a1173c2dab6be7008de231dab28fe03ed8d95304f1bc067cae63deac297bd50dc4f2b309b2404b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4191765662093eafee24d1615d46cce6eba1a4583e2db600d09db44f6e4e823633dd9a6c6166829918396c1ffbb907597866b86e7201c4c62f1ab9565070b2a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/293f5c2ea3b05018eb50be72987a8082280b9861a5847907e55f792ddf4da88ba3fff52984e874eb7e714e6cff8ac2d5a9693b5ca05e8333bb298d89df056571"} 05:11:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:11:52 INFO - Copying logs to upload dir... 05:11:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:11:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.430427 ========= master_lag: 1.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-10 05:11:53.467557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 05:11:53.471055) ========= 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.hVEn8GRbHc/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.wgUxxGycai/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5401149dc6f77ff5d53d4146d180c189badfffc6e1268d706bfe638b2bf4dc8e301e8f5b63d15788ba1fcaa2f8449855b11311d815a57ad8a237fb51fd77615", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2674a710620db86357bed817307000e8c6a9718c5fe9e6d0a1173c2dab6be7008de231dab28fe03ed8d95304f1bc067cae63deac297bd50dc4f2b309b2404b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4191765662093eafee24d1615d46cce6eba1a4583e2db600d09db44f6e4e823633dd9a6c6166829918396c1ffbb907597866b86e7201c4c62f1ab9565070b2a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/293f5c2ea3b05018eb50be72987a8082280b9861a5847907e55f792ddf4da88ba3fff52984e874eb7e714e6cff8ac2d5a9693b5ca05e8333bb298d89df056571"} build_url:https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011665 build_url: 'https://queue.taskcluster.net/v1/task/Q5WgZTakTdiySX9nclANBA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5401149dc6f77ff5d53d4146d180c189badfffc6e1268d706bfe638b2bf4dc8e301e8f5b63d15788ba1fcaa2f8449855b11311d815a57ad8a237fb51fd77615", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2674a710620db86357bed817307000e8c6a9718c5fe9e6d0a1173c2dab6be7008de231dab28fe03ed8d95304f1bc067cae63deac297bd50dc4f2b309b2404b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4191765662093eafee24d1615d46cce6eba1a4583e2db600d09db44f6e4e823633dd9a6c6166829918396c1ffbb907597866b86e7201c4c62f1ab9565070b2a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/293f5c2ea3b05018eb50be72987a8082280b9861a5847907e55f792ddf4da88ba3fff52984e874eb7e714e6cff8ac2d5a9693b5ca05e8333bb298d89df056571"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 05:11:53.575216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 05:11:53.575566) ========= 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.hVEn8GRbHc/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.wgUxxGycai/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.005434 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 05:11:53.853719) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 05:11:53.854837) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 05:11:53.855238) ========= ========= Total master_lag: 1.58 =========