builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0141 starttime: 1480721862.74 results: success (0) buildid: 20161202130943 builduid: 1f85e82a10ea4eba902f878cb8e17694 revision: bfa85d23df57c8a1db17c99b267667becc1c4afd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:42.738073) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:42.738526) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:42.738806) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:42.763852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:42.764272) ========= 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.VPF3S2ZztM/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.s9srhEzo9I/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-02 15:37:42-- 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% 8.39M=0.001s 2016-12-02 15:37:42 (8.39 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152192 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:42.941199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:42.941933) ========= 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.VPF3S2ZztM/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.s9srhEzo9I/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.019698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:42.992101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 15:37:42.992496) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bfa85d23df57c8a1db17c99b267667becc1c4afd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bfa85d23df57c8a1db17c99b267667becc1c4afd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VPF3S2ZztM/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.s9srhEzo9I/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-02 15:37:43,065 truncating revision to first 12 chars 2016-12-02 15:37:43,065 Setting DEBUG logging. 2016-12-02 15:37:43,065 attempt 1/10 2016-12-02 15:37:43,065 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bfa85d23df57?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 15:37:44,170 unpacking tar archive at: mozilla-central-bfa85d23df57/testing/mozharness/ program finished with exit code 0 elapsedTime=1.347985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 15:37:44.364079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:44.364577) ========= script_repo_revision: bfa85d23df57c8a1db17c99b267667becc1c4afd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:44.365247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:44.365712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 15:37:44.385689) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-12-02 15:37:44.386179) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VPF3S2ZztM/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.s9srhEzo9I/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:37:44 INFO - MultiFileLogger online at 20161202 15:37:44 in /builds/slave/test 15:37:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:37:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:37:44 INFO - {'append_to_log': False, 15:37:44 INFO - 'base_work_dir': '/builds/slave/test', 15:37:44 INFO - 'blob_upload_branch': 'Firefox', 15:37:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:37:44 INFO - 'branch': 'Firefox', 15:37:44 INFO - 'buildbot_json_path': 'buildprops.json', 15:37:44 INFO - 'config_files': ('talos/mac_config.py',), 15:37:44 INFO - 'default_actions': ('clobber', 15:37:44 INFO - 'read-buildbot-config', 15:37:44 INFO - 'download-and-extract', 15:37:44 INFO - 'populate-webroot', 15:37:44 INFO - 'create-virtualenv', 15:37:44 INFO - 'install', 15:37:44 INFO - 'run-tests'), 15:37:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:37:44 INFO - 'download_minidump_stackwalk': True, 15:37:44 INFO - 'download_symbols': 'ondemand', 15:37:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:37:44 INFO - 'tooltool.py': '/tools/tooltool.py', 15:37:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:37:44 INFO - '/tools/misc-python/virtualenv.py')}, 15:37:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:37:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:37:44 INFO - 'installer_path': 'installer.exe', 15:37:44 INFO - 'log_level': 'info', 15:37:44 INFO - 'log_name': 'talos', 15:37:44 INFO - 'log_to_console': True, 15:37:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:37:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:37:44 INFO - 'opt_config_files': (), 15:37:44 INFO - 'pip_index': False, 15:37:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:37:44 INFO - 'cmd': ('bash', 15:37:44 INFO - '-c', 15:37:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:37:44 INFO - 'enabled': True, 15:37:44 INFO - 'halt_on_failure': False, 15:37:44 INFO - 'name': 'check_screen_resolution'},), 15:37:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:37:44 INFO - 'cmd': ('bash', 15:37:44 INFO - '-c', 15:37:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:37:44 INFO - 'enabled': True, 15:37:44 INFO - 'halt_on_failure': False, 15:37:44 INFO - 'name': 'check_screen_resolution'},), 15:37:44 INFO - 'run_cmd_checks_enabled': True, 15:37:44 INFO - 'sps_profile': False, 15:37:44 INFO - 'sps_profile_interval': 0, 15:37:44 INFO - 'suite': 'dromaeojs', 15:37:44 INFO - 'system_bits': '32', 15:37:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:37:44 INFO - 'title': 't-yosemite-r7-0141', 15:37:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:37:44 INFO - 'use_talos_json': True, 15:37:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:37:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:37:44 INFO - 'work_dir': 'build'} 15:37:44 INFO - [mozharness: 2016-12-02 23:37:44.585927Z] Running clobber step. 15:37:44 INFO - Running pre-action listener: _resource_record_pre_action 15:37:44 INFO - Running main action method: clobber 15:37:44 INFO - rmtree: /builds/slave/test/build 15:37:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:37:46 INFO - Running post-action listener: _resource_record_post_action 15:37:46 INFO - [mozharness: 2016-12-02 23:37:46.735886Z] Finished clobber step (success) 15:37:46 INFO - [mozharness: 2016-12-02 23:37:46.736144Z] Running read-buildbot-config step. 15:37:46 INFO - Running pre-action listener: _resource_record_pre_action 15:37:46 INFO - Running main action method: read_buildbot_config 15:37:46 INFO - Using buildbot properties: 15:37:46 INFO - { 15:37:46 INFO - "project": "", 15:37:46 INFO - "product": "firefox", 15:37:46 INFO - "script_repo_revision": "production", 15:37:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:37:46 INFO - "repository": "", 15:37:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:37:46 INFO - "buildid": "20161202130943", 15:37:46 INFO - "pgo_build": "False", 15:37:46 INFO - "basedir": "/builds/slave/test", 15:37:46 INFO - "buildnumber": 10, 15:37:46 INFO - "slavename": "t-yosemite-r7-0141", 15:37:46 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:37:46 INFO - "platform": "yosemite_r7", 15:37:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:37:46 INFO - "branch": "mozilla-central", 15:37:46 INFO - "repo_path": "mozilla-central", 15:37:46 INFO - "revision": "bfa85d23df57c8a1db17c99b267667becc1c4afd", 15:37:46 INFO - "stage_platform": "macosx64", 15:37:46 INFO - "builduid": "1f85e82a10ea4eba902f878cb8e17694", 15:37:46 INFO - "slavebuilddir": "test" 15:37:46 INFO - } 15:37:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 15:37:46 INFO - Running post-action listener: _resource_record_post_action 15:37:46 INFO - [mozharness: 2016-12-02 23:37:46.742085Z] Finished read-buildbot-config step (success) 15:37:46 INFO - [mozharness: 2016-12-02 23:37:46.742296Z] Running download-and-extract step. 15:37:46 INFO - Running pre-action listener: _resource_record_pre_action 15:37:46 INFO - Running main action method: download_and_extract 15:37:46 INFO - mkdir: /builds/slave/test/build/tests 15:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:46 INFO - trying https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 15:37:46 INFO - Downloading https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:37:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 15:37:47 INFO - Downloaded 1199 bytes. 15:37:47 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:37:47 INFO - Using the following test package requirements: 15:37:47 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:37:47 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:37:47 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 15:37:47 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:37:47 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 15:37:47 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:37:47 INFO - u'jsshell-mac.zip'], 15:37:47 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:37:47 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 15:37:47 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:37:47 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:37:47 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 15:37:47 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:37:47 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 15:37:47 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:37:47 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 15:37:47 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:37:47 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 15:37:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:37:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:37:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:37:47 INFO - Fetch https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:37:48 INFO - Expected file size: 16274943 15:37:48 INFO - Obtained file size: 16274943 15:37:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:37:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:37:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:37:55 INFO - Fetch https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:37:56 INFO - Expected file size: 16274943 15:37:56 INFO - Obtained file size: 16274943 15:38:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 15:38:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:38:02 INFO - Fetch https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 15:38:03 INFO - Expected file size: 14409734 15:38:03 INFO - Obtained file size: 14409734 15:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:03 INFO - trying https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:38:03 INFO - Downloading https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 15:38:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 15:38:06 INFO - Downloaded 107626843 bytes. 15:38:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:38:06 INFO - mkdir: /builds/slave/test/properties 15:38:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:38:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:38:06 INFO - Contents: 15:38:06 INFO - build_url:https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:38:06 INFO - Running post-action listener: _resource_record_post_action 15:38:06 INFO - Running post-action listener: set_extra_try_arguments 15:38:06 INFO - [mozharness: 2016-12-02 23:38:06.980760Z] Finished download-and-extract step (success) 15:38:06 INFO - [mozharness: 2016-12-02 23:38:06.980920Z] Running populate-webroot step. 15:38:06 INFO - Running pre-action listener: _resource_record_pre_action 15:38:06 INFO - Running main action method: populate_webroot 15:38:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:38:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:38:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:38:06 INFO - '--tppagecycles', 15:38:06 INFO - '7'], 15:38:06 INFO - 'tests': ['tsvgm']}}, 15:38:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:38:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:38:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:38:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:38:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:38:06 INFO - 'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:38:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:38:06 INFO - 'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['damp', 'tps']}, 15:38:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:38:06 INFO - 'tests': ['damp', 'tps']}, 15:38:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['dromaeo_dom']}, 15:38:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:38:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['basic_compositor_video']}, 15:38:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:38:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['a11yr', 15:38:06 INFO - 'ts_paint', 15:38:06 INFO - 'tpaint', 15:38:06 INFO - 'sessionrestore', 15:38:06 INFO - 'sessionrestore_no_auto_restore', 15:38:06 INFO - 'tabpaint']}, 15:38:06 INFO - 'other-e10s': {'tests': ['a11yr', 15:38:06 INFO - 'ts_paint', 15:38:06 INFO - 'tpaint', 15:38:06 INFO - 'sessionrestore', 15:38:06 INFO - 'sessionrestore_no_auto_restore', 15:38:06 INFO - 'tabpaint']}, 15:38:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:38:06 INFO - 'ts_paint', 15:38:06 INFO - 'tpaint', 15:38:06 INFO - 'sessionrestore', 15:38:06 INFO - 'sessionrestore_no_auto_restore', 15:38:06 INFO - 'tabpaint']}, 15:38:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:38:06 INFO - 'ts_paint', 15:38:06 INFO - 'tpaint', 15:38:06 INFO - 'sessionrestore', 15:38:06 INFO - 'sessionrestore_no_auto_restore', 15:38:06 INFO - 'tabpaint']}, 15:38:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['a11yr', 15:38:06 INFO - 'ts_paint', 15:38:06 INFO - 'tpaint', 15:38:06 INFO - 'sessionrestore', 15:38:06 INFO - 'sessionrestore_no_auto_restore', 15:38:06 INFO - 'tabpaint']}, 15:38:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['a11yr', 15:38:06 INFO - 'ts_paint', 15:38:06 INFO - 'tpaint', 15:38:06 INFO - 'sessionrestore', 15:38:06 INFO - 'sessionrestore_no_auto_restore', 15:38:06 INFO - 'tabpaint']}, 15:38:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['tsvgx', 15:38:06 INFO - 'tsvgr_opacity', 15:38:06 INFO - 'tart', 15:38:06 INFO - 'tscrollx', 15:38:06 INFO - 'cart', 15:38:06 INFO - 'tsvg_static']}, 15:38:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:38:06 INFO - 'tsvgr_opacity', 15:38:06 INFO - 'tart', 15:38:06 INFO - 'tscrollx', 15:38:06 INFO - 'cart', 15:38:06 INFO - 'tsvg_static']}, 15:38:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:38:06 INFO - 'talos_options': ['--disable-e10s'], 15:38:06 INFO - 'tests': ['tp5o']}, 15:38:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:38:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:38:06 INFO - 'talos_options': ['--disable-e10s', 15:38:06 INFO - '--xperf_path', 15:38:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:06 INFO - 'tests': ['tp5n']}, 15:38:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:38:06 INFO - 'talos_options': ['--xperf_path', 15:38:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:06 INFO - 'tests': ['tp5n']}}, 15:38:06 INFO - 'talos.zip': {'path': '', 15:38:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:38:06 INFO - Running post-action listener: _resource_record_post_action 15:38:06 INFO - [mozharness: 2016-12-02 23:38:06.999642Z] Finished populate-webroot step (success) 15:38:06 INFO - [mozharness: 2016-12-02 23:38:06.999782Z] Running create-virtualenv step. 15:38:06 INFO - Running pre-action listener: _resource_record_pre_action 15:38:07 INFO - Running main action method: create_virtualenv 15:38:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:38:07 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 15:38:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:38:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:38:07 INFO - Using real prefix '/tools/python27' 15:38:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:38:07 INFO - Installing distribute.............................................................................................................................................................................................done. 15:38:10 INFO - Installing pip.................done. 15:38:10 INFO - Return code: 0 15:38:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:38:10 INFO - Reading from file tmpfile_stdout 15:38:10 INFO - Output received: 15:38:10 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) 15:38:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:38: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')]} 15:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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')]} 15:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b1db3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b151570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6bbd7b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, '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.VPF3S2ZztM/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.s9srhEzo9I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:10 INFO - 'HOME': '/Users/cltbld', 15:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:10 INFO - 'LOGNAME': 'cltbld', 15:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:10 INFO - 'MOZ_NO_REMOTE': '1', 15:38:10 INFO - 'NO_EM_RESTART': '1', 15:38:10 INFO - 'PAGER': '/bin/cat', 15:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:10 INFO - 'PWD': '/builds/slave/test', 15:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:10 INFO - 'SHELL': '/bin/bash', 15:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:38:10 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:10 INFO - 'USER': 'cltbld', 15:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:10 INFO - 'XPC_FLAGS': '0x0', 15:38:10 INFO - 'XPC_SERVICE_NAME': '0', 15:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:11 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 15:38:11 INFO - Cleaning up... 15:38:11 INFO - Return code: 0 15:38:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:38:11 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')]} 15:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:11 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')]} 15:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:11 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 0x10b1db3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b151570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6bbd7b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, '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.VPF3S2ZztM/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.s9srhEzo9I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:38:11 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 15:38:11 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 15:38:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:38:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:11 INFO - 'HOME': '/Users/cltbld', 15:38:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:11 INFO - 'LOGNAME': 'cltbld', 15:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:11 INFO - 'MOZ_NO_REMOTE': '1', 15:38:11 INFO - 'NO_EM_RESTART': '1', 15:38:11 INFO - 'PAGER': '/bin/cat', 15:38:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:11 INFO - 'PWD': '/builds/slave/test', 15:38:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:11 INFO - 'SHELL': '/bin/bash', 15:38:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:38:11 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:38:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:11 INFO - 'USER': 'cltbld', 15:38:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:11 INFO - 'XPC_FLAGS': '0x0', 15:38:11 INFO - 'XPC_SERVICE_NAME': '0', 15:38:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:11 INFO - Downloading/unpacking psutil>=3.1.1 15:38:11 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 15:38:11 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 15:38:11 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 15:38:11 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 15:38:11 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 15:38:11 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 15:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:38:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:15 INFO - Installing collected packages: psutil 15:38:15 INFO - Running setup.py install for psutil 15:38:15 INFO - building 'psutil._psutil_osx' extension 15:38:15 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 15:38:15 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 15:38:15 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 15:38:15 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 15:38:15 INFO - building 'psutil._psutil_posix' extension 15:38:15 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 15:38:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:38:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:38:15 INFO - ^ 15:38:15 INFO - 1 warning generated. 15:38:15 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 15:38:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:15 INFO - Successfully installed psutil 15:38:15 INFO - Cleaning up... 15:38:15 INFO - Return code: 0 15:38:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:15 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 0x10b1db3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b151570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6bbd7b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, '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.VPF3S2ZztM/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.s9srhEzo9I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:38:15 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 15:38:15 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 15:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:15 INFO - 'HOME': '/Users/cltbld', 15:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:15 INFO - 'LOGNAME': 'cltbld', 15:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:15 INFO - 'MOZ_NO_REMOTE': '1', 15:38:15 INFO - 'NO_EM_RESTART': '1', 15:38:15 INFO - 'PAGER': '/bin/cat', 15:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:15 INFO - 'PWD': '/builds/slave/test', 15:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:15 INFO - 'SHELL': '/bin/bash', 15:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:38:15 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:15 INFO - 'USER': 'cltbld', 15:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:15 INFO - 'XPC_FLAGS': '0x0', 15:38:15 INFO - 'XPC_SERVICE_NAME': '0', 15:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:38:18 INFO - Installing collected packages: mozsystemmonitor 15:38:18 INFO - Running setup.py install for mozsystemmonitor 15:38:19 INFO - Successfully installed mozsystemmonitor 15:38:19 INFO - Cleaning up... 15:38:19 INFO - Return code: 0 15:38:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b1db3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b151570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6bbd7b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, '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.VPF3S2ZztM/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.s9srhEzo9I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:19 INFO - 'HOME': '/Users/cltbld', 15:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:19 INFO - 'LOGNAME': 'cltbld', 15:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:19 INFO - 'MOZ_NO_REMOTE': '1', 15:38:19 INFO - 'NO_EM_RESTART': '1', 15:38:19 INFO - 'PAGER': '/bin/cat', 15:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:19 INFO - 'PWD': '/builds/slave/test', 15:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:19 INFO - 'SHELL': '/bin/bash', 15:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:38:19 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:19 INFO - 'USER': 'cltbld', 15:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:19 INFO - 'XPC_FLAGS': '0x0', 15:38:19 INFO - 'XPC_SERVICE_NAME': '0', 15:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:19 INFO - Downloading/unpacking jsonschema==2.5.1 15:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:38:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:22 INFO - Downloading functools32-3.2.3-2.tar.gz 15:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:38:22 INFO - warning: no files found matching '*.txt' 15:38:22 INFO - no previously-included directories found matching 'build' 15:38:22 INFO - no previously-included directories found matching 'dist' 15:38:22 INFO - no previously-included directories found matching '.git*' 15:38:22 INFO - Installing collected packages: jsonschema, functools32 15:38:22 INFO - Running setup.py install for functools32 15:38:22 INFO - warning: no files found matching '*.txt' 15:38:22 INFO - no previously-included directories found matching 'build' 15:38:22 INFO - no previously-included directories found matching 'dist' 15:38:22 INFO - no previously-included directories found matching '.git*' 15:38:22 INFO - Successfully installed jsonschema functools32 15:38:22 INFO - Cleaning up... 15:38:22 INFO - Return code: 0 15:38:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:38: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')]} 15:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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')]} 15:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:22 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 0x10b1db3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b151570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6bbd7b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, '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.VPF3S2ZztM/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.s9srhEzo9I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:38:22 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 15:38:22 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 15:38:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:38:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:22 INFO - 'HOME': '/Users/cltbld', 15:38:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:22 INFO - 'LOGNAME': 'cltbld', 15:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:22 INFO - 'MOZ_NO_REMOTE': '1', 15:38:22 INFO - 'NO_EM_RESTART': '1', 15:38:22 INFO - 'PAGER': '/bin/cat', 15:38:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:22 INFO - 'PWD': '/builds/slave/test', 15:38:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:22 INFO - 'SHELL': '/bin/bash', 15:38:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:38:22 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:38:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:22 INFO - 'USER': 'cltbld', 15:38:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:22 INFO - 'XPC_FLAGS': '0x0', 15:38:22 INFO - 'XPC_SERVICE_NAME': '0', 15:38:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:38:22 INFO - Cleaning up... 15:38:22 INFO - Return code: 0 15:38:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:38: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')]} 15:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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')]} 15:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:22 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 0x10b1db3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b151570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6bbd7b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, '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.VPF3S2ZztM/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.s9srhEzo9I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:38:22 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 15:38:22 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 15:38:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:38:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:22 INFO - 'HOME': '/Users/cltbld', 15:38:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:22 INFO - 'LOGNAME': 'cltbld', 15:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:22 INFO - 'MOZ_NO_REMOTE': '1', 15:38:22 INFO - 'NO_EM_RESTART': '1', 15:38:22 INFO - 'PAGER': '/bin/cat', 15:38:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:22 INFO - 'PWD': '/builds/slave/test', 15:38:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:22 INFO - 'SHELL': '/bin/bash', 15:38:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:38:22 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:38:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:22 INFO - 'USER': 'cltbld', 15:38:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:22 INFO - 'XPC_FLAGS': '0x0', 15:38:22 INFO - 'XPC_SERVICE_NAME': '0', 15:38:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:23 INFO - Downloading/unpacking blobuploader==1.2.4 15:38: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 15:38: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 15:38: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 15:38: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 15:38: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 15:38: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 15:38:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:38:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:38:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:38: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 15:38: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 15:38: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 15:38: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 15:38: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 15:38: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 15:38:27 INFO - Downloading docopt-0.6.1.tar.gz 15:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:38:27 INFO - Installing collected packages: blobuploader, requests, docopt 15:38:27 INFO - Running setup.py install for blobuploader 15:38:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:38:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:38:27 INFO - Running setup.py install for requests 15:38:27 INFO - Running setup.py install for docopt 15:38:27 INFO - Successfully installed blobuploader requests docopt 15:38:27 INFO - Cleaning up... 15:38:28 INFO - Return code: 0 15:38:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:28 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 0x10b1db3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b151570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6bbd7b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, '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.VPF3S2ZztM/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.s9srhEzo9I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:38:28 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 15:38:28 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 15:38:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:38:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:28 INFO - 'HOME': '/Users/cltbld', 15:38:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:28 INFO - 'LOGNAME': 'cltbld', 15:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:28 INFO - 'MOZ_NO_REMOTE': '1', 15:38:28 INFO - 'NO_EM_RESTART': '1', 15:38:28 INFO - 'PAGER': '/bin/cat', 15:38:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:28 INFO - 'PWD': '/builds/slave/test', 15:38:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:28 INFO - 'SHELL': '/bin/bash', 15:38:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:38:28 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:38:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:28 INFO - 'USER': 'cltbld', 15:38:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:28 INFO - 'XPC_FLAGS': '0x0', 15:38:28 INFO - 'XPC_SERVICE_NAME': '0', 15:38:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:38:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-opLYju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:38:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-s2eKOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:38:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-URn48B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:38:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-MiKVYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:38:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ekZsqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-fxh83C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-a8p4ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-fv0BXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-o15G44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-XhF6WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Nkg9nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-uAOPoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-aJ6lyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-dS6tLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-kCrCce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-zDRNa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ZWNrWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:38:30 INFO - Running setup.py install for manifestparser 15:38:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:38:30 INFO - Running setup.py install for mozcrash 15:38:30 INFO - Running setup.py install for mozdebug 15:38:30 INFO - Running setup.py install for mozdevice 15:38:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:38:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:38:30 INFO - Running setup.py install for mozfile 15:38:30 INFO - Running setup.py install for mozhttpd 15:38:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:38:30 INFO - Running setup.py install for mozinfo 15:38:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:38:31 INFO - Running setup.py install for mozInstall 15:38:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:38:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:38:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:38:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:38:31 INFO - Running setup.py install for mozleak 15:38:31 INFO - Running setup.py install for mozlog 15:38:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:38:31 INFO - Running setup.py install for moznetwork 15:38:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:38:31 INFO - Running setup.py install for mozprocess 15:38:31 INFO - Running setup.py install for mozprofile 15:38:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:38:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:38:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:38:32 INFO - Running setup.py install for mozrunner 15:38:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:38:32 INFO - Running setup.py install for mozscreenshot 15:38:32 INFO - Running setup.py install for moztest 15:38:32 INFO - Running setup.py install for mozversion 15:38:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:38:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:38:32 INFO - Cleaning up... 15:38:32 INFO - Return code: 0 15:38:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:32 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 0x10b1db3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b151570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6bbd7b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, '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.VPF3S2ZztM/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.s9srhEzo9I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:38:32 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 15:38:32 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 15:38:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:38:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:32 INFO - 'HOME': '/Users/cltbld', 15:38:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:32 INFO - 'LOGNAME': 'cltbld', 15:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:32 INFO - 'MOZ_NO_REMOTE': '1', 15:38:32 INFO - 'NO_EM_RESTART': '1', 15:38:32 INFO - 'PAGER': '/bin/cat', 15:38:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:32 INFO - 'PWD': '/builds/slave/test', 15:38:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:32 INFO - 'SHELL': '/bin/bash', 15:38:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:38:32 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:38:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:32 INFO - 'USER': 'cltbld', 15:38:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:32 INFO - 'XPC_FLAGS': '0x0', 15:38:32 INFO - 'XPC_SERVICE_NAME': '0', 15:38:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:38:32 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-l1RBfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:38:33 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)) 15:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:38:33 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ETv8vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:38:33 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)) 15:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:38:33 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-UeX5Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:38:33 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)) 15:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:38:33 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-WQZ6fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:38:33 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)) 15:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:38:33 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Rk5Jri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:33 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)) 15:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:33 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-KsPCKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:33 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)) 15:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:33 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-VZTiry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:33 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)) 15:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:33 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-PS7c23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:33 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)) 15:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:33 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Jy8jcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:33 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)) 15:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:33 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-yFEQ6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:33 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)) 15:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:33 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-K9jQ6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:34 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)) 15:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:34 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-jdviGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:34 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-p3_hga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:34 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)) 15:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:34 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-mZIxQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:34 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)) 15:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:34 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-qvMAxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:34 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)) 15:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:34 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-k1j7ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:34 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-fLoZ64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:34 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)) 15:38:34 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)) 15:38:34 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)) 15:38:34 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)) 15:38:34 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)) 15:38:34 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)) 15:38:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:38: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 15:38: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 15:38: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 15:38: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 15:38: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 15:38: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 15:38:37 INFO - Downloading blessings-1.6.tar.gz 15:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:38:37 INFO - Installing collected packages: blessings 15:38:37 INFO - Running setup.py install for blessings 15:38:37 INFO - Successfully installed blessings 15:38:37 INFO - Cleaning up... 15:38:37 INFO - Return code: 0 15:38:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:38:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:38:37 INFO - Reading from file tmpfile_stdout 15:38:37 INFO - Current package versions: 15:38:37 INFO - blessings == 1.6 15:38:37 INFO - blobuploader == 1.2.4 15:38:37 INFO - docopt == 0.6.1 15:38:37 INFO - functools32 == 3.2.3-2 15:38:37 INFO - jsonschema == 2.5.1 15:38:37 INFO - manifestparser == 1.1 15:38:37 INFO - mozInstall == 1.12 15:38:37 INFO - mozcrash == 1.0 15:38:37 INFO - mozdebug == 0.1 15:38:37 INFO - mozdevice == 0.49 15:38:37 INFO - mozfile == 1.2 15:38:37 INFO - mozhttpd == 0.7 15:38:37 INFO - mozinfo == 0.9 15:38:37 INFO - mozleak == 0.1 15:38:37 INFO - mozlog == 3.4 15:38:37 INFO - moznetwork == 0.27 15:38:37 INFO - mozprocess == 0.23 15:38:37 INFO - mozprofile == 0.28 15:38:37 INFO - mozrunner == 6.13 15:38:37 INFO - mozscreenshot == 0.1 15:38:37 INFO - mozsystemmonitor == 0.3 15:38:37 INFO - moztest == 0.7 15:38:37 INFO - mozversion == 1.4 15:38:37 INFO - psutil == 3.1.1 15:38:37 INFO - requests == 1.2.3 15:38:37 INFO - wsgiref == 0.1.2 15:38:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:37 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 0x10b1db3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b151570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6bbd7b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, '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.VPF3S2ZztM/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.s9srhEzo9I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:38:37 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 15:38:37 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 15:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:37 INFO - 'HOME': '/Users/cltbld', 15:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:37 INFO - 'LOGNAME': 'cltbld', 15:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:37 INFO - 'MOZ_NO_REMOTE': '1', 15:38:37 INFO - 'NO_EM_RESTART': '1', 15:38:37 INFO - 'PAGER': '/bin/cat', 15:38:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:37 INFO - 'PWD': '/builds/slave/test', 15:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:37 INFO - 'SHELL': '/bin/bash', 15:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:38:37 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:37 INFO - 'USER': 'cltbld', 15:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:37 INFO - 'XPC_FLAGS': '0x0', 15:38:37 INFO - 'XPC_SERVICE_NAME': '0', 15:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:38 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)) 15:38:38 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)) 15:38:38 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)) 15:38:38 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)) 15:38:38 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)) 15:38:38 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)) 15:38:38 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)) 15:38:38 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)) 15:38:38 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)) 15:38:38 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)) 15:38:38 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)) 15:38:38 INFO - Cleaning up... 15:38:38 INFO - Return code: 0 15:38:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:38 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 0x10b1db3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b151570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6bbd7b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, '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.VPF3S2ZztM/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.s9srhEzo9I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 15:38:38 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 15:38:38 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 15:38:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:38:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:38 INFO - 'HOME': '/Users/cltbld', 15:38:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:38 INFO - 'LOGNAME': 'cltbld', 15:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:38 INFO - 'MOZ_NO_REMOTE': '1', 15:38:38 INFO - 'NO_EM_RESTART': '1', 15:38:38 INFO - 'PAGER': '/bin/cat', 15:38:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:38 INFO - 'PWD': '/builds/slave/test', 15:38:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:38 INFO - 'SHELL': '/bin/bash', 15:38:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:38:38 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:38:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:38 INFO - 'USER': 'cltbld', 15:38:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:38 INFO - 'XPC_FLAGS': '0x0', 15:38:38 INFO - 'XPC_SERVICE_NAME': '0', 15:38:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:38:38 INFO - Cleaning up... 15:38:38 INFO - Return code: 0 15:38:38 INFO - Running post-action listener: _resource_record_post_action 15:38:38 INFO - Running post-action listener: _start_resource_monitoring 15:38:38 INFO - Starting resource monitoring. 15:38:38 INFO - [mozharness: 2016-12-02 23:38:38.450688Z] Finished create-virtualenv step (success) 15:38:38 INFO - [mozharness: 2016-12-02 23:38:38.451538Z] Running install step. 15:38:38 INFO - Running pre-action listener: _resource_record_pre_action 15:38:38 INFO - Running main action method: install 15:38:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:38:38 INFO - Reading from file tmpfile_stdout 15:38:38 INFO - Detecting whether we're running mozinstall >=1.0... 15:38:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:38:38 INFO - Reading from file tmpfile_stdout 15:38:38 INFO - Output received: 15:38:38 INFO - Usage: mozinstall [options] installer 15:38:38 INFO - Options: 15:38:38 INFO - -h, --help show this help message and exit 15:38:38 INFO - -d DEST, --destination=DEST 15:38:38 INFO - Directory to install application into. [default: 15:38:38 INFO - "/builds/slave/test"] 15:38:38 INFO - --app=APP Application being installed. [default: firefox] 15:38:38 INFO - mkdir: /builds/slave/test/build/application 15:38:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:39:11 INFO - Reading from file tmpfile_stdout 15:39:11 INFO - Output received: 15:39:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:39:11 INFO - Running post-action listener: _resource_record_post_action 15:39:11 INFO - [mozharness: 2016-12-02 23:39:11.444715Z] Finished install step (success) 15:39:11 INFO - [mozharness: 2016-12-02 23:39:11.444843Z] Running run-tests step. 15:39:11 INFO - Running pre-action listener: _resource_record_pre_action 15:39:11 INFO - Running main action method: run_tests 15:39:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:39:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:39:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:39:11 INFO - 2016-12-02 15:39:11.459 screenresolution[1962:9905] starting screenresolution argv=screenresolution get 15:39:11 INFO - 2016-12-02 15:39:11.462 screenresolution[1962:9905] Display 0: 1600x1200x32@60 15:39:11 INFO - 2016-12-02 15:39:11.468 screenresolution[1963:9907] starting screenresolution argv=screenresolution list 15:39:11 INFO - Available Modes on Display 0 15:39:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:39:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:39:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:39:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:39:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:39:11 INFO - Intel Iris: 15:39:11 INFO - Chipset Model: Intel Iris 15:39:11 INFO - Type: GPU 15:39:11 INFO - Bus: Built-In 15:39:11 INFO - VRAM (Dynamic, Max): 1536 MB 15:39:11 INFO - Vendor: Intel (0x8086) 15:39:11 INFO - Device ID: 0x0a2e 15:39:11 INFO - Revision ID: 0x0009 15:39:11 INFO - Displays: 15:39:11 INFO - Display: 15:39:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:39:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:39:11 INFO - Display Serial Number: 1600x1200 60 15:39:11 INFO - Main Display: Yes 15:39:11 INFO - Mirror: Off 15:39:11 INFO - Online: Yes 15:39:11 INFO - Rotation: Supported 15:39:11 INFO - Return code: 0 15:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:39:11 INFO - Python 2.7.3 15:39:11 INFO - Return code: 0 15:39:11 INFO - grabbing minidump binary from tooltool 15:39:11 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')]} 15:39:11 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 0x10aff0d30>, '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 0x10ae57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afe8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:39:11 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 15:39:11 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 15:39:11 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 15:39:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:39:11 INFO - Return code: 0 15:39:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:39:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:39:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:39:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:39:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--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 15:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0141 --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 15:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VPF3S2ZztM/Render', 15:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:11 INFO - 'HOME': '/Users/cltbld', 15:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:11 INFO - 'LOGNAME': 'cltbld', 15:39:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:39:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:11 INFO - 'MOZ_NO_REMOTE': '1', 15:39:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:39:11 INFO - 'NO_EM_RESTART': '1', 15:39:11 INFO - 'PAGER': '/bin/cat', 15:39:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:11 INFO - 'PWD': '/builds/slave/test', 15:39:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:11 INFO - 'SHELL': '/bin/bash', 15:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s9srhEzo9I/Listeners', 15:39:11 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 15:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:11 INFO - 'USER': 'cltbld', 15:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:11 INFO - 'XPC_FLAGS': '0x0', 15:39:11 INFO - 'XPC_SERVICE_NAME': '0', 15:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--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 15:39:12 INFO - mozversion application_buildid: 20161202130943 15:39:12 INFO - mozversion application_changeset: bfa85d23df57c8a1db17c99b267667becc1c4afd 15:39:12 INFO - mozversion application_display_name: Nightly 15:39:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:39:12 INFO - mozversion application_name: Firefox 15:39:12 INFO - mozversion application_remotingname: firefox 15:39:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:39:12 INFO - mozversion application_vendor: Mozilla 15:39:12 INFO - mozversion application_version: 53.0a1 15:39:12 INFO - mozversion platform_buildid: 20161202130943 15:39:12 INFO - mozversion platform_changeset: bfa85d23df57c8a1db17c99b267667becc1c4afd 15:39:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:39:12 INFO - mozversion platform_version: 53.0a1 15:39:12 INFO - using testdate: 1480721952 15:39:12 INFO - actual date: 1480721952 15:39:12 INFO - starting webserver on 'localhost:49328' 15:39:12 INFO - SUITE-START | Running 2 tests 15:39:12 INFO - TEST-START | dromaeo_css 15:39:12 INFO - operating with platform_type : mac_ 15:39:12 INFO - Initialising browser for dromaeo_css test... 15:39:12 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpt8zv7Q/profile http://localhost:49328/getInfo.html) 15:39:14 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 15:39:14 INFO - PROCESS | 1973 | colorDepth:24 15:39:14 INFO - PROCESS | 1973 | Browser inner width/height: 1024/689 15:39:14 INFO - PROCESS | 1973 | __metrics 15:39:14 INFO - PROCESS | 1973 | 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" 15:39:14 INFO - PROCESS | 1973 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:39:15 INFO - TEST-INFO | 1973: exit 0 15:39:15 INFO - Browser initialized. 15:39:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:39:15 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpt8zv7Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:27 INFO - PROCESS | 1975 | RSS: Main: 238071808 15:39:27 INFO - PROCESS | 1975 | 15:40:19 INFO - PROCESS | 1975 | 1480722019461 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:42:30 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49328/tests/dromaeo/cssquery-ext.html) 15:42:33 INFO - PROCESS | 1975 | RSS: Main: 485949440 15:42:33 INFO - PROCESS | 1975 | 15:45:37 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-ext.html (next: http://localhost:49328/tests/dromaeo/cssquery-jquery.html) 15:45:37 INFO - PROCESS | 1975 | RSS: Main: 382906368 15:45:37 INFO - PROCESS | 1975 | 15:48:40 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49328/tests/dromaeo/cssquery-mootools.html) 15:48:40 INFO - PROCESS | 1975 | RSS: Main: 362049536 15:48:40 INFO - PROCESS | 1975 | 15:51:43 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49328/tests/dromaeo/cssquery-prototype.html) 15:51:43 INFO - PROCESS | 1975 | RSS: Main: 346222592 15:51:43 INFO - PROCESS | 1975 | 15:54:47 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49328/tests/dromaeo/cssquery-yui.html) 15:54:47 INFO - PROCESS | 1975 | RSS: Main: 336711680 15:54:47 INFO - PROCESS | 1975 | 15:57:51 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-yui.html (next: http://localhost:49328/tests/dromaeo/cssquery-dojo.html) 15:57:51 INFO - PROCESS | 1975 | RSS: Main: 404324352 15:57:51 INFO - PROCESS | 1975 | 15:57:51 INFO - PROCESS | 1975 | __start_tp_report 15:57:51 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 15:57:51 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 15:57:51 INFO - PROCESS | 1975 | |i|pagename|runs| 15:57:51 INFO - PROCESS | 1975 | |0;dojo.html;3238.3199528099112;3277;3281.7046465818075;3295.5221492883534;3312.734981201504;5452.236686863842;5472.972635136824;5535.225068490415;5542.085555883279;5552.944470555293;5567.220589117516;5573.247611572437;5678.318601767784;5681.119426488901;5689.175069614914;5024.246363045536;5056.367954005749;5075.543201111899;5116.488351164872;5125.256837758523;5130.050940576006;5208.817691380802;5208.817691380802;5220.947790522084;5245.632805703603;5034.874128146826;5138.229265610151;5150;5153.201253805666;5231.633785635007;5053.267276244924;5084.389873215201;5111.08000559899;5135.332406787131;5140.383154021504;4218.704690671654;5093.108705976476;5100.897982040376;5139.871503212449;5156.948430515685;5572.3870374258795;5576.1356989666265;5583.441655834425;5590.832275031756;5592.273004509429;5894.675792831393;5956.672383018932;5957.374475680078;6099.542534309944;6105.755769769204;6120.908186377208;6129.572745043282;6163.01391777318;6205.193324867739;6211.161493198406;5618.297712785902;5670.829875103754;5679.659220446786;5689.089745640677;5708.029634962025;5217.58259339252;6131.877362452815;6250.249970003629;6258.405451482102;6271.937280627135;5839.948809214382;5853.64878107315;5896.351401345849;5954.940450595525;5956.791512297135;6143.665407145256;6153.323134455206;6156.230471191101;6157.815265542041;6163.229596300463;5970.432808883149;6051.394860513913;6057.636541807506;6061.1514387984835;6080.14877917092;5905.114232865105;5955.493783028491;5964.463198312173;6000.0999850022845;6097.7865774697675;4785.665003449794;4822.132016237111;4830.903381932412;4842.975785121052;4845.781939812717;4264.1471705659;4330.935035974463;4369.951211709167;4376.562343765598;4380.211561918822;5611.130274807411;5620.381758006616;5626.887462250814;5629.831105066854;5642.971785141048;6058.27300723916;6059.939400606026;6062.333143354227;6064.090386441981;6105.511559075263;5593.188987596775;5628.212050312959;5638.210650508932;5642.069058605366;5646.548276137982;5260.237265596467;5267.789288428497;5275.683458992473;5286.709230992333;5290.709011004432;6266.968665156736;6275.246970363585;6277.0270608056735;6284.402981716729;6290.968545157245;5999.670018149044;6059.394060594082;6147.66187859672;6150.630962142286;6155.1075094112;5918.733656985532;5961.493273071664;5981.970090149522;6071.848203794941;6136.243373036893;5682;5689.943100569107;5691.857703557444;5695.914561281667;5702.315722113373;5647.124695672177;5766.625169363978;5768.625039372428;5772.422757724194;5776.56675749312;5114.4374118847645;5756.079027355603;5780.768769249183;5887.146363777314;5893.852653683693;5880.206172166874;5883.911741323969;5885.911711324248;5890.911636325544;5891.882162356815;5741.425857414225;5748.6263392881;5750.827475175752;5753.3958934311295;5758.596898217084;5803.071508558611;5869.8239052828485;5877.617954832922;5879.412058794257;5884.32330282023;4497.415336006298;5012.298278240976;5711.457411545896;5760.222369979999;5776.508996735324 15:57:51 INFO - PROCESS | 1975 | |1;ext.html;441.7283370727003;483.951604839516;484.36306257271684;521.7808520421422;536.9221462887881;30271;38369.23261534771;39506.80246598763;39847.40228896569;41925.371119433235;40600.59399406005;41168.58831411685;41175.55885544007;41176.58823411773;41222.38166427499;8292.419530632858;9131.269498440126;9291;9309.069093090704;9355.34512584116;8284.917150828474;9892.268852950741;10779.407132607703;10797.29817561856;11019.449027548631;11046.226764126515;11125.666230013112;11143;11144.498497567589;11185.217034807567;8293.253607175322;10986;11058.502367393487;11063.114950803916;11066.446677666165;8259.95870020646;10601.31091479059;10956.397398143099;10963.50664220112;11151.665450036431;38688.80655596732;38975.02562435933;38977.22045559073;39021;39023.82928512121;3237.4981877808978;3273.787203831743;3343.314620502791;3365.0914253151755;3621.3300539400293;28879.133625991253;30048.39903201924;30084.097477075724;30166.84916575425;30201.69798302011;3173.4129186100645;3231.2568109334748;3286.917827054343;3317.137544238491;3319.369319829225;433165;437804;438952;440281;441078;55624;55940.16089758657;55992.44007559954;56013.439865601635;56309;50102.248466273035;58360.4163958355;58479.70760146172;60729;60882.69558652267;15231.695366092616;15465.36563907481;15470.690586188213;15481.612959675873;15483.458078967407;10914.345139291669;11181.608643697431;12036.699082523008;12099.516019359304;12103;15980.76028859568;17279.878651051247;18909.810901890804;19003.714944275845;19899;7613.885791713129;7677.385809135256;7716.691332346755;7749.7287594933905;7882.7241046563095;838.2832678060292;913.0734150941508;985.3841349156777;995.9004099590128;1047.3244757131608;27803;28677.713222867504;28999.565006524917;29677.258068548028;29946.25134371658;1000.8498725191134;1035.9274850760526;1042.3902017319801;1053.1416895230363;1102.2890235797865;15110.168940708147;15129.243537823066;15295.12607207085;15474.767878481833;15504.922475387777;586441;588642;589070;589337;590643;56598;57034;57107;57176.856462870506;57203;1317.8616245294297;1339.7540287532688;1364.2564802182635;1367.705943222212;1369.1990185741254;27361.31596710098;28487;28802;29380.118596442142;29537.852310738308;49599;49660.503394965584;49668.50331496639;49698.75150624224;49718.50281497283;576317;578815;578828;580645;580943;26133.99459062156;26680;26808;40555.79722101371;41075.58924410718;44453.333200001376;44912.55087449084;45162.77418612886;45795.08409831851;45834;36677.81661091677;37348.439773402875;37490.625093749804;37675.05812354713;38425.23149536938;37362.25275494529;37397.439038413904;37590.06024849401;38462.42306365463;38542;36050;36462.63537364592;36672;36678.8166059168;36694.8165259172;30238.395232095674;32102.876399325913;32218.516722248718;32225;32260.35479290354;21566.245181418573;24013.51972960566;24563.63154552719;24961.0015599374;25482.362940926625 15:57:51 INFO - PROCESS | 1975 | |2;jquery.html;355.8238671857431;369.90382500549856;370.7905033655984;382.6498753640419;401.9216252830697;14725.337359818806;14906.552803415902;15157.696846063072;15643.452479163232;20427.591448171028;15503.844961550381;16896.47931686148;20303.695444568344;20380.388588342335;20646.690299645517;5392.514673679368;5756.424357564252;5758.165066065418;5759.16492108644;5762.3373312069225;4554.225781617133;4771.9761401192945;5636.4927156555905;5655.7172141392975;5698;5654.491095801377;5667.489925906688;5674.517665998395;5678;5683.318001839785;5489.478499542557;5582.190582365554;5624.831255062334;5670.801521946753;5677.318721753416;4987.625928055374;4999.625028122905;5000.7249601271915;5000.774965126541;5010.949890501085;18987.33544325942;25030.74846257698;25041;25124;25305.746942530524;2260.864348139117;2423.248792874197;2429.186222615426;2509.3475696318906;2723.6459260296233;12220.816687749691;13376.264305463195;15312.923435382863;15379.846201538065;16086.873918825688;1597.7922870026823;1787.3833527433014;1798.2087881332172;1801.846843018345;1969.6750036244002;72796.54406911832;89432;113966.43016784864;114256.28615570773;115560;8292.2951549119;8715.34634902372;10610.416427096583;10827.187960902806;10895.782084358427;13531.864681353061;13549.25479098659;13561.321933903266;13580.59258222235;13581.728365432637;6059.878802423927;7985.960070199611;8265.495305058757;8282.514800794614;8456.619452124669;6729.49528785343;6907.861842763217;8188.058373287148;8229.382796290301;8445;6474.15835941334;6599.538032337787;6620.801375958729;6626.370494802986;6648.401643852077;1760.8679349048873;1790.498660375097;1794.4885707573278;1796.7574377459136;1799.0824679413593;734.944879134067;877.1579283887412;920.2683866326287;943.4150826487621;963.7879666473365;14764.557063288119;20113.29603463901;20274.797252027587;21548.35354939354;21580.784192157877;856.6915910272297;869.3697069624471;891.839468895605;922.1378011559214;940.8541676040225;10665.626703065356;10918.727031824268;10971.780564388668;11009.779804403866;11081.722956926142;545259;548977;551010;560304;561906;89823.10176898148;105611.4719426398;108843.10903202565;123644;126102;911.3802614222525;940.6284517615503;974.449436068619;976.6337623391229;978.7374287169614;18861.528461788566;18975.33586324472;19036;19174.712379314602;19175.80824191796;39760;42857.07143178502;51614.709632259495;52658;53028;67671.6465670674;70838.22904427431;75212;76540.85188722285;78170;7642;7752.108507521707;7977.042754869452;8142.982127234096;8163.387745918961;11174;12262.938685306517;12740.936295318465;12873.35633218354;12887.742245155232;10886.891131088587;10935.453227338443;11077.501512431798;11121.721956951142;11124.833127502932;10510.421926794099;10593.205509586965;11072.612458563912;11080.778384432106;11226.719332016764;10989.670309890716;11022.889771102185;11160.386178760245;11245.550177992789;11411.915867992528;7759.961200193963;7971.402144839044;7985.484572359688;8133.593320333841;8190.7952301192945;10400.687979360631;10646.73383165427;10876.945615271872;10942.398168100832;11063.170262230204 15:57:51 INFO - PROCESS | 1975 | |3;mootools.html;1449.615851799273;1477.039924049368;1623.8538531532167;1756.2184827751655;1808.9457316280516;6829.521933464659;7723.497972631782;8172.836543269131;8189.590520473982;8193.959030204847;7215.24239954805;7451.292127247916;7454.962725186367;7669.501482403653;7947;2223.855449395788;2272.0457407888644;2274.920377786778;2282.2468585366873;2284.3946354216146;1984.791596882321;2254.6843441918145;2288.8626682399026;2296.1389478945393;2312.560613483441;2257.085880218514;2268.6710426988075;2284.360379093848;2289.839711220215;2295.2196253273883;1924.3457224543652;2157.9460513487134;2238.809701175402;2239.7200349956256;2245.8315626327926;2233.475133343663;2254.2786308381324;2267.8299127565497;2272.6477396003647;2273.1134857405623;7861.606919654052;8157.388195885273;8158.143394943564;8170.632321545545;8172.060213075513;4901.3383193269165;5101.234814777776;5102.056119617882;5106.489351064901;5111;3213.2770126721534;3458.2564748579175;3514.824258787076;3558.839852206657;3559.982200088983;781.4568874632133;814.8777683347486;1030.6907927621683;1082.8267477203688;1085.6417382263835;10588.523516441779;10624.150067994542;10625;10643.946780266126;10648.787024259549;4445.310976798602;4477.910441791211;4568.314752787042;4614.123316569908;4660.86017419478;8515.403921725543;8559.871601925975;8560.101189375026;8572.657093716181;8587.270082043096;4973.900521989613;4981.601471882241;4982.975085124551;4984.750762461862;4987.251912213197;3933.1740334529495;4372.934405983913;4607.815687372535;4661.394018777537;4669.182892993713;3531.487934249571;3540.0175901495245;3591.2996965591983;3650.7809531428197;3656.433252845813;1127.560251501915;1128.4100851030023;1133.3256712256195;1144.2562334482486;1145.9140564457698;772.7179579453572;783.9098503672037;784.2275358771606;863.9308855291562;876.3690143097087;5192.4807519248525;5328.653637513549;5350.946490535122;5390.164524498709;5449.455054494598;434.81303039693233;438.85737135430475;442.62376979567756;448.6679856905866;928.572856486024;3761.4733937248807;3778.8299526521373;3877.7673339599714;3890.183061557048;3938.468306778548;8630.78423039429;9261.351705380694;9293.535323233811;9935;9947.303688741718;9841.114299712917;9862;9877.456739879231;9887.851682224773;9907.603695852085;7274.381677557467;7464.253574642492;7468.551886886804;7470.252974702595;7479.551226926293;4612.723236605814;4925.1873440881855;5316.734163291742;5490.792025754327;5783.595148339576;9089.136532029446;9235.953820231125;9239.907600924174;9249.86125208109;9260.629574816932;9063.456192628464;9226.169644732006;9353.204977576983;9441.952790236004;9460.337776355589;6418.390252925965;6625.602463852184;6784.2876497967;6912.930870691229;7054.470914681317;7774.6890124394395;7805.765827025199;7860.5676687782725;7865.528068315919;7884.763457096296;6870.725170993104;6930.965345173242;6962.094927659372;6999.720011199495;7087.433005359662;6834.2482326943;6863.828404289933;6874.896876546756;6914.135733033371;6927.445804335742;6346.841328966628;6514.902276465762;6545.803625891231;6569.277379488157;6600.174978127734;4592.104539614743;4646.721196728207;4658.138244424792;4686.554777296152;4863;4518.231900576976;4643.698159619749;4701.717896926195;4726.740029298421;4843.152448321459 15:57:51 INFO - PROCESS | 1975 | |4;prototype.html;302.3258134360376;305.16080777860884;310.2739589360895;314.76707236644876;319.3819958380535;4607.654425918061;4966.130927087764;5169.793208271674;5224.45143259958;5305.65513241639;4312.74123552587;4904.852854414365;5027.34644496215;5087.667577736588;5098.31172791673;3369.427197376452;3980.44273801668;4049.2508885856064;4054.3310353791735;4055.9797201013953;3330.9167270818302;3518.6833185013343;4016.6385025347713;4058.1072164123993;4101.589841015904;3012.141539661197;3341.448660970937;4047.219223541647;4051.392291156321;4064.4106604542326;3073.8770449182007;3562.536870206882;3622.565292164957;3982.5619181890115;4004.5194576650697;2503.68703912011;3334.549835772164;3416.6754158354915;3433.111788516331;3433.2275238071484;4116.0327323079055;4649.582556820734;4831.840358314014;5054.465360430323;5129.332746971554;4049.291374009566;4239.682023848224;4372.781360931941;4498.190325741365;4507.5659144062165;4497.7526236057;5019.749012549358;5445.957765837811;5483.561315094823;5489.313835770528;2917.547780094089;3527.918528068452;3748.850045998157;3760.905977350561;3782.224643947984;5261.447872877472;5543.1408131739645;5581.804636837732;5594.14698503766;5786.479216870502;3325.7339412846914;3491.266833964896;3679.7672779618592;3793.203427280302;3816.6450909926575;3423.383790917609;3873.4189871519498;3898.310165985461;3899.629535194152;3911.6675082617726;3659.2681463707363;4387.298032314814;4443.7111587746695;4465.263231566755;4482.574155455227;4525.0497395546645;5341.077212203603;5369.48989845964;5400.21696853954;5492.835214943558;1205.825155352469;1207.927524348542;1212.751385965875;1220.6338098570393;1234.2902830872285;719.9496035277481;774.5585016540631;786.6302837666287;787.4605894961969;805.7381351060928;4385.846495372711;4443.51184320307;4873.220284754422;4974.433053588108;5060.266261392151;5581.553475721932;5647.519960803295;5649.519790817744;5654.830355089354;5727.971360143172;4732.556570246039;5029.742332016408;5066.493350664904;5156.613254005964;5161.793528258828;2508.94982100357;2782.4156927045547;2785.860706964684;2787.205646390769;2807.9438411231663;4722.527747225318;4907.705537667752;5003.449620541737;5034.910512137495;5589.105743081169;4513.826405134623;4807.870150514626;5089.109405853961;5228.503292187236;5405.081316045836;4364.498082720528;4680.578747912704;5272.657277276965;5338.702344612624;5522.0336441122645;4661.641365323298;4748.477667456508;5204.446109654053;5360.874216414597;5370.4629537045985;4210.873673789792;4377.146456440963;4431.623312018385;5104.617153713412;5128.974355128201;4931.6301277405055;5012;5575.358833734011;5591.356993945748;5654.660720356792;3404.608470025979;3522.260325331709;3549.8225088745976;3552.9467057993634;3579.3736096183584;4851.234796166152;4939.382577177853;4946.802127914843;5207.635465517377;5345.545628621455;4443.511213766547;5199.740012999259;5214.722393013736;5221.746780772663;5224.660397074178;4417.757023363617;4470.552944705503;4529.376498801012;5167.896642067213;5224.97676788878;4902.534259245366;4994.400671919393;5225.790968361223;5375.758090885842;5440.863978400572;5079;5420.457954204548;5450.209719590716;5454.427285135003;5605.831825045255;4658.440987081572;4978.32792572998;5092.4468037249;5477.945220547744;5503.422140675171 15:57:51 INFO - PROCESS | 1975 | |5;yui.html;684.4729558240156;716.0691101567963;748.2554857916374;788.9211078892108;791.469715290755;15378.231088445575;15915.204239788007;15921.203939803021;15929.362825486967;15929.44246951357;14353.99522033458;14527.636809079779;14529.927350363234;14551.490697825579;14595.708085838276;662.8475450646354;693.2270518372004;792.0614072324314;806.6168569929296;836.4437648963462;818.0960039156736;820.4666966471782;823.9464434811748;824.8968878890139;834.8079941613432;888.3248730964449;889.5774507109136;890.8797312362813;891.7993451473399;892.1658249536672;888.6667499687617;891.1400498518896;891.1534042659467;892.1925657280171;892.6518657723428;520.6979951628047;534.3854567247657;540.4622400711278;546.6200990311735;659.2451642868937;12458.43937022827;14163.008589398747;14730.116193028452;14733.55799326022;15102.244887755569;14299.78550321746;14595.197264150467;14621;14671.926640366837;14704.26478676062;11582.305061696325;11986.820197697041;12090.637280881587;12149.962509372657;12320.445579948924;3363.630000699921;3646.4894914711963;3759.755615884959;3929.941050884239;3984.4023396490757;102320;113551;116134;117368;118347;10364.844527332096;11345.149113816497;11378.08975281992;11423.61318891744;11433.950112704566;22959.770402295762;23100.306990789966;23126.537469250856;23158.76841231566;23352.883235583715;7717.729879454305;7747.845043099219;7764.029496312961;7779;7966.123726390092;3095.90712278632;3969.583193764613;4054.722268007222;4072.2466343725914;4145.440365550672;3448.896533104011;3565.536480257602;3576.91057723559;3591.7665351752053;3617.4935509028755;622.3465361370543;631.5957787016313;637.9521535884735;640.6316368088368;642.996785016072;564.4524810933389;576.9336526299529;586.7125108696794;617.521420898807;657.7007461604958;7553.357964572963;8740.08283019807;9121.36150469474;9376.203022743006;9425.905740942502;554.8874506614293;603.9607425517328;649.3182158733312;650.9479241660656;673.8820706376463;4309.267424537836;4329.328954012133;4441.578050085237;4452.888677783081;4477.753723545171;116309;116745;117272.41363793127;118865;120540.39729801471;86951;103899;105633.04238279512;106457.46771266249;108350;73184;76933.23066769373;78883.60558197173;81272;87550.56224718835;8328.833963245272;9029.548522573714;9053.321000925089;9258.305627077862;9867.851982220416;41480.37779433371;52509;53197;53456.396308110816;56750;76339;78124.60937695502;78554;78569.60715196388;80940;10268.383896966207;12561.05792065617;12621.305828179538;12683.746325073631;13059.281739504419;11712.590059348222;13857.099288546213;14241.50154744579;14729.410823566937;15282.388704452142;13093.476260949456;13141.934290328487;13332.403389644498;13389.866101339252;13699.794503082661;12086.395680215777;13512.324383780575;13947;14102;14231.288435577973;12692.238465692088;13446.596602101952;13618.978576606596;13688.041837071309;13692.726145477234;9483.910866399268;10508.264421490423;11067.335959842436;11105.722356940818;11522.82715759281;11215.55137794479;11305.434728263719;11360.886391136313;11383.317000979967;11533.88466115328 15:57:51 INFO - PROCESS | 1975 | __end_tp_report 15:57:51 INFO - PROCESS | 1975 | __start_cc_report 15:57:51 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,2917 15:57:51 INFO - PROCESS | 1975 | __end_cc_report 15:57:51 INFO - PROCESS | 1975 | __startTimestamp1480723071433__endTimestamp 15:57:51 INFO - PROCESS | 1975 | 15:57:51 INFO - PROCESS | 1975 | ------- Summary: start ------- 15:57:51 INFO - PROCESS | 1975 | Number of tests: 6 15:57:51 INFO - PROCESS | 1975 | 15:57:51 INFO - PROCESS | 1975 | [#0] dojo.html Cycles:165 Average:5563.03 Median:5695.91 stddev:615.54 (10.8%) stddev-sans-first:589.79 15:57:51 INFO - PROCESS | 1975 | Values: 3238.3 3277.0 3281.7 3295.5 3312.7 5452.2 5473.0 5535.2 5542.1 5552.9 5567.2 5573.2 5678.3 5681.1 5689.2 5024.2 5056.4 5075.5 5116.5 5125.3 5130.1 5208.8 5208.8 5220.9 5245.6 5034.9 5138.2 5150.0 5153.2 5231.6 5053.3 5084.4 5111.1 5135.3 5140.4 4218.7 5093.1 5100.9 5139.9 5156.9 5572.4 5576.1 5583.4 5590.8 5592.3 5894.7 5956.7 5957.4 6099.5 6105.8 6120.9 6129.6 6163.0 6205.2 6211.2 5618.3 5670.8 5679.7 5689.1 5708.0 5217.6 6131.9 6250.2 6258.4 6271.9 5839.9 5853.6 5896.4 5954.9 5956.8 6143.7 6153.3 6156.2 6157.8 6163.2 5970.4 6051.4 6057.6 6061.2 6080.1 5905.1 5955.5 5964.5 6000.1 6097.8 4785.7 4822.1 4830.9 4843.0 4845.8 4264.1 4330.9 4370.0 4376.6 4380.2 5611.1 5620.4 5626.9 5629.8 5643.0 6058.3 6059.9 6062.3 6064.1 6105.5 5593.2 5628.2 5638.2 5642.1 5646.5 5260.2 5267.8 5275.7 5286.7 5290.7 6267.0 6275.2 6277.0 6284.4 6291.0 5999.7 6059.4 6147.7 6150.6 6155.1 5918.7 5961.5 5982.0 6071.8 6136.2 5682.0 5689.9 5691.9 5695.9 5702.3 5647.1 5766.6 5768.6 5772.4 5776.6 5114.4 5756.1 5780.8 5887.1 5893.9 5880.2 5883.9 5885.9 5890.9 5891.9 5741.4 5748.6 5750.8 5753.4 5758.6 5803.1 5869.8 5877.6 5879.4 5884.3 4497.4 5012.3 5711.5 5760.2 5776.5 15:57:51 INFO - PROCESS | 1975 | 15:57:51 INFO - PROCESS | 1975 | [#1] ext.html Cycles:180 Average:66876.32 Median:36686.82 stddev:144067.45 (392.7%) stddev-sans-first:144385.25 15:57:51 INFO - PROCESS | 1975 | Values: 441.7 484.0 484.4 521.8 536.9 30271.0 38369.2 39506.8 39847.4 41925.4 40600.6 41168.6 41175.6 41176.6 41222.4 8292.4 9131.3 9291.0 9309.1 9355.3 8284.9 9892.3 10779.4 10797.3 11019.4 11046.2 11125.7 11143.0 11144.5 11185.2 8293.3 10986.0 11058.5 11063.1 11066.4 8260.0 10601.3 10956.4 10963.5 11151.7 38688.8 38975.0 38977.2 39021.0 39023.8 3237.5 3273.8 3343.3 3365.1 3621.3 28879.1 30048.4 30084.1 30166.8 30201.7 3173.4 3231.3 3286.9 3317.1 3319.4 433165.0 437804.0 438952.0 440281.0 441078.0 55624.0 55940.2 55992.4 56013.4 56309.0 50102.2 58360.4 58479.7 60729.0 60882.7 15231.7 15465.4 15470.7 15481.6 15483.5 10914.3 11181.6 12036.7 12099.5 12103.0 15980.8 17279.9 18909.8 19003.7 19899.0 7613.9 7677.4 7716.7 7749.7 7882.7 838.3 913.1 985.4 995.9 1047.3 27803.0 28677.7 28999.6 29677.3 29946.3 1000.8 1035.9 1042.4 1053.1 1102.3 15110.2 15129.2 15295.1 15474.8 15504.9 586441.0 588642.0 589070.0 589337.0 590643.0 56598.0 57034.0 57107.0 57176.9 57203.0 1317.9 1339.8 1364.3 1367.7 1369.2 27361.3 28487.0 28802.0 29380.1 29537.9 49599.0 49660.5 49668.5 49698.8 49718.5 576317.0 578815.0 578828.0 580645.0 580943.0 26134.0 26680.0 26808.0 40555.8 41075.6 44453.3 44912.6 45162.8 45795.1 45834.0 36677.8 37348.4 37490.6 37675.1 38425.2 37362.3 37397.4 37590.1 38462.4 38542.0 36050.0 36462.6 36672.0 36678.8 36694.8 30238.4 32102.9 32218.5 32225.0 32260.4 21566.2 24013.5 24563.6 24961.0 25482.4 15:57:51 INFO - PROCESS | 1975 | 15:57:51 INFO - PROCESS | 1975 | [#2] jquery.html Cycles:180 Average:32339.66 Median:362.86 stddev:92024.53 (25360.6%) stddev-sans-first:92251.34 15:57:51 INFO - PROCESS | 1975 | Values: 355.8 369.9 370.8 382.6 401.9 14725.3 14906.6 15157.7 15643.5 20427.6 15503.8 16896.5 20303.7 20380.4 20646.7 5392.5 5756.4 5758.2 5759.2 5762.3 4554.2 4772.0 5636.5 5655.7 5698.0 5654.5 5667.5 5674.5 5678.0 5683.3 5489.5 5582.2 5624.8 5670.8 5677.3 4987.6 4999.6 5000.7 5000.8 5010.9 18987.3 25030.7 25041.0 25124.0 25305.7 2260.9 2423.2 2429.2 2509.3 2723.6 12220.8 13376.3 15312.9 15379.8 16086.9 1597.8 1787.4 1798.2 1801.8 1969.7 72796.5 89432.0 113966.4 114256.3 115560.0 8292.3 8715.3 10610.4 10827.2 10895.8 13531.9 13549.3 13561.3 13580.6 13581.7 6059.9 7986.0 8265.5 8282.5 8456.6 6729.5 6907.9 8188.1 8229.4 8445.0 6474.2 6599.5 6620.8 6626.4 6648.4 1760.9 1790.5 1794.5 1796.8 1799.1 734.9 877.2 920.3 943.4 963.8 14764.6 20113.3 20274.8 21548.4 21580.8 856.7 869.4 891.8 922.1 940.9 10665.6 10918.7 10971.8 11009.8 11081.7 545259.0 548977.0 551010.0 560304.0 561906.0 89823.1 105611.5 108843.1 123644.0 126102.0 911.4 940.6 974.4 976.6 978.7 18861.5 18975.3 19036.0 19174.7 19175.8 39760.0 42857.1 51614.7 52658.0 53028.0 67671.6 70838.2 75212.0 76540.9 78170.0 7642.0 7752.1 7977.0 8143.0 8163.4 11174.0 12262.9 12740.9 12873.4 12887.7 10886.9 10935.5 11077.5 11121.7 11124.8 10510.4 10593.2 11072.6 11080.8 11226.7 10989.7 11022.9 11160.4 11245.6 11411.9 7760.0 7971.4 7985.5 8133.6 8190.8 10400.7 10646.7 10876.9 10942.4 11063.2 15:57:51 INFO - PROCESS | 1975 | 15:57:51 INFO - PROCESS | 1975 | [#3] mootools.html Cycles:180 Average:5250.96 Median:5101.65 stddev:2886.87 (56.6%) stddev-sans-first:2880.83 15:57:51 INFO - PROCESS | 1975 | Values: 1449.6 1477.0 1623.9 1756.2 1808.9 6829.5 7723.5 8172.8 8189.6 8194.0 7215.2 7451.3 7455.0 7669.5 7947.0 2223.9 2272.0 2274.9 2282.2 2284.4 1984.8 2254.7 2288.9 2296.1 2312.6 2257.1 2268.7 2284.4 2289.8 2295.2 1924.3 2157.9 2238.8 2239.7 2245.8 2233.5 2254.3 2267.8 2272.6 2273.1 7861.6 8157.4 8158.1 8170.6 8172.1 4901.3 5101.2 5102.1 5106.5 5111.0 3213.3 3458.3 3514.8 3558.8 3560.0 781.5 814.9 1030.7 1082.8 1085.6 10588.5 10624.2 10625.0 10643.9 10648.8 4445.3 4477.9 4568.3 4614.1 4660.9 8515.4 8559.9 8560.1 8572.7 8587.3 4973.9 4981.6 4983.0 4984.8 4987.3 3933.2 4372.9 4607.8 4661.4 4669.2 3531.5 3540.0 3591.3 3650.8 3656.4 1127.6 1128.4 1133.3 1144.3 1145.9 772.7 783.9 784.2 863.9 876.4 5192.5 5328.7 5350.9 5390.2 5449.5 434.8 438.9 442.6 448.7 928.6 3761.5 3778.8 3877.8 3890.2 3938.5 8630.8 9261.4 9293.5 9935.0 9947.3 9841.1 9862.0 9877.5 9887.9 9907.6 7274.4 7464.3 7468.6 7470.3 7479.6 4612.7 4925.2 5316.7 5490.8 5783.6 9089.1 9236.0 9239.9 9249.9 9260.6 9063.5 9226.2 9353.2 9442.0 9460.3 6418.4 6625.6 6784.3 6912.9 7054.5 7774.7 7805.8 7860.6 7865.5 7884.8 6870.7 6931.0 6962.1 6999.7 7087.4 6834.2 6863.8 6874.9 6914.1 6927.4 6346.8 6514.9 6545.8 6569.3 6600.2 4592.1 4646.7 4658.1 4686.6 4863.0 4518.2 4643.7 4701.7 4726.7 4843.2 15:57:51 INFO - PROCESS | 1975 | 15:57:51 INFO - PROCESS | 1975 | [#4] prototype.html Cycles:180 Average:4258.55 Median:4727.54 stddev:1312.29 (27.8%) stddev-sans-first:1281.94 15:57:51 INFO - PROCESS | 1975 | Values: 302.3 305.2 310.3 314.8 319.4 4607.7 4966.1 5169.8 5224.5 5305.7 4312.7 4904.9 5027.3 5087.7 5098.3 3369.4 3980.4 4049.3 4054.3 4056.0 3330.9 3518.7 4016.6 4058.1 4101.6 3012.1 3341.4 4047.2 4051.4 4064.4 3073.9 3562.5 3622.6 3982.6 4004.5 2503.7 3334.5 3416.7 3433.1 3433.2 4116.0 4649.6 4831.8 5054.5 5129.3 4049.3 4239.7 4372.8 4498.2 4507.6 4497.8 5019.7 5446.0 5483.6 5489.3 2917.5 3527.9 3748.9 3760.9 3782.2 5261.4 5543.1 5581.8 5594.1 5786.5 3325.7 3491.3 3679.8 3793.2 3816.6 3423.4 3873.4 3898.3 3899.6 3911.7 3659.3 4387.3 4443.7 4465.3 4482.6 4525.0 5341.1 5369.5 5400.2 5492.8 1205.8 1207.9 1212.8 1220.6 1234.3 719.9 774.6 786.6 787.5 805.7 4385.8 4443.5 4873.2 4974.4 5060.3 5581.6 5647.5 5649.5 5654.8 5728.0 4732.6 5029.7 5066.5 5156.6 5161.8 2508.9 2782.4 2785.9 2787.2 2807.9 4722.5 4907.7 5003.4 5034.9 5589.1 4513.8 4807.9 5089.1 5228.5 5405.1 4364.5 4680.6 5272.7 5338.7 5522.0 4661.6 4748.5 5204.4 5360.9 5370.5 4210.9 4377.1 4431.6 5104.6 5129.0 4931.6 5012.0 5575.4 5591.4 5654.7 3404.6 3522.3 3549.8 3552.9 3579.4 4851.2 4939.4 4946.8 5207.6 5345.5 4443.5 5199.7 5214.7 5221.7 5224.7 4417.8 4470.6 4529.4 5167.9 5225.0 4902.5 4994.4 5225.8 5375.8 5440.9 5079.0 5420.5 5450.2 5454.4 5605.8 4658.4 4978.3 5092.4 5477.9 5503.4 15:57:51 INFO - PROCESS | 1975 | 15:57:51 INFO - PROCESS | 1975 | [#5] yui.html Cycles:180 Average:21813.21 Median:3703.12 stddev:32806.52 (885.9%) stddev-sans-first:32860.19 15:57:51 INFO - PROCESS | 1975 | Values: 684.5 716.1 748.3 788.9 791.5 15378.2 15915.2 15921.2 15929.4 15929.4 14354.0 14527.6 14529.9 14551.5 14595.7 662.8 693.2 792.1 806.6 836.4 818.1 820.5 823.9 824.9 834.8 888.3 889.6 890.9 891.8 892.2 888.7 891.1 891.2 892.2 892.7 520.7 534.4 540.5 546.6 659.2 12458.4 14163.0 14730.1 14733.6 15102.2 14299.8 14595.2 14621.0 14671.9 14704.3 11582.3 11986.8 12090.6 12150.0 12320.4 3363.6 3646.5 3759.8 3929.9 3984.4 102320.0 113551.0 116134.0 117368.0 118347.0 10364.8 11345.1 11378.1 11423.6 11434.0 22959.8 23100.3 23126.5 23158.8 23352.9 7717.7 7747.8 7764.0 7779.0 7966.1 3095.9 3969.6 4054.7 4072.2 4145.4 3448.9 3565.5 3576.9 3591.8 3617.5 622.3 631.6 638.0 640.6 643.0 564.5 576.9 586.7 617.5 657.7 7553.4 8740.1 9121.4 9376.2 9425.9 554.9 604.0 649.3 650.9 673.9 4309.3 4329.3 4441.6 4452.9 4477.8 116309.0 116745.0 117272.4 118865.0 120540.4 86951.0 103899.0 105633.0 106457.5 108350.0 73184.0 76933.2 78883.6 81272.0 87550.6 8328.8 9029.5 9053.3 9258.3 9867.9 41480.4 52509.0 53197.0 53456.4 56750.0 76339.0 78124.6 78554.0 78569.6 80940.0 10268.4 12561.1 12621.3 12683.7 13059.3 11712.6 13857.1 14241.5 14729.4 15282.4 13093.5 13141.9 13332.4 13389.9 13699.8 12086.4 13512.3 13947.0 14102.0 14231.3 12692.2 13446.6 13619.0 13688.0 13692.7 9483.9 10508.3 11067.3 11105.7 11522.8 11215.6 11305.4 11360.9 11383.3 11533.9 15:57:51 INFO - PROCESS | 1975 | -------- Summary: end -------- 15:57:51 INFO - PROCESS | 1975 | 15:57:52 INFO - TEST-INFO | 1975: exit 0 15:57:52 INFO - TEST-OK | dromaeo_css | took 1120076ms 15:57:52 INFO - TEST-START | kraken 15:57:52 INFO - operating with platform_type : mac_ 15:57:52 INFO - Initialising browser for kraken test... 15:57:52 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpSzfOgU/profile http://localhost:49328/getInfo.html) 15:57:54 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 15:57:54 INFO - PROCESS | 1977 | colorDepth:24 15:57:54 INFO - PROCESS | 1977 | Browser inner width/height: 1024/689 15:57:54 INFO - PROCESS | 1977 | __metrics 15:57:54 INFO - PROCESS | 1977 | 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" 15:57:54 INFO - PROCESS | 1977 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:57:55 INFO - TEST-INFO | 1977: exit 0 15:57:55 INFO - Browser initialized. 15:57:55 INFO - Running cycle 1/1 for kraken test... 15:57:55 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpSzfOgU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:58:08 INFO - PROCESS | 1978 | RSS: Main: 244137984 15:58:08 INFO - PROCESS | 1978 | 15:58:10 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49328/tests/kraken/driver.html?testName=audio-beat-detection) 15:58:11 INFO - PROCESS | 1978 | RSS: Main: 294985728 15:58:11 INFO - PROCESS | 1978 | 15:58:14 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49328/tests/kraken/driver.html?testName=audio-dft) 15:58:14 INFO - PROCESS | 1978 | RSS: Main: 296243200 15:58:14 INFO - PROCESS | 1978 | 15:58:18 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49328/tests/kraken/driver.html?testName=audio-fft) 15:58:18 INFO - PROCESS | 1978 | RSS: Main: 386719744 15:58:18 INFO - PROCESS | 1978 | 15:58:20 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49328/tests/kraken/driver.html?testName=audio-oscillator) 15:58:21 INFO - PROCESS | 1978 | RSS: Main: 290668544 15:58:21 INFO - PROCESS | 1978 | 15:58:23 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49328/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:58:24 INFO - PROCESS | 1978 | RSS: Main: 294096896 15:58:24 INFO - PROCESS | 1978 | 15:58:27 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49328/tests/kraken/driver.html?testName=imaging-darkroom) 15:58:27 INFO - PROCESS | 1978 | RSS: Main: 337281024 15:58:27 INFO - PROCESS | 1978 | 15:58:30 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49328/tests/kraken/driver.html?testName=imaging-desaturate) 15:58:31 INFO - PROCESS | 1978 | RSS: Main: 338268160 15:58:31 INFO - PROCESS | 1978 | 15:58:34 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49328/tests/kraken/driver.html?testName=json-parse-financial) 15:58:34 INFO - PROCESS | 1978 | RSS: Main: 337563648 15:58:34 INFO - PROCESS | 1978 | 15:58:36 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49328/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:58:37 INFO - PROCESS | 1978 | RSS: Main: 309952512 15:58:37 INFO - PROCESS | 1978 | 15:58:39 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:58:39 INFO - PROCESS | 1978 | RSS: Main: 313270272 15:58:39 INFO - PROCESS | 1978 | 15:58:42 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:58:42 INFO - PROCESS | 1978 | RSS: Main: 315965440 15:58:42 INFO - PROCESS | 1978 | 15:58:45 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:58:46 INFO - PROCESS | 1978 | RSS: Main: 333369344 15:58:46 INFO - PROCESS | 1978 | 15:58:49 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:58:50 INFO - PROCESS | 1978 | RSS: Main: 326680576 15:58:50 INFO - PROCESS | 1978 | 15:58:51 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49328/tests/kraken/driver.html?testName=ai-astar) 15:58:52 INFO - PROCESS | 1978 | RSS: Main: 370163712 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | __start_tp_report 15:58:52 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 15:58:52 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 15:58:52 INFO - PROCESS | 1978 | |i|pagename|runs| 15:58:52 INFO - PROCESS | 1978 | |0;ai-astar;112;115;115;114;113;114;114;114;112;113 15:58:52 INFO - PROCESS | 1978 | |1;audio-beat-detection;157;117;114;153;112;114;115;113;134;112 15:58:52 INFO - PROCESS | 1978 | |2;audio-dft;184;183;183;183;185;183;180;181;183;184 15:58:52 INFO - PROCESS | 1978 | |3;audio-fft;83;75;81;114;63;58;59;59;75;61 15:58:52 INFO - PROCESS | 1978 | |4;audio-oscillator;90;70;87;70;68;69;78;67;69;83 15:58:52 INFO - PROCESS | 1978 | |5;imaging-gaussian-blur;93;107;121;130;86;84;87;84;86;84 15:58:52 INFO - PROCESS | 1978 | |6;imaging-darkroom;93;93;93;96;93;93;112;158;94;102 15:58:52 INFO - PROCESS | 1978 | |7;imaging-desaturate;86;88;86;109;140;137;87;85;87;85 15:58:52 INFO - PROCESS | 1978 | |8;json-parse-financial;59;56;56;56;56;59;56;58;56;56 15:58:52 INFO - PROCESS | 1978 | |9;json-stringify-tinderbox;64;73;71;79;95;94;104;104;107;60 15:58:52 INFO - PROCESS | 1978 | |10;stanford-crypto-aes;89;88;87;86;87;86;88;86;88;89 15:58:52 INFO - PROCESS | 1978 | |11;stanford-crypto-ccm;150;156;156;159;167;151;143;147;197;162 15:58:52 INFO - PROCESS | 1978 | |12;stanford-crypto-pbkdf2;174;173;175;173;176;176;176;173;174;180 15:58:52 INFO - PROCESS | 1978 | |13;stanford-crypto-sha256-iterative;69;71;70;69;70;68;69;69;70;70 15:58:52 INFO - PROCESS | 1978 | __end_tp_report 15:58:52 INFO - PROCESS | 1978 | __start_cc_report 15:58:52 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,2030 15:58:52 INFO - PROCESS | 1978 | __end_cc_report 15:58:52 INFO - PROCESS | 1978 | __startTimestamp1480723132006__endTimestamp 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | ------- Summary: start ------- 15:58:52 INFO - PROCESS | 1978 | Number of tests: 14 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:0.97 15:58:52 INFO - PROCESS | 1978 | Values: 112.0 115.0 115.0 114.0 113.0 114.0 114.0 114.0 112.0 113.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:116.00 stddev:17.54 (15.1%) stddev-sans-first:13.99 15:58:52 INFO - PROCESS | 1978 | Values: 157.0 117.0 114.0 153.0 112.0 114.0 115.0 113.0 134.0 112.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.00 stddev:1.45 (0.8%) stddev-sans-first:1.48 15:58:52 INFO - PROCESS | 1978 | Values: 184.0 183.0 183.0 183.0 185.0 183.0 180.0 181.0 183.0 184.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#3] audio-fft Cycles:10 Average:72.80 Median:69.00 stddev:17.36 (25.2%) stddev-sans-first:18.02 15:58:52 INFO - PROCESS | 1978 | Values: 83.0 75.0 81.0 114.0 63.0 58.0 59.0 59.0 75.0 61.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:74.00 stddev:8.67 (11.7%) stddev-sans-first:7.33 15:58:52 INFO - PROCESS | 1978 | Values: 90.0 70.0 87.0 70.0 68.0 69.0 78.0 67.0 69.0 83.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:85.00 stddev:17.07 (20.1%) stddev-sans-first:18.07 15:58:52 INFO - PROCESS | 1978 | Values: 93.0 107.0 121.0 130.0 86.0 84.0 87.0 84.0 86.0 84.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#6] imaging-darkroom Cycles:10 Average:102.70 Median:93.00 stddev:20.37 (21.9%) stddev-sans-first:21.31 15:58:52 INFO - PROCESS | 1978 | Values: 93.0 93.0 93.0 96.0 93.0 93.0 112.0 158.0 94.0 102.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#7] imaging-desaturate Cycles:10 Average:99.00 Median:86.00 stddev:22.02 (25.6%) stddev-sans-first:22.85 15:58:52 INFO - PROCESS | 1978 | Values: 86.0 88.0 86.0 109.0 140.0 137.0 87.0 85.0 87.0 85.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.00 stddev:1.32 (2.4%) stddev-sans-first:1.13 15:58:52 INFO - PROCESS | 1978 | Values: 59.0 56.0 56.0 56.0 56.0 59.0 56.0 58.0 56.0 56.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#9] json-stringify-tinderbox Cycles:10 Average:85.10 Median:72.00 stddev:17.73 (24.6%) stddev-sans-first:17.08 15:58:52 INFO - PROCESS | 1978 | Values: 64.0 73.0 71.0 79.0 95.0 94.0 104.0 104.0 107.0 60.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:88.00 stddev:1.17 (1.3%) stddev-sans-first:1.09 15:58:52 INFO - PROCESS | 1978 | Values: 89.0 88.0 87.0 86.0 87.0 86.0 88.0 86.0 88.0 89.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#11] stanford-crypto-ccm Cycles:10 Average:158.80 Median:157.50 stddev:15.20 (9.7%) stddev-sans-first:15.79 15:58:52 INFO - PROCESS | 1978 | Values: 150.0 156.0 156.0 159.0 167.0 151.0 143.0 147.0 197.0 162.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:175.50 stddev:2.16 (1.2%) stddev-sans-first:2.26 15:58:52 INFO - PROCESS | 1978 | Values: 174.0 173.0 175.0 173.0 176.0 176.0 176.0 173.0 174.0 180.0 15:58:52 INFO - PROCESS | 1978 | 15:58:52 INFO - PROCESS | 1978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 15:58:52 INFO - PROCESS | 1978 | Values: 69.0 71.0 70.0 69.0 70.0 68.0 69.0 69.0 70.0 70.0 15:58:52 INFO - PROCESS | 1978 | -------- Summary: end -------- 15:58:52 INFO - PROCESS | 1978 | 15:58:53 INFO - TEST-INFO | 1978: exit 0 15:58:53 INFO - TEST-OK | kraken | took 60947ms 15:58:53 INFO - SUITE-END | took 1181s 15:58:53 INFO - Completed test suite (00:19:41) 15:58:53 INFO - javascript benchmark 15:58:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3238.3199528099112, 3277.0, 3281.7046465818075, 3295.5221492883534, 3312.734981201504, 5452.236686863842, 5472.972635136824, 5535.225068490415, 5542.085555883279, 5552.944470555293, 5567.220589117516, 5573.247611572437, 5678.318601767784, 5681.119426488901, 5689.175069614914, 5024.246363045536, 5056.367954005749, 5075.543201111899, 5116.488351164872, 5125.256837758523, 5130.050940576006, 5208.817691380802, 5208.817691380802, 5220.947790522084, 5245.632805703603, 5034.874128146826, 5138.229265610151, 5150.0, 5153.201253805666, 5231.633785635007, 5053.267276244924, 5084.389873215201, 5111.08000559899, 5135.332406787131, 5140.383154021504, 4218.704690671654, 5093.108705976476, 5100.897982040376, 5139.871503212449, 5156.948430515685, 5572.3870374258795, 5576.1356989666265, 5583.441655834425, 5590.832275031756, 5592.273004509429, 5894.675792831393, 5956.672383018932, 5957.374475680078, 6099.542534309944, 6105.755769769204, 6120.908186377208, 6129.572745043282, 6163.01391777318, 6205.193324867739, 6211.161493198406, 5618.297712785902, 5670.829875103754, 5679.659220446786, 5689.089745640677, 5708.029634962025, 5217.58259339252, 6131.877362452815, 6250.249970003629, 6258.405451482102, 6271.937280627135, 5839.948809214382, 5853.64878107315, 5896.351401345849, 5954.940450595525, 5956.791512297135, 6143.665407145256, 6153.323134455206, 6156.230471191101, 6157.815265542041, 6163.229596300463, 5970.432808883149, 6051.394860513913, 6057.636541807506, 6061.1514387984835, 6080.14877917092, 5905.114232865105, 5955.493783028491, 5964.463198312173, 6000.0999850022845, 6097.7865774697675, 4785.665003449794, 4822.132016237111, 4830.903381932412, 4842.975785121052, 4845.781939812717, 4264.1471705659, 4330.935035974463, 4369.951211709167, 4376.562343765598, 4380.211561918822, 5611.130274807411, 5620.381758006616, 5626.887462250814, 5629.831105066854, 5642.971785141048, 6058.27300723916, 6059.939400606026, 6062.333143354227, 6064.090386441981, 6105.511559075263, 5593.188987596775, 5628.212050312959, 5638.210650508932, 5642.069058605366, 5646.548276137982, 5260.237265596467, 5267.789288428497, 5275.683458992473, 5286.709230992333, 5290.709011004432, 6266.968665156736, 6275.246970363585, 6277.0270608056735, 6284.402981716729, 6290.968545157245, 5999.670018149044, 6059.394060594082, 6147.66187859672, 6150.630962142286, 6155.1075094112, 5918.733656985532, 5961.493273071664, 5981.970090149522, 6071.848203794941, 6136.243373036893, 5682.0, 5689.943100569107, 5691.857703557444, 5695.914561281667, 5702.315722113373, 5647.124695672177, 5766.625169363978, 5768.625039372428, 5772.422757724194, 5776.56675749312, 5114.4374118847645, 5756.079027355603, 5780.768769249183, 5887.146363777314, 5893.852653683693, 5880.206172166874, 5883.911741323969, 5885.911711324248, 5890.911636325544, 5891.882162356815, 5741.425857414225, 5748.6263392881, 5750.827475175752, 5753.3958934311295, 5758.596898217084, 5803.071508558611, 5869.8239052828485, 5877.617954832922, 5879.412058794257, 5884.32330282023, 4497.415336006298, 5012.298278240976, 5711.457411545896, 5760.222369979999, 5776.508996735324], "value": 5524.977117594258, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.7283370727003, 483.951604839516, 484.36306257271684, 521.7808520421422, 536.9221462887881, 30271.0, 38369.23261534771, 39506.80246598763, 39847.40228896569, 41925.371119433235, 40600.59399406005, 41168.58831411685, 41175.55885544007, 41176.58823411773, 41222.38166427499, 8292.419530632858, 9131.269498440126, 9291.0, 9309.069093090704, 9355.34512584116, 8284.917150828474, 9892.268852950741, 10779.407132607703, 10797.29817561856, 11019.449027548631, 11046.226764126515, 11125.666230013112, 11143.0, 11144.498497567589, 11185.217034807567, 8293.253607175322, 10986.0, 11058.502367393487, 11063.114950803916, 11066.446677666165, 8259.95870020646, 10601.31091479059, 10956.397398143099, 10963.50664220112, 11151.665450036431, 38688.80655596732, 38975.02562435933, 38977.22045559073, 39021.0, 39023.82928512121, 3237.4981877808978, 3273.787203831743, 3343.314620502791, 3365.0914253151755, 3621.3300539400293, 28879.133625991253, 30048.39903201924, 30084.097477075724, 30166.84916575425, 30201.69798302011, 3173.4129186100645, 3231.2568109334748, 3286.917827054343, 3317.137544238491, 3319.369319829225, 433165.0, 437804.0, 438952.0, 440281.0, 441078.0, 55624.0, 55940.16089758657, 55992.44007559954, 56013.439865601635, 56309.0, 50102.248466273035, 58360.4163958355, 58479.70760146172, 60729.0, 60882.69558652267, 15231.695366092616, 15465.36563907481, 15470.690586188213, 15481.612959675873, 15483.458078967407, 10914.345139291669, 11181.608643697431, 12036.699082523008, 12099.516019359304, 12103.0, 15980.76028859568, 17279.878651051247, 18909.810901890804, 19003.714944275845, 19899.0, 7613.885791713129, 7677.385809135256, 7716.691332346755, 7749.7287594933905, 7882.7241046563095, 838.2832678060292, 913.0734150941508, 985.3841349156777, 995.9004099590128, 1047.3244757131608, 27803.0, 28677.713222867504, 28999.565006524917, 29677.258068548028, 29946.25134371658, 1000.8498725191134, 1035.9274850760526, 1042.3902017319801, 1053.1416895230363, 1102.2890235797865, 15110.168940708147, 15129.243537823066, 15295.12607207085, 15474.767878481833, 15504.922475387777, 586441.0, 588642.0, 589070.0, 589337.0, 590643.0, 56598.0, 57034.0, 57107.0, 57176.856462870506, 57203.0, 1317.8616245294297, 1339.7540287532688, 1364.2564802182635, 1367.705943222212, 1369.1990185741254, 27361.31596710098, 28487.0, 28802.0, 29380.118596442142, 29537.852310738308, 49599.0, 49660.503394965584, 49668.50331496639, 49698.75150624224, 49718.50281497283, 576317.0, 578815.0, 578828.0, 580645.0, 580943.0, 26133.99459062156, 26680.0, 26808.0, 40555.79722101371, 41075.58924410718, 44453.333200001376, 44912.55087449084, 45162.77418612886, 45795.08409831851, 45834.0, 36677.81661091677, 37348.439773402875, 37490.625093749804, 37675.05812354713, 38425.23149536938, 37362.25275494529, 37397.439038413904, 37590.06024849401, 38462.42306365463, 38542.0, 36050.0, 36462.63537364592, 36672.0, 36678.8166059168, 36694.8165259172, 30238.395232095674, 32102.876399325913, 32218.516722248718, 32225.0, 32260.35479290354, 21566.245181418573, 24013.51972960566, 24563.63154552719, 24961.0015599374, 25482.362940926625], "value": 19679.519364376203, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.8238671857431, 369.90382500549856, 370.7905033655984, 382.6498753640419, 401.9216252830697, 14725.337359818806, 14906.552803415902, 15157.696846063072, 15643.452479163232, 20427.591448171028, 15503.844961550381, 16896.47931686148, 20303.695444568344, 20380.388588342335, 20646.690299645517, 5392.514673679368, 5756.424357564252, 5758.165066065418, 5759.16492108644, 5762.3373312069225, 4554.225781617133, 4771.9761401192945, 5636.4927156555905, 5655.7172141392975, 5698.0, 5654.491095801377, 5667.489925906688, 5674.517665998395, 5678.0, 5683.318001839785, 5489.478499542557, 5582.190582365554, 5624.831255062334, 5670.801521946753, 5677.318721753416, 4987.625928055374, 4999.625028122905, 5000.7249601271915, 5000.774965126541, 5010.949890501085, 18987.33544325942, 25030.74846257698, 25041.0, 25124.0, 25305.746942530524, 2260.864348139117, 2423.248792874197, 2429.186222615426, 2509.3475696318906, 2723.6459260296233, 12220.816687749691, 13376.264305463195, 15312.923435382863, 15379.846201538065, 16086.873918825688, 1597.7922870026823, 1787.3833527433014, 1798.2087881332172, 1801.846843018345, 1969.6750036244002, 72796.54406911832, 89432.0, 113966.43016784864, 114256.28615570773, 115560.0, 8292.2951549119, 8715.34634902372, 10610.416427096583, 10827.187960902806, 10895.782084358427, 13531.864681353061, 13549.25479098659, 13561.321933903266, 13580.59258222235, 13581.728365432637, 6059.878802423927, 7985.960070199611, 8265.495305058757, 8282.514800794614, 8456.619452124669, 6729.49528785343, 6907.861842763217, 8188.058373287148, 8229.382796290301, 8445.0, 6474.15835941334, 6599.538032337787, 6620.801375958729, 6626.370494802986, 6648.401643852077, 1760.8679349048873, 1790.498660375097, 1794.4885707573278, 1796.7574377459136, 1799.0824679413593, 734.944879134067, 877.1579283887412, 920.2683866326287, 943.4150826487621, 963.7879666473365, 14764.557063288119, 20113.29603463901, 20274.797252027587, 21548.35354939354, 21580.784192157877, 856.6915910272297, 869.3697069624471, 891.839468895605, 922.1378011559214, 940.8541676040225, 10665.626703065356, 10918.727031824268, 10971.780564388668, 11009.779804403866, 11081.722956926142, 545259.0, 548977.0, 551010.0, 560304.0, 561906.0, 89823.10176898148, 105611.4719426398, 108843.10903202565, 123644.0, 126102.0, 911.3802614222525, 940.6284517615503, 974.449436068619, 976.6337623391229, 978.7374287169614, 18861.528461788566, 18975.33586324472, 19036.0, 19174.712379314602, 19175.80824191796, 39760.0, 42857.07143178502, 51614.709632259495, 52658.0, 53028.0, 67671.6465670674, 70838.22904427431, 75212.0, 76540.85188722285, 78170.0, 7642.0, 7752.108507521707, 7977.042754869452, 8142.982127234096, 8163.387745918961, 11174.0, 12262.938685306517, 12740.936295318465, 12873.35633218354, 12887.742245155232, 10886.891131088587, 10935.453227338443, 11077.501512431798, 11121.721956951142, 11124.833127502932, 10510.421926794099, 10593.205509586965, 11072.612458563912, 11080.778384432106, 11226.719332016764, 10989.670309890716, 11022.889771102185, 11160.386178760245, 11245.550177992789, 11411.915867992528, 7759.961200193963, 7971.402144839044, 7985.484572359688, 8133.593320333841, 8190.7952301192945, 10400.687979360631, 10646.73383165427, 10876.945615271872, 10942.398168100832, 11063.170262230204], "value": 9255.649869521803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.615851799273, 1477.039924049368, 1623.8538531532167, 1756.2184827751655, 1808.9457316280516, 6829.521933464659, 7723.497972631782, 8172.836543269131, 8189.590520473982, 8193.959030204847, 7215.24239954805, 7451.292127247916, 7454.962725186367, 7669.501482403653, 7947.0, 2223.855449395788, 2272.0457407888644, 2274.920377786778, 2282.2468585366873, 2284.3946354216146, 1984.791596882321, 2254.6843441918145, 2288.8626682399026, 2296.1389478945393, 2312.560613483441, 2257.085880218514, 2268.6710426988075, 2284.360379093848, 2289.839711220215, 2295.2196253273883, 1924.3457224543652, 2157.9460513487134, 2238.809701175402, 2239.7200349956256, 2245.8315626327926, 2233.475133343663, 2254.2786308381324, 2267.8299127565497, 2272.6477396003647, 2273.1134857405623, 7861.606919654052, 8157.388195885273, 8158.143394943564, 8170.632321545545, 8172.060213075513, 4901.3383193269165, 5101.234814777776, 5102.056119617882, 5106.489351064901, 5111.0, 3213.2770126721534, 3458.2564748579175, 3514.824258787076, 3558.839852206657, 3559.982200088983, 781.4568874632133, 814.8777683347486, 1030.6907927621683, 1082.8267477203688, 1085.6417382263835, 10588.523516441779, 10624.150067994542, 10625.0, 10643.946780266126, 10648.787024259549, 4445.310976798602, 4477.910441791211, 4568.314752787042, 4614.123316569908, 4660.86017419478, 8515.403921725543, 8559.871601925975, 8560.101189375026, 8572.657093716181, 8587.270082043096, 4973.900521989613, 4981.601471882241, 4982.975085124551, 4984.750762461862, 4987.251912213197, 3933.1740334529495, 4372.934405983913, 4607.815687372535, 4661.394018777537, 4669.182892993713, 3531.487934249571, 3540.0175901495245, 3591.2996965591983, 3650.7809531428197, 3656.433252845813, 1127.560251501915, 1128.4100851030023, 1133.3256712256195, 1144.2562334482486, 1145.9140564457698, 772.7179579453572, 783.9098503672037, 784.2275358771606, 863.9308855291562, 876.3690143097087, 5192.4807519248525, 5328.653637513549, 5350.946490535122, 5390.164524498709, 5449.455054494598, 434.81303039693233, 438.85737135430475, 442.62376979567756, 448.6679856905866, 928.572856486024, 3761.4733937248807, 3778.8299526521373, 3877.7673339599714, 3890.183061557048, 3938.468306778548, 8630.78423039429, 9261.351705380694, 9293.535323233811, 9935.0, 9947.303688741718, 9841.114299712917, 9862.0, 9877.456739879231, 9887.851682224773, 9907.603695852085, 7274.381677557467, 7464.253574642492, 7468.551886886804, 7470.252974702595, 7479.551226926293, 4612.723236605814, 4925.1873440881855, 5316.734163291742, 5490.792025754327, 5783.595148339576, 9089.136532029446, 9235.953820231125, 9239.907600924174, 9249.86125208109, 9260.629574816932, 9063.456192628464, 9226.169644732006, 9353.204977576983, 9441.952790236004, 9460.337776355589, 6418.390252925965, 6625.602463852184, 6784.2876497967, 6912.930870691229, 7054.470914681317, 7774.6890124394395, 7805.765827025199, 7860.5676687782725, 7865.528068315919, 7884.763457096296, 6870.725170993104, 6930.965345173242, 6962.094927659372, 6999.720011199495, 7087.433005359662, 6834.2482326943, 6863.828404289933, 6874.896876546756, 6914.135733033371, 6927.445804335742, 6346.841328966628, 6514.902276465762, 6545.803625891231, 6569.277379488157, 6600.174978127734, 4592.104539614743, 4646.721196728207, 4658.138244424792, 4686.554777296152, 4863.0, 4518.231900576976, 4643.698159619749, 4701.717896926195, 4726.740029298421, 4843.152448321459], "value": 4203.310274494417, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.3258134360376, 305.16080777860884, 310.2739589360895, 314.76707236644876, 319.3819958380535, 4607.654425918061, 4966.130927087764, 5169.793208271674, 5224.45143259958, 5305.65513241639, 4312.74123552587, 4904.852854414365, 5027.34644496215, 5087.667577736588, 5098.31172791673, 3369.427197376452, 3980.44273801668, 4049.2508885856064, 4054.3310353791735, 4055.9797201013953, 3330.9167270818302, 3518.6833185013343, 4016.6385025347713, 4058.1072164123993, 4101.589841015904, 3012.141539661197, 3341.448660970937, 4047.219223541647, 4051.392291156321, 4064.4106604542326, 3073.8770449182007, 3562.536870206882, 3622.565292164957, 3982.5619181890115, 4004.5194576650697, 2503.68703912011, 3334.549835772164, 3416.6754158354915, 3433.111788516331, 3433.2275238071484, 4116.0327323079055, 4649.582556820734, 4831.840358314014, 5054.465360430323, 5129.332746971554, 4049.291374009566, 4239.682023848224, 4372.781360931941, 4498.190325741365, 4507.5659144062165, 4497.7526236057, 5019.749012549358, 5445.957765837811, 5483.561315094823, 5489.313835770528, 2917.547780094089, 3527.918528068452, 3748.850045998157, 3760.905977350561, 3782.224643947984, 5261.447872877472, 5543.1408131739645, 5581.804636837732, 5594.14698503766, 5786.479216870502, 3325.7339412846914, 3491.266833964896, 3679.7672779618592, 3793.203427280302, 3816.6450909926575, 3423.383790917609, 3873.4189871519498, 3898.310165985461, 3899.629535194152, 3911.6675082617726, 3659.2681463707363, 4387.298032314814, 4443.7111587746695, 4465.263231566755, 4482.574155455227, 4525.0497395546645, 5341.077212203603, 5369.48989845964, 5400.21696853954, 5492.835214943558, 1205.825155352469, 1207.927524348542, 1212.751385965875, 1220.6338098570393, 1234.2902830872285, 719.9496035277481, 774.5585016540631, 786.6302837666287, 787.4605894961969, 805.7381351060928, 4385.846495372711, 4443.51184320307, 4873.220284754422, 4974.433053588108, 5060.266261392151, 5581.553475721932, 5647.519960803295, 5649.519790817744, 5654.830355089354, 5727.971360143172, 4732.556570246039, 5029.742332016408, 5066.493350664904, 5156.613254005964, 5161.793528258828, 2508.94982100357, 2782.4156927045547, 2785.860706964684, 2787.205646390769, 2807.9438411231663, 4722.527747225318, 4907.705537667752, 5003.449620541737, 5034.910512137495, 5589.105743081169, 4513.826405134623, 4807.870150514626, 5089.109405853961, 5228.503292187236, 5405.081316045836, 4364.498082720528, 4680.578747912704, 5272.657277276965, 5338.702344612624, 5522.0336441122645, 4661.641365323298, 4748.477667456508, 5204.446109654053, 5360.874216414597, 5370.4629537045985, 4210.873673789792, 4377.146456440963, 4431.623312018385, 5104.617153713412, 5128.974355128201, 4931.6301277405055, 5012.0, 5575.358833734011, 5591.356993945748, 5654.660720356792, 3404.608470025979, 3522.260325331709, 3549.8225088745976, 3552.9467057993634, 3579.3736096183584, 4851.234796166152, 4939.382577177853, 4946.802127914843, 5207.635465517377, 5345.545628621455, 4443.511213766547, 5199.740012999259, 5214.722393013736, 5221.746780772663, 5224.660397074178, 4417.757023363617, 4470.552944705503, 4529.376498801012, 5167.896642067213, 5224.97676788878, 4902.534259245366, 4994.400671919393, 5225.790968361223, 5375.758090885842, 5440.863978400572, 5079.0, 5420.457954204548, 5450.209719590716, 5454.427285135003, 5605.831825045255, 4658.440987081572, 4978.32792572998, 5092.4468037249, 5477.945220547744, 5503.422140675171], "value": 3843.1329555973957, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.4729558240156, 716.0691101567963, 748.2554857916374, 788.9211078892108, 791.469715290755, 15378.231088445575, 15915.204239788007, 15921.203939803021, 15929.362825486967, 15929.44246951357, 14353.99522033458, 14527.636809079779, 14529.927350363234, 14551.490697825579, 14595.708085838276, 662.8475450646354, 693.2270518372004, 792.0614072324314, 806.6168569929296, 836.4437648963462, 818.0960039156736, 820.4666966471782, 823.9464434811748, 824.8968878890139, 834.8079941613432, 888.3248730964449, 889.5774507109136, 890.8797312362813, 891.7993451473399, 892.1658249536672, 888.6667499687617, 891.1400498518896, 891.1534042659467, 892.1925657280171, 892.6518657723428, 520.6979951628047, 534.3854567247657, 540.4622400711278, 546.6200990311735, 659.2451642868937, 12458.43937022827, 14163.008589398747, 14730.116193028452, 14733.55799326022, 15102.244887755569, 14299.78550321746, 14595.197264150467, 14621.0, 14671.926640366837, 14704.26478676062, 11582.305061696325, 11986.820197697041, 12090.637280881587, 12149.962509372657, 12320.445579948924, 3363.630000699921, 3646.4894914711963, 3759.755615884959, 3929.941050884239, 3984.4023396490757, 102320.0, 113551.0, 116134.0, 117368.0, 118347.0, 10364.844527332096, 11345.149113816497, 11378.08975281992, 11423.61318891744, 11433.950112704566, 22959.770402295762, 23100.306990789966, 23126.537469250856, 23158.76841231566, 23352.883235583715, 7717.729879454305, 7747.845043099219, 7764.029496312961, 7779.0, 7966.123726390092, 3095.90712278632, 3969.583193764613, 4054.722268007222, 4072.2466343725914, 4145.440365550672, 3448.896533104011, 3565.536480257602, 3576.91057723559, 3591.7665351752053, 3617.4935509028755, 622.3465361370543, 631.5957787016313, 637.9521535884735, 640.6316368088368, 642.996785016072, 564.4524810933389, 576.9336526299529, 586.7125108696794, 617.521420898807, 657.7007461604958, 7553.357964572963, 8740.08283019807, 9121.36150469474, 9376.203022743006, 9425.905740942502, 554.8874506614293, 603.9607425517328, 649.3182158733312, 650.9479241660656, 673.8820706376463, 4309.267424537836, 4329.328954012133, 4441.578050085237, 4452.888677783081, 4477.753723545171, 116309.0, 116745.0, 117272.41363793127, 118865.0, 120540.39729801471, 86951.0, 103899.0, 105633.04238279512, 106457.46771266249, 108350.0, 73184.0, 76933.23066769373, 78883.60558197173, 81272.0, 87550.56224718835, 8328.833963245272, 9029.548522573714, 9053.321000925089, 9258.305627077862, 9867.851982220416, 41480.37779433371, 52509.0, 53197.0, 53456.396308110816, 56750.0, 76339.0, 78124.60937695502, 78554.0, 78569.60715196388, 80940.0, 10268.383896966207, 12561.05792065617, 12621.305828179538, 12683.746325073631, 13059.281739504419, 11712.590059348222, 13857.099288546213, 14241.50154744579, 14729.410823566937, 15282.388704452142, 13093.476260949456, 13141.934290328487, 13332.403389644498, 13389.866101339252, 13699.794503082661, 12086.395680215777, 13512.324383780575, 13947.0, 14102.0, 14231.288435577973, 12692.238465692088, 13446.596602101952, 13618.978576606596, 13688.041837071309, 13692.726145477234, 9483.910866399268, 10508.264421490423, 11067.335959842436, 11105.722356940818, 11522.82715759281, 11215.55137794479, 11305.434728263719, 11360.886391136313, 11383.317000979967, 11533.88466115328], "value": 7437.896396181058, "unit": "score"}], "name": "dromaeo_css", "value": 7032.15503092166, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 112.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 117.0, 114.0, 153.0, 112.0, 114.0, 115.0, 113.0, 134.0, 112.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 183.0, 183.0, 185.0, 183.0, 180.0, 181.0, 183.0, 184.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 75.0, 81.0, 114.0, 63.0, 58.0, 59.0, 59.0, 75.0, 61.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 87.0, 70.0, 68.0, 69.0, 78.0, 67.0, 69.0, 83.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 107.0, 121.0, 130.0, 86.0, 84.0, 87.0, 84.0, 86.0, 84.0], "value": 96.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 96.0, 93.0, 93.0, 112.0, 158.0, 94.0, 102.0], "value": 102.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 109.0, 140.0, 137.0, 87.0, 85.0, 87.0, 85.0], "value": 99.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 56.0, 56.0, 56.0, 59.0, 56.0, 58.0, 56.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 71.0, 79.0, 95.0, 94.0, 104.0, 104.0, 107.0, 60.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 87.0, 86.0, 87.0, 86.0, 88.0, 86.0, 88.0, 89.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 156.0, 156.0, 159.0, 167.0, 151.0, 143.0, 147.0, 197.0, 162.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 175.0, 173.0, 176.0, 176.0, 176.0, 173.0, 174.0, 180.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 70.0, 69.0, 70.0, 68.0, 69.0, 69.0, 70.0, 70.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1499.0, "alertThreshold": 2.0}]} 15:58:53 INFO - Return code: 0 15:58:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:58:53 INFO - # TBPL SUCCESS # 15:58:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:58:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:58:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:58:53 INFO - 2016-12-02 15:58:53.318 screenresolution[1982:11854] starting screenresolution argv=screenresolution get 15:58:53 INFO - 2016-12-02 15:58:53.321 screenresolution[1982:11854] Display 0: 1600x1200x32@60 15:58:53 INFO - 2016-12-02 15:58:53.328 screenresolution[1983:11857] starting screenresolution argv=screenresolution list 15:58:53 INFO - Available Modes on Display 0 15:58:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:58:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:58:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:58:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:58:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:58:53 INFO - Intel Iris: 15:58:53 INFO - Chipset Model: Intel Iris 15:58:53 INFO - Type: GPU 15:58:53 INFO - Bus: Built-In 15:58:53 INFO - VRAM (Dynamic, Max): 1536 MB 15:58:53 INFO - Vendor: Intel (0x8086) 15:58:53 INFO - Device ID: 0x0a2e 15:58:53 INFO - Revision ID: 0x0009 15:58:53 INFO - Displays: 15:58:53 INFO - Display: 15:58:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:58:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:58:53 INFO - Display Serial Number: 1600x1200 60 15:58:53 INFO - Main Display: Yes 15:58:53 INFO - Mirror: Off 15:58:53 INFO - Online: Yes 15:58:53 INFO - Rotation: Supported 15:58:53 INFO - Return code: 0 15:58:53 INFO - Running post-action listener: _resource_record_post_action 15:58:53 INFO - [mozharness: 2016-12-02 23:58:53.573957Z] Finished run-tests step (success) 15:58:53 INFO - Running post-run listener: _resource_record_post_run 15:58:53 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 188416; Write bytes: 688180736; Read time: 3; Write time: 1868 15:58:53 INFO - TinderboxPrint: CPU usage
53.4% 15:58:53 INFO - TinderboxPrint: I/O read bytes / time
188,416 / 3 15:58:53 INFO - TinderboxPrint: I/O write bytes / time
688,180,736 / 1,868 15:58:53 INFO - TinderboxPrint: CPU idle
2,263.1 (46.6%) 15:58:53 INFO - TinderboxPrint: CPU system
969.5 (20.0%) 15:58:53 INFO - TinderboxPrint: CPU user
1,625.1 (33.5%) 15:58:53 INFO - TinderboxPrint: Swap in / out
383,328,256 / 0 15:58:53 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 362969600; Write bytes: 357226496; Read time: 27571; Write time: 664 15:58:53 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 188416; Write bytes: 301827584; Read time: 3; Write time: 1138 15:58:54 INFO - Running post-run listener: _upload_blobber_files 15:58:54 INFO - Blob upload gear active. 15:58:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:58:54 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 15:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:58:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:58:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:58:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:58:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:55 INFO - (blobuploader) - INFO - Done attempting. 15:58:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:58:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:58:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:56 INFO - (blobuploader) - INFO - Done attempting. 15:58:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:58:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:58:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:58 INFO - (blobuploader) - INFO - Done attempting. 15:58:58 INFO - (blobuploader) - INFO - Iteration through files over. 15:58:58 INFO - Return code: 0 15:58:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:58:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:58:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571136763c5f904cc158e40d3a4b9ab941dc0c36f535d523670084744acfa526fef9b39b1667ddf6ef63ffd63bb6ca21b13f2775288d3136e6fe8b75731c47ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f470824f7ec3bdbfa93b04cffd683a686ec325b02594feb5278a78ad208e2745c605af8e599b8336ebbe0f3cb014b3abd309c556234685e40c2aea52eaac7179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3326687b68ebf67e8feba7692ab9e83ebd582ec1dedb91ae09cc69b0337bb4c01b6ef47a7a49bd2e581173ace3a4e5b35e0b969d48dc8fd0682d34187591fedb"} 15:58:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:58:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:58:58 INFO - Contents: 15:58:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571136763c5f904cc158e40d3a4b9ab941dc0c36f535d523670084744acfa526fef9b39b1667ddf6ef63ffd63bb6ca21b13f2775288d3136e6fe8b75731c47ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f470824f7ec3bdbfa93b04cffd683a686ec325b02594feb5278a78ad208e2745c605af8e599b8336ebbe0f3cb014b3abd309c556234685e40c2aea52eaac7179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3326687b68ebf67e8feba7692ab9e83ebd582ec1dedb91ae09cc69b0337bb4c01b6ef47a7a49bd2e581173ace3a4e5b35e0b969d48dc8fd0682d34187591fedb"} 15:58:58 INFO - Running post-run listener: copy_logs_to_upload_dir 15:58:58 INFO - Copying logs to upload dir... 15:58:58 INFO - mkdir: /builds/slave/test/build/upload/logs 15:58:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.043830 ========= master_lag: 1.71 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-12-02 15:59:00.137897) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 15:59:00.142324) ========= 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.VPF3S2ZztM/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.s9srhEzo9I/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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/Firefox/sha512/571136763c5f904cc158e40d3a4b9ab941dc0c36f535d523670084744acfa526fef9b39b1667ddf6ef63ffd63bb6ca21b13f2775288d3136e6fe8b75731c47ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f470824f7ec3bdbfa93b04cffd683a686ec325b02594feb5278a78ad208e2745c605af8e599b8336ebbe0f3cb014b3abd309c556234685e40c2aea52eaac7179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3326687b68ebf67e8feba7692ab9e83ebd582ec1dedb91ae09cc69b0337bb4c01b6ef47a7a49bd2e581173ace3a4e5b35e0b969d48dc8fd0682d34187591fedb"} build_url:https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/fVDC4oDTS4K3Kppn4zzPbw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571136763c5f904cc158e40d3a4b9ab941dc0c36f535d523670084744acfa526fef9b39b1667ddf6ef63ffd63bb6ca21b13f2775288d3136e6fe8b75731c47ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f470824f7ec3bdbfa93b04cffd683a686ec325b02594feb5278a78ad208e2745c605af8e599b8336ebbe0f3cb014b3abd309c556234685e40c2aea52eaac7179", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3326687b68ebf67e8feba7692ab9e83ebd582ec1dedb91ae09cc69b0337bb4c01b6ef47a7a49bd2e581173ace3a4e5b35e0b969d48dc8fd0682d34187591fedb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 15:59:00.181809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:59:00.185177) ========= 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.VPF3S2ZztM/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.s9srhEzo9I/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.005228 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:59:00.233676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 15:59:00.236997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 15:59:00.237310) ========= ========= Total master_lag: 1.86 =========