builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0225 starttime: 1487669566.46 results: success (0) buildid: 20170221004019 builduid: f33e6435d8564abc9ba33d4234a97d05 revision: 53189303b53dbf20ca068c9081232b7ae7ec01d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:46.458305) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:46.458804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:46.459096) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:46.503038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:46.503444) ========= 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.Yl5T0AiPge/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.IS955dti3Y/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-21 01:32:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2017-02-21 01:32:46 (19.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117287 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:46.645524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:46.645882) ========= 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.Yl5T0AiPge/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.IS955dti3Y/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.026532 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:46.700857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:46.701204) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 53189303b53dbf20ca068c9081232b7ae7ec01d4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 53189303b53dbf20ca068c9081232b7ae7ec01d4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Yl5T0AiPge/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.IS955dti3Y/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-21 01:32:46,807 truncating revision to first 12 chars 2017-02-21 01:32:46,807 Setting DEBUG logging. 2017-02-21 01:32:46,807 attempt 1/10 2017-02-21 01:32:46,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/53189303b53d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-21 01:32:47,462 unpacking tar archive at: mozilla-aurora-53189303b53d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.912873 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:47.639102) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:47.639631) ========= script_repo_revision: 53189303b53dbf20ca068c9081232b7ae7ec01d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:47.640250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:47.640713) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 01:32:47.662719) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-21 01:32:47.663129) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Yl5T0AiPge/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.IS955dti3Y/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:32:47 INFO - MultiFileLogger online at 20170221 01:32:47 in /builds/slave/test 01:32:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:32:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:32:47 INFO - {'append_to_log': False, 01:32:47 INFO - 'base_work_dir': '/builds/slave/test', 01:32:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:32:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:32:47 INFO - 'branch': 'Mozilla-Aurora', 01:32:47 INFO - 'buildbot_json_path': 'buildprops.json', 01:32:47 INFO - 'config_files': ('talos/mac_config.py',), 01:32:47 INFO - 'default_actions': ('clobber', 01:32:47 INFO - 'read-buildbot-config', 01:32:47 INFO - 'download-and-extract', 01:32:47 INFO - 'populate-webroot', 01:32:47 INFO - 'create-virtualenv', 01:32:47 INFO - 'install', 01:32:47 INFO - 'run-tests'), 01:32:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:32:47 INFO - 'download_minidump_stackwalk': True, 01:32:47 INFO - 'download_symbols': 'ondemand', 01:32:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:32:47 INFO - 'tooltool.py': '/tools/tooltool.py', 01:32:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:32:47 INFO - '/tools/misc-python/virtualenv.py')}, 01:32:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:32:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:32:47 INFO - 'installer_path': 'installer.exe', 01:32:47 INFO - 'log_level': 'info', 01:32:47 INFO - 'log_name': 'talos', 01:32:47 INFO - 'log_to_console': True, 01:32:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:32:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:32:47 INFO - 'opt_config_files': (), 01:32:47 INFO - 'pip_index': False, 01:32:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:32:47 INFO - 'cmd': ('bash', 01:32:47 INFO - '-c', 01:32:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:32:47 INFO - 'enabled': True, 01:32:47 INFO - 'halt_on_failure': False, 01:32:47 INFO - 'name': 'check_screen_resolution'},), 01:32:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:32:47 INFO - 'cmd': ('bash', 01:32:47 INFO - '-c', 01:32:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:32:47 INFO - 'enabled': True, 01:32:47 INFO - 'halt_on_failure': False, 01:32:47 INFO - 'name': 'check_screen_resolution'},), 01:32:47 INFO - 'run_cmd_checks_enabled': True, 01:32:47 INFO - 'sps_profile': False, 01:32:47 INFO - 'sps_profile_interval': 0, 01:32:47 INFO - 'suite': 'dromaeojs-e10s', 01:32:47 INFO - 'system_bits': '32', 01:32:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:32:47 INFO - 'title': 't-yosemite-r7-0225', 01:32:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:32:47 INFO - 'use_talos_json': True, 01:32:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:32:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:32:47 INFO - 'work_dir': 'build'} 01:32:47 INFO - [mozharness: 2017-02-21 09:32:47.878699Z] Running clobber step. 01:32:47 INFO - Running pre-action listener: _resource_record_pre_action 01:32:47 INFO - Running main action method: clobber 01:32:47 INFO - rmtree: /builds/slave/test/build 01:32:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:32:52 INFO - Running post-action listener: _resource_record_post_action 01:32:52 INFO - [mozharness: 2017-02-21 09:32:52.191122Z] Finished clobber step (success) 01:32:52 INFO - [mozharness: 2017-02-21 09:32:52.191253Z] Running read-buildbot-config step. 01:32:52 INFO - Running pre-action listener: _resource_record_pre_action 01:32:52 INFO - Running main action method: read_buildbot_config 01:32:52 INFO - Using buildbot properties: 01:32:52 INFO - { 01:32:52 INFO - "project": "", 01:32:52 INFO - "product": "firefox", 01:32:52 INFO - "script_repo_revision": "production", 01:32:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:32:52 INFO - "repository": "", 01:32:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:32:52 INFO - "buildid": "20170221004019", 01:32:52 INFO - "stage_platform": "macosx64", 01:32:52 INFO - "basedir": "/builds/slave/test", 01:32:52 INFO - "nightly_build": "True", 01:32:52 INFO - "buildnumber": 0, 01:32:52 INFO - "slavename": "t-yosemite-r7-0225", 01:32:52 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 01:32:52 INFO - "platform": "yosemite_r7", 01:32:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:32:52 INFO - "branch": "mozilla-aurora", 01:32:52 INFO - "repo_path": "releases/mozilla-aurora", 01:32:52 INFO - "revision": "53189303b53dbf20ca068c9081232b7ae7ec01d4", 01:32:52 INFO - "pgo_build": "False", 01:32:52 INFO - "builduid": "f33e6435d8564abc9ba33d4234a97d05", 01:32:52 INFO - "slavebuilddir": "test" 01:32:52 INFO - } 01:32:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 01:32:52 INFO - Running post-action listener: _resource_record_post_action 01:32:52 INFO - [mozharness: 2017-02-21 09:32:52.194710Z] Finished read-buildbot-config step (success) 01:32:52 INFO - [mozharness: 2017-02-21 09:32:52.194826Z] Running download-and-extract step. 01:32:52 INFO - Running pre-action listener: _resource_record_pre_action 01:32:52 INFO - Running main action method: download_and_extract 01:32:52 INFO - mkdir: /builds/slave/test/build/tests 01:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:52 INFO - trying https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 01:32:52 INFO - Downloading https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 01:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 01:32:52 INFO - Downloaded 1199 bytes. 01:32:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 01:32:52 INFO - Using the following test package requirements: 01:32:52 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:32:52 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:52 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 01:32:52 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:52 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 01:32:52 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:52 INFO - u'jsshell-mac.zip'], 01:32:52 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:52 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 01:32:52 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:32:52 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:52 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 01:32:52 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:52 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 01:32:52 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:52 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 01:32:52 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:52 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 01:32:52 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:32:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:32:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:32:52 INFO - Fetch https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:32:53 INFO - Expected file size: 16359111 01:32:53 INFO - Obtained file size: 16359111 01:33:00 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:33:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:33:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:33:00 INFO - Fetch https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:33:01 INFO - Expected file size: 16359111 01:33:01 INFO - Obtained file size: 16359111 01:33:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 01:33:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:33:07 INFO - Fetch https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 01:33:09 INFO - Expected file size: 14403485 01:33:09 INFO - Obtained file size: 14403485 01:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:09 INFO - trying https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:33:09 INFO - Downloading https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 01:33:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 01:33:11 INFO - Downloaded 74023462 bytes. 01:33:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:33:11 INFO - mkdir: /builds/slave/test/properties 01:33:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:33:11 INFO - Writing to file /builds/slave/test/properties/build_url 01:33:11 INFO - Contents: 01:33:11 INFO - build_url:https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:33:12 INFO - Running post-action listener: _resource_record_post_action 01:33:12 INFO - Running post-action listener: set_extra_try_arguments 01:33:12 INFO - [mozharness: 2017-02-21 09:33:12.297320Z] Finished download-and-extract step (success) 01:33:12 INFO - [mozharness: 2017-02-21 09:33:12.297436Z] Running populate-webroot step. 01:33:12 INFO - Running pre-action listener: _resource_record_pre_action 01:33:12 INFO - Running main action method: populate_webroot 01:33:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:33:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:33:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:33:12 INFO - '--tppagecycles', 01:33:12 INFO - '7'], 01:33:12 INFO - 'tests': ['tsvgm']}}, 01:33:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:33:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:33:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:33:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:33:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:33:12 INFO - 'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:33:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:33:12 INFO - 'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['damp', 'tps']}, 01:33:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:33:12 INFO - 'tests': ['damp', 'tps']}, 01:33:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['dromaeo_dom']}, 01:33:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:33:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['basic_compositor_video']}, 01:33:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:33:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore', 01:33:12 INFO - 'tabpaint']}, 01:33:12 INFO - 'other-e10s': {'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore', 01:33:12 INFO - 'tabpaint']}, 01:33:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore', 01:33:12 INFO - 'tabpaint']}, 01:33:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore', 01:33:12 INFO - 'tabpaint']}, 01:33:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore', 01:33:12 INFO - 'tabpaint']}, 01:33:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['a11yr', 01:33:12 INFO - 'ts_paint', 01:33:12 INFO - 'tpaint', 01:33:12 INFO - 'sessionrestore', 01:33:12 INFO - 'sessionrestore_no_auto_restore', 01:33:12 INFO - 'tabpaint']}, 01:33:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['tsvgx', 01:33:12 INFO - 'tsvgr_opacity', 01:33:12 INFO - 'tart', 01:33:12 INFO - 'tscrollx', 01:33:12 INFO - 'cart', 01:33:12 INFO - 'tsvg_static']}, 01:33:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:33:12 INFO - 'tsvgr_opacity', 01:33:12 INFO - 'tart', 01:33:12 INFO - 'tscrollx', 01:33:12 INFO - 'cart', 01:33:12 INFO - 'tsvg_static']}, 01:33:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:33:12 INFO - 'talos_options': ['--disable-e10s'], 01:33:12 INFO - 'tests': ['tp5o']}, 01:33:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:33:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:33:12 INFO - 'talos_options': ['--disable-e10s', 01:33:12 INFO - '--xperf_path', 01:33:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:12 INFO - 'tests': ['tp5n']}, 01:33:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:33:12 INFO - 'talos_options': ['--xperf_path', 01:33:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:12 INFO - 'tests': ['tp5n']}}, 01:33:12 INFO - 'talos.zip': {'path': '', 01:33:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:33:12 INFO - Running post-action listener: _resource_record_post_action 01:33:12 INFO - [mozharness: 2017-02-21 09:33:12.316011Z] Finished populate-webroot step (success) 01:33:12 INFO - [mozharness: 2017-02-21 09:33:12.316154Z] Running create-virtualenv step. 01:33:12 INFO - Running pre-action listener: _resource_record_pre_action 01:33:12 INFO - Running main action method: create_virtualenv 01:33:12 INFO - Creating virtualenv /builds/slave/test/build/venv 01:33:12 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 01:33:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:33:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:33:12 INFO - Using real prefix '/tools/python27' 01:33:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:33:13 INFO - Installing distribute.............................................................................................................................................................................................done. 01:33:16 INFO - Installing pip.................done. 01:33:16 INFO - Return code: 0 01:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:33:16 INFO - Reading from file tmpfile_stdout 01:33:16 INFO - Output received: 01:33:16 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) 01:33:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:33:16 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')]} 01:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:16 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')]} 01:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:16 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 0x10647cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10647f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd615764b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, '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.Yl5T0AiPge/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.IS955dti3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:33:16 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 01:33:16 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 01:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:16 INFO - 'HOME': '/Users/cltbld', 01:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:16 INFO - 'LOGNAME': 'cltbld', 01:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:16 INFO - 'MOZ_NO_REMOTE': '1', 01:33:16 INFO - 'NO_EM_RESTART': '1', 01:33:16 INFO - 'PAGER': '/bin/cat', 01:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:16 INFO - 'PWD': '/builds/slave/test', 01:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:16 INFO - 'SHELL': '/bin/bash', 01:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:33:16 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:16 INFO - 'USER': 'cltbld', 01:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:16 INFO - 'XPC_FLAGS': '0x0', 01:33:16 INFO - 'XPC_SERVICE_NAME': '0', 01:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:16 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 01:33:16 INFO - Cleaning up... 01:33:16 INFO - Return code: 0 01:33:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:33:16 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')]} 01:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:16 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')]} 01:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:16 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 0x10647cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10647f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd615764b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, '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.Yl5T0AiPge/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.IS955dti3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:33:16 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 01:33:16 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 01:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:16 INFO - 'HOME': '/Users/cltbld', 01:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:16 INFO - 'LOGNAME': 'cltbld', 01:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:16 INFO - 'MOZ_NO_REMOTE': '1', 01:33:16 INFO - 'NO_EM_RESTART': '1', 01:33:16 INFO - 'PAGER': '/bin/cat', 01:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:16 INFO - 'PWD': '/builds/slave/test', 01:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:16 INFO - 'SHELL': '/bin/bash', 01:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:33:16 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:16 INFO - 'USER': 'cltbld', 01:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:16 INFO - 'XPC_FLAGS': '0x0', 01:33:16 INFO - 'XPC_SERVICE_NAME': '0', 01:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:16 INFO - Downloading/unpacking psutil>=3.1.1 01:33: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 01:33: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 01:33: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 01:33: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 01:33: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 01:33: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 01:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:33:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:20 INFO - Installing collected packages: psutil 01:33:20 INFO - Running setup.py install for psutil 01:33:20 INFO - building 'psutil._psutil_osx' extension 01:33:20 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 01:33:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:33:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:33:21 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 01:33:21 INFO - building 'psutil._psutil_posix' extension 01:33:21 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 01:33:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:33:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:33:21 INFO - ^ 01:33:21 INFO - 1 warning generated. 01:33:21 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 01:33:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:21 INFO - Successfully installed psutil 01:33:21 INFO - Cleaning up... 01:33:21 INFO - Return code: 0 01:33:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:33:21 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')]} 01:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:21 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')]} 01:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:21 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 0x10647cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10647f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd615764b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, '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.Yl5T0AiPge/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.IS955dti3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:33:21 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 01:33:21 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 01:33:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:33:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:21 INFO - 'HOME': '/Users/cltbld', 01:33:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:21 INFO - 'LOGNAME': 'cltbld', 01:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:21 INFO - 'MOZ_NO_REMOTE': '1', 01:33:21 INFO - 'NO_EM_RESTART': '1', 01:33:21 INFO - 'PAGER': '/bin/cat', 01:33:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:21 INFO - 'PWD': '/builds/slave/test', 01:33:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:21 INFO - 'SHELL': '/bin/bash', 01:33:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:33:21 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:33:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:21 INFO - 'USER': 'cltbld', 01:33:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:21 INFO - 'XPC_FLAGS': '0x0', 01:33:21 INFO - 'XPC_SERVICE_NAME': '0', 01:33:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:33:22 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 01:33:22 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 01:33:22 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 01:33:22 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 01:33:22 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 01:33:22 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 01:33:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:33:24 INFO - Installing collected packages: mozsystemmonitor 01:33:24 INFO - Running setup.py install for mozsystemmonitor 01:33:25 INFO - Successfully installed mozsystemmonitor 01:33:25 INFO - Cleaning up... 01:33:25 INFO - Return code: 0 01:33:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10647cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10647f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd615764b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, '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.Yl5T0AiPge/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.IS955dti3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:33:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:33:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:25 INFO - 'HOME': '/Users/cltbld', 01:33:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:25 INFO - 'LOGNAME': 'cltbld', 01:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:25 INFO - 'MOZ_NO_REMOTE': '1', 01:33:25 INFO - 'NO_EM_RESTART': '1', 01:33:25 INFO - 'PAGER': '/bin/cat', 01:33:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:25 INFO - 'PWD': '/builds/slave/test', 01:33:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:25 INFO - 'SHELL': '/bin/bash', 01:33:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:33:25 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:33:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:25 INFO - 'USER': 'cltbld', 01:33:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:25 INFO - 'XPC_FLAGS': '0x0', 01:33:25 INFO - 'XPC_SERVICE_NAME': '0', 01:33:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:25 INFO - Downloading/unpacking jsonschema==2.5.1 01:33: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 01:33: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 01:33: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 01:33: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 01:33: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 01:33: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 01:33:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:33:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:33:28 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 01:33:28 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 01:33:28 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 01:33:28 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 01:33:28 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 01:33:28 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 01:33:28 INFO - Downloading functools32-3.2.3-2.tar.gz 01:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:33:28 INFO - warning: no files found matching '*.txt' 01:33:28 INFO - no previously-included directories found matching 'build' 01:33:28 INFO - no previously-included directories found matching 'dist' 01:33:28 INFO - no previously-included directories found matching '.git*' 01:33:28 INFO - Installing collected packages: jsonschema, functools32 01:33:28 INFO - Running setup.py install for functools32 01:33:28 INFO - warning: no files found matching '*.txt' 01:33:28 INFO - no previously-included directories found matching 'build' 01:33:28 INFO - no previously-included directories found matching 'dist' 01:33:28 INFO - no previously-included directories found matching '.git*' 01:33:28 INFO - Successfully installed jsonschema functools32 01:33:28 INFO - Cleaning up... 01:33:28 INFO - Return code: 0 01:33:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10647cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10647f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd615764b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, '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.Yl5T0AiPge/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.IS955dti3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:28 INFO - 'HOME': '/Users/cltbld', 01:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:28 INFO - 'LOGNAME': 'cltbld', 01:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:28 INFO - 'MOZ_NO_REMOTE': '1', 01:33:28 INFO - 'NO_EM_RESTART': '1', 01:33:28 INFO - 'PAGER': '/bin/cat', 01:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:28 INFO - 'PWD': '/builds/slave/test', 01:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:28 INFO - 'SHELL': '/bin/bash', 01:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:33:28 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:28 INFO - 'USER': 'cltbld', 01:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:28 INFO - 'XPC_FLAGS': '0x0', 01:33:28 INFO - 'XPC_SERVICE_NAME': '0', 01:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:33:29 INFO - Cleaning up... 01:33:29 INFO - Return code: 0 01:33:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:33:29 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')]} 01:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:29 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')]} 01:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:29 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 0x10647cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10647f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd615764b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, '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.Yl5T0AiPge/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.IS955dti3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:33:29 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 01:33:29 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 01:33:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:33:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:29 INFO - 'HOME': '/Users/cltbld', 01:33:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:29 INFO - 'LOGNAME': 'cltbld', 01:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:29 INFO - 'MOZ_NO_REMOTE': '1', 01:33:29 INFO - 'NO_EM_RESTART': '1', 01:33:29 INFO - 'PAGER': '/bin/cat', 01:33:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:29 INFO - 'PWD': '/builds/slave/test', 01:33:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:29 INFO - 'SHELL': '/bin/bash', 01:33:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:33:29 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:33:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:29 INFO - 'USER': 'cltbld', 01:33:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:29 INFO - 'XPC_FLAGS': '0x0', 01:33:29 INFO - 'XPC_SERVICE_NAME': '0', 01:33:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:29 INFO - Downloading/unpacking blobuploader==1.2.4 01:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:31 INFO - Downloading blobuploader-1.2.4.tar.gz 01:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:33:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:33:32 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 01:33:32 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 01:33:32 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 01:33:32 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 01:33:32 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 01:33:32 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 01:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:33:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:33:32 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 01:33:32 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 01:33:32 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 01:33:32 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 01:33:32 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 01:33:32 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 01:33:33 INFO - Downloading docopt-0.6.1.tar.gz 01:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:33:33 INFO - Installing collected packages: blobuploader, requests, docopt 01:33:33 INFO - Running setup.py install for blobuploader 01:33:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:33:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:33:33 INFO - Running setup.py install for requests 01:33:33 INFO - Running setup.py install for docopt 01:33:34 INFO - Successfully installed blobuploader requests docopt 01:33:34 INFO - Cleaning up... 01:33:34 INFO - Return code: 0 01:33:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:34 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 0x10647cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10647f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd615764b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, '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.Yl5T0AiPge/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.IS955dti3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:33:34 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 01:33:34 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 01:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:34 INFO - 'HOME': '/Users/cltbld', 01:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:34 INFO - 'LOGNAME': 'cltbld', 01:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:34 INFO - 'MOZ_NO_REMOTE': '1', 01:33:34 INFO - 'NO_EM_RESTART': '1', 01:33:34 INFO - 'PAGER': '/bin/cat', 01:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:34 INFO - 'PWD': '/builds/slave/test', 01:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:34 INFO - 'SHELL': '/bin/bash', 01:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:33:34 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:34 INFO - 'USER': 'cltbld', 01:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:34 INFO - 'XPC_FLAGS': '0x0', 01:33:34 INFO - 'XPC_SERVICE_NAME': '0', 01:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:33:34 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-2Rvpju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:33:34 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-DeMnz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:33:34 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-PEk6km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:33:34 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-rtAUI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:33:34 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-ig1sP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:33:34 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-z7Z5u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:33:35 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-_6BXyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:33:35 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-S8_nm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:33:35 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-NrVFSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:33:35 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-RLdPwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:33:35 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-owE7Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:33:35 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Sfcplw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:33:35 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-e49rfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:33:35 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-FYkIpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:35 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Tno2OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:33:35 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-sVxxws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:33:36 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-2jJWi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:33:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:33:36 INFO - Running setup.py install for manifestparser 01:33:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Running setup.py install for mozcrash 01:33:36 INFO - Running setup.py install for mozdebug 01:33:36 INFO - Running setup.py install for mozdevice 01:33:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Running setup.py install for mozfile 01:33:36 INFO - Running setup.py install for mozhttpd 01:33:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:33:37 INFO - Running setup.py install for mozinfo 01:33:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:33:37 INFO - Running setup.py install for mozInstall 01:33:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:33:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:33:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:33:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:33:37 INFO - Running setup.py install for mozleak 01:33:37 INFO - Running setup.py install for mozlog 01:33:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:33:37 INFO - Running setup.py install for moznetwork 01:33:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:33:37 INFO - Running setup.py install for mozprocess 01:33:37 INFO - Running setup.py install for mozprofile 01:33:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:33:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:33:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:33:38 INFO - Running setup.py install for mozrunner 01:33:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:33:38 INFO - Running setup.py install for mozscreenshot 01:33:38 INFO - Running setup.py install for moztest 01:33:38 INFO - Running setup.py install for mozversion 01:33:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:33:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:33:38 INFO - Cleaning up... 01:33:38 INFO - Return code: 0 01:33:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:38 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 0x10647cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10647f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd615764b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, '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.Yl5T0AiPge/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.IS955dti3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:33:38 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 01:33:38 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 01:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:38 INFO - 'HOME': '/Users/cltbld', 01:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:38 INFO - 'LOGNAME': 'cltbld', 01:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:38 INFO - 'MOZ_NO_REMOTE': '1', 01:33:38 INFO - 'NO_EM_RESTART': '1', 01:33:38 INFO - 'PAGER': '/bin/cat', 01:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:38 INFO - 'PWD': '/builds/slave/test', 01:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:38 INFO - 'SHELL': '/bin/bash', 01:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:33:38 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:38 INFO - 'USER': 'cltbld', 01:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:38 INFO - 'XPC_FLAGS': '0x0', 01:33:38 INFO - 'XPC_SERVICE_NAME': '0', 01:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:33:39 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-lyp3HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:33:39 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)) 01:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:33:39 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-swVojn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:33:39 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)) 01:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:33:39 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-vJhgGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:33:39 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)) 01:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:33:39 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-2sZyCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:33:39 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)) 01:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:33:39 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-4avU9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:33:39 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)) 01:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:33:39 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-nEg0GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:33:39 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)) 01:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:33:39 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-5eZbcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:33:39 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)) 01:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:33:39 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-PGueRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:33:39 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)) 01:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:33:39 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-4OaNnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:33:39 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)) 01:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:33:39 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-eesuw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:33:40 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)) 01:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:33:40 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-IG9kS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:33:40 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)) 01:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:33:40 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-GSlosr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:33:40 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-ryoan2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:33:40 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)) 01:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:33:40 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Qa0rZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:33:40 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)) 01:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:40 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-mvsLGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:40 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)) 01:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:33:40 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-FwccRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:33:40 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-nIbV8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:33:40 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)) 01:33:40 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)) 01:33:40 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)) 01:33:40 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)) 01:33:40 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)) 01:33:40 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)) 01:33:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:33:40 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 01:33:40 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 01:33:40 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 01:33:40 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 01:33:40 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 01:33:40 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 01:33:43 INFO - Downloading blessings-1.6.tar.gz 01:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:33:43 INFO - Installing collected packages: blessings 01:33:43 INFO - Running setup.py install for blessings 01:33:43 INFO - Successfully installed blessings 01:33:43 INFO - Cleaning up... 01:33:43 INFO - Return code: 0 01:33:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:33:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:44 INFO - Reading from file tmpfile_stdout 01:33:44 INFO - Current package versions: 01:33:44 INFO - blessings == 1.6 01:33:44 INFO - blobuploader == 1.2.4 01:33:44 INFO - docopt == 0.6.1 01:33:44 INFO - functools32 == 3.2.3-2 01:33:44 INFO - jsonschema == 2.5.1 01:33:44 INFO - manifestparser == 1.1 01:33:44 INFO - mozInstall == 1.12 01:33:44 INFO - mozcrash == 1.0 01:33:44 INFO - mozdebug == 0.1 01:33:44 INFO - mozdevice == 0.49 01:33:44 INFO - mozfile == 1.2 01:33:44 INFO - mozhttpd == 0.7 01:33:44 INFO - mozinfo == 0.9 01:33:44 INFO - mozleak == 0.1 01:33:44 INFO - mozlog == 3.4 01:33:44 INFO - moznetwork == 0.27 01:33:44 INFO - mozprocess == 0.24 01:33:44 INFO - mozprofile == 0.28 01:33:44 INFO - mozrunner == 6.13 01:33:44 INFO - mozscreenshot == 0.1 01:33:44 INFO - mozsystemmonitor == 0.3 01:33:44 INFO - moztest == 0.8 01:33:44 INFO - mozversion == 1.4 01:33:44 INFO - psutil == 3.1.1 01:33:44 INFO - requests == 1.2.3 01:33:44 INFO - wsgiref == 0.1.2 01:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33:44 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')]} 01:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:44 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')]} 01:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:44 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 0x10647cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10647f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd615764b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, '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.Yl5T0AiPge/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.IS955dti3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:33:44 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 01:33:44 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 01:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:44 INFO - 'HOME': '/Users/cltbld', 01:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:44 INFO - 'LOGNAME': 'cltbld', 01:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:44 INFO - 'MOZ_NO_REMOTE': '1', 01:33:44 INFO - 'NO_EM_RESTART': '1', 01:33:44 INFO - 'PAGER': '/bin/cat', 01:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:44 INFO - 'PWD': '/builds/slave/test', 01:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:44 INFO - 'SHELL': '/bin/bash', 01:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:33:44 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:44 INFO - 'USER': 'cltbld', 01:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:44 INFO - 'XPC_FLAGS': '0x0', 01:33:44 INFO - 'XPC_SERVICE_NAME': '0', 01:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:44 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)) 01:33:44 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)) 01:33:44 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)) 01:33:44 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)) 01:33:44 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)) 01:33:44 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)) 01:33:44 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)) 01:33:44 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)) 01:33:44 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)) 01:33:44 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)) 01:33:44 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)) 01:33:44 INFO - Cleaning up... 01:33:44 INFO - Return code: 0 01:33:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:33:44 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')]} 01:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:44 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')]} 01:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:44 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 0x10647cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10647f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd615764b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, '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.Yl5T0AiPge/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.IS955dti3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 01:33:44 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 01:33:44 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 01:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:44 INFO - 'HOME': '/Users/cltbld', 01:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:44 INFO - 'LOGNAME': 'cltbld', 01:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:44 INFO - 'MOZ_NO_REMOTE': '1', 01:33:44 INFO - 'NO_EM_RESTART': '1', 01:33:44 INFO - 'PAGER': '/bin/cat', 01:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:44 INFO - 'PWD': '/builds/slave/test', 01:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:44 INFO - 'SHELL': '/bin/bash', 01:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:33:44 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:44 INFO - 'USER': 'cltbld', 01:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:44 INFO - 'XPC_FLAGS': '0x0', 01:33:44 INFO - 'XPC_SERVICE_NAME': '0', 01:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:33:44 INFO - Cleaning up... 01:33:44 INFO - Return code: 0 01:33:44 INFO - Running post-action listener: _resource_record_post_action 01:33:44 INFO - Running post-action listener: _start_resource_monitoring 01:33:44 INFO - Starting resource monitoring. 01:33:44 INFO - [mozharness: 2017-02-21 09:33:44.683524Z] Finished create-virtualenv step (success) 01:33:44 INFO - [mozharness: 2017-02-21 09:33:44.684526Z] Running install step. 01:33:44 INFO - Running pre-action listener: _resource_record_pre_action 01:33:44 INFO - Running main action method: install 01:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:44 INFO - Reading from file tmpfile_stdout 01:33:44 INFO - Detecting whether we're running mozinstall >=1.0... 01:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:33:45 INFO - Reading from file tmpfile_stdout 01:33:45 INFO - Output received: 01:33:45 INFO - Usage: mozinstall [options] installer 01:33:45 INFO - Options: 01:33:45 INFO - -h, --help show this help message and exit 01:33:45 INFO - -d DEST, --destination=DEST 01:33:45 INFO - Directory to install application into. [default: 01:33:45 INFO - "/builds/slave/test"] 01:33:45 INFO - --app=APP Application being installed. [default: firefox] 01:33:45 INFO - mkdir: /builds/slave/test/build/application 01:33:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:34:05 INFO - Reading from file tmpfile_stdout 01:34:05 INFO - Output received: 01:34:05 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:34:05 INFO - Running post-action listener: _resource_record_post_action 01:34:05 INFO - [mozharness: 2017-02-21 09:34:05.003279Z] Finished install step (success) 01:34:05 INFO - [mozharness: 2017-02-21 09:34:05.003421Z] Running run-tests step. 01:34:05 INFO - Running pre-action listener: _resource_record_pre_action 01:34:05 INFO - Running main action method: run_tests 01:34:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:34:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:34:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:34:05 INFO - 2017-02-21 01:34:05.017 screenresolution[1639:8886] starting screenresolution argv=screenresolution get 01:34:05 INFO - 2017-02-21 01:34:05.020 screenresolution[1639:8886] Display 0: 1600x1200x32@60 01:34:05 INFO - 2017-02-21 01:34:05.026 screenresolution[1640:8889] starting screenresolution argv=screenresolution list 01:34:05 INFO - Available Modes on Display 0 01:34:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:34:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:34:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:34:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:34:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:34:05 INFO - Intel Iris: 01:34:05 INFO - Chipset Model: Intel Iris 01:34:05 INFO - Type: GPU 01:34:05 INFO - Bus: Built-In 01:34:05 INFO - VRAM (Dynamic, Max): 1536 MB 01:34:05 INFO - Vendor: Intel (0x8086) 01:34:05 INFO - Device ID: 0x0a2e 01:34:05 INFO - Revision ID: 0x0009 01:34:05 INFO - Displays: 01:34:05 INFO - Display: 01:34:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:34:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:34:05 INFO - Display Serial Number: 1600x1200 60 01:34:05 INFO - Main Display: Yes 01:34:05 INFO - Mirror: Off 01:34:05 INFO - Online: Yes 01:34:05 INFO - Rotation: Supported 01:34:05 INFO - Return code: 0 01:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:34:05 INFO - Python 2.7.3 01:34:05 INFO - Return code: 0 01:34:05 INFO - grabbing minidump binary from tooltool 01:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:05 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 0x10625ad30>, '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 0x106181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10624fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:34:05 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 01:34:05 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 01:34:05 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 01:34:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:34:05 INFO - Return code: 0 01:34:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:34:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:34:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:34:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:34:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0225 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:34:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yl5T0AiPge/Render', 01:34:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:05 INFO - 'HOME': '/Users/cltbld', 01:34:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:05 INFO - 'LOGNAME': 'cltbld', 01:34:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:34:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:05 INFO - 'MOZ_NO_REMOTE': '1', 01:34:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:34:05 INFO - 'NO_EM_RESTART': '1', 01:34:05 INFO - 'PAGER': '/bin/cat', 01:34:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:05 INFO - 'PWD': '/builds/slave/test', 01:34:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:34:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:05 INFO - 'SHELL': '/bin/bash', 01:34:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IS955dti3Y/Listeners', 01:34:05 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 01:34:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:05 INFO - 'USER': 'cltbld', 01:34:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:05 INFO - 'XPC_FLAGS': '0x0', 01:34:05 INFO - 'XPC_SERVICE_NAME': '0', 01:34:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:34:05 INFO - mozversion application_buildid: 20170221004019 01:34:05 INFO - mozversion application_changeset: 53189303b53dbf20ca068c9081232b7ae7ec01d4 01:34:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:34:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:34:05 INFO - mozversion application_name: Firefox 01:34:05 INFO - mozversion application_remotingname: firefox-dev 01:34:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:34:05 INFO - mozversion application_vendor: Mozilla 01:34:05 INFO - mozversion application_version: 53.0a2 01:34:05 INFO - mozversion platform_buildid: 20170221004019 01:34:05 INFO - mozversion platform_changeset: 53189303b53dbf20ca068c9081232b7ae7ec01d4 01:34:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:34:05 INFO - mozversion platform_version: 53.0a2 01:34:05 INFO - using testdate: 1487669645 01:34:05 INFO - actual date: 1487669645 01:34:05 INFO - starting webserver on 'localhost:49243' 01:34:05 INFO - SUITE-START | Running 2 tests 01:34:05 INFO - TEST-START | dromaeo_css 01:34:05 INFO - operating with platform_type : mac_ 01:34:05 INFO - Initialising browser for dromaeo_css test... 01:34:05 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpXbNAi6/profile http://localhost:49243/getInfo.html) 01:34:08 INFO - PROCESS | 1650 | 2017-02-21 01:34:08.498 plugin-container[1654:9082] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9043, name = 'com.apple.tsm.portname' 01:34:08 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:34:08 INFO - PROCESS | 1650 | 2017-02-21 01:34:08.499 plugin-container[1654:9082] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c27, name = 'com.apple.CFPasteboardClient' 01:34:08 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:34:08 INFO - PROCESS | 1650 | 2017-02-21 01:34:08.499 plugin-container[1654:9082] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:34:08 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 01:34:08 INFO - PROCESS | 1650 | colorDepth:24 01:34:08 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 01:34:08 INFO - PROCESS | 1650 | __metrics 01:34:08 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 01:34:09 INFO - TEST-INFO | 1650: exit 0 01:34:09 INFO - Browser initialized. 01:34:09 INFO - Running cycle 1/1 for dromaeo_css test... 01:34:09 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpXbNAi6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:34:11 INFO - PROCESS | 1655 | 2017-02-21 01:34:11.858 plugin-container[1656:9213] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 01:34:11 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:34:11 INFO - PROCESS | 1655 | 2017-02-21 01:34:11.858 plugin-container[1656:9213] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 01:34:11 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:34:11 INFO - PROCESS | 1655 | 2017-02-21 01:34:11.858 plugin-container[1656:9213] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:34:21 INFO - PROCESS | 1655 | RSS: Main: 219676672 01:34:21 INFO - PROCESS | 1655 | 01:37:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 01:37:25 INFO - PROCESS | 1655 | RSS: Main: 239783936 01:37:25 INFO - PROCESS | 1655 | 01:39:09 INFO - PROCESS | 1655 | ************************* 01:39:09 INFO - PROCESS | 1655 | A coding exception was thrown and uncaught in a Task. 01:39:09 INFO - PROCESS | 1655 | 01:39:09 ERROR - PROCESS | 1655 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:39:09 INFO - PROCESS | 1655 | Full stack: 01:39:09 INFO - PROCESS | 1655 | ************************* 01:40:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 01:40:28 INFO - PROCESS | 1655 | RSS: Main: 247431168 01:40:28 INFO - PROCESS | 1655 | 01:43:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 01:43:31 INFO - PROCESS | 1655 | RSS: Main: 254709760 01:43:31 INFO - PROCESS | 1655 | 01:46:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 01:46:33 INFO - PROCESS | 1655 | RSS: Main: 251187200 01:46:33 INFO - PROCESS | 1655 | 01:49:36 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 01:49:37 INFO - PROCESS | 1655 | RSS: Main: 259362816 01:49:37 INFO - PROCESS | 1655 | 01:52:39 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 01:52:40 INFO - PROCESS | 1655 | RSS: Main: 264224768 01:52:40 INFO - PROCESS | 1655 | 01:52:40 INFO - PROCESS | 1655 | __start_tp_report 01:52:40 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 01:52:40 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 01:52:40 INFO - PROCESS | 1655 | |i|pagename|runs| 01:52:40 INFO - PROCESS | 1655 | |0;dojo.html;2977.315217499975;3356.899293021209;3368.040108569057;3396.252824378636;3404.14896275931;5639.069553523669;5681.005823980808;5689.345725241598;5705.9144112838285;5708.571857110723;5659.6321239119425;5738.7991420300295;5739.081746920494;5767.990601644706;5790.884182316351;5133.204353325231;5212.244224587433;5227.26818245446;5229.294045303874;5273.789048438058;5261.342332208474;5291.973540132294;5296.894062118756;5306.973465132688;5350.35795704516;5123.385193776733;5150.124478838607;5281.70950597717;5294.655847369928;5306.177542480922;3797.917593485871;4382.342648602703;4551.65862560306;5041.470645582216;5187.559057480119;5111.897762044776;5165.070287348276;5188.247704082924;5199.948000519984;5217.895642087137;5515.310586176728;5628.380878103405;5633.915491267593;5745.511631511326;5751.884962300731;6057.697115144225;6118.3146263159115;6119.3197658210165;6148.016317389241;6233.87532249357;5272.31459910213;6298.905516417258;6309.968450157766;6316.1788967434395;6317.589356691847;5773.451522105393;5774.422557744276;5775.913361299584;5806.767729290823;5826.067829147359;6206.286277078104;6233.96883015582;6250.312465628777;6255.343188965184;6270.6864656766975;6087.120610201783;6100.99362449148;6151.630902145886;6156.661383623854;6157.507399408037;6209.441150296495;6283.497320214372;6285.057241413733;6294.842628934313;6316.968415157987;6003.609765365237;6052;6129.295131059896;6138.6623735694075;6203;6244.781432649836;6253.187085678833;6259.061140828912;6265.686715664198;6282;4959.479254678206;4972.627052970969;4975.0796102721115;4977.9751101244265;5001.224810154432;4291.806868690916;4339.891502712458;4381.890452738707;4446.399736035659;4473.463184417826;5737.913931291034;5767.596268261265;5818.796342128006;5847.976604094267;5878.941210587925;6287.9056814147825;6290.150829637941;6295.716692748837;6306.779262725782;6314.905276420857;5529.557635389159;5576.1356989666665;5682.573806964494;5722.599418040781;5725.570582206268;5409.43200963901;5427.728613569306;5429.1856221566295;5435.565154787608;5453.863653408617;6285.748570057238;6303.432691057735;6305.464035557029;6317.3366796486625;6321.1782468278825;6040.788572399945;6115.3578874217565;6170.136180934583;6174.289956655042;6278.937210627835;6293.150424692791;6304.590201637063;6308.71610777507;6321.367863213642;6323.241211054703;6195.504359651307;6197.4732147767945;6200.906986395117;6207.81376558704;6211.627302361872;5869.090291004901;5980.43185897339;6131.9272270139245;6300.306966233802;6301.6534090625455;5862.912056319244;5992.221011268507;6072.60528065692;6088.817335479943;6101.298350689727;5974.731137098754;5996.37038110992;6038.396160384103;6049.062395328731;6061.212042434456;5644.125160600113;5697.059985102412;5738.512226460798;5881.206037184926;5894.70526473666;5966.19456373384;5995.100734889801;6012.849678758066;6052.697365131814;6102.786402475892;5889.882202355843;5897.882042359043;5904.822855314347;5908.940910590839;5926.407359264039 01:52:40 INFO - PROCESS | 1655 | |1;ext.html;415.9022629682024;464.44266879744316;469.13912969700596;471.7051842598376;493.6914428482199;30679.693203067964;32110.67889321109;34204;40362.39456408153;41423.58576414235;42198;42586.935326616775;42758.786206069;42805.929851753725;42903.570964290346;8288.046874609407;8544.829103417927;9041.683541076063;9342.346035777498;9359.906400936006;11005.724856878602;11259.605913793019;11296.887031129707;11436.71408214793;11444;11301.208915375926;11351.978321951023;11354.829677554842;11374.829377559343;11377.2035957483;11242.437878106062;11290;11313.773724525463;11319.999999999958;11325.433728313552;11212.04697600705;11258.268212566158;11260.831087533694;11274.887251127466;11324.9807517323;40785;40966;41019.38470922939;41148.17703645911;41179;3920.5491368492417;3977.105151340954;4008.2785098682225;4036.3945408189006;4051.169510250421;23500.647490287487;28521.286967825763;28799.71200287991;29005.41989160226;29283.85358073196;3025.13783571681;3041.0724728957657;3070.5394190871325;3086.6141732283463;3139.8116113033293;454342;486996;487787;487954;491749;55351.72324138354;57311;57452.71273643605;57625;62796.372036279055;64593.67703161454;65017.699646007764;65304.04087877371;65370;65712;16235;16704;16717.331306747838;16764.329426823035;16799.91600041992;10638.840417393745;11905.642830715093;12631.494740210472;12850.421731022127;12994.415251313525;16193.757093643604;16266.18669066542;16281.51155465338;16291;16328.591785205228;6649.468042556584;6796.93203067963;7235.865419701201;7247.782566523013;7251.093613298338;838.8741688746737;848.2620120495209;857.8455877941906;860.3246451535515;882.801823459581;28896.422071558452;29484;29526.852365738036;29886.823880507916;30322.69677303243;1027.7071034755058;1049.3861091261545;1062.3148069495132;1089.6404186618397;1185.1348515583672;12087.637370878887;13614;14392.928035359757;15251.542453726406;15500.612484687974;608332;609183;611421;615132;616922;56904.86190276171;59442.405575944555;59622.70188649116;59747.402525975056;59904.40095599076;1259.974800504003;1435.3110506956718;1452.8038714773581;1454.3891565542708;1468.08978433372;28468.572971405032;28857.711422885503;29379.85310073436;29895.850520747255;30113.849430752707;49485;49625.50374496209;50001.74999124981;50010.999780004924;50042.499575003785;519947;520780.39609803224;521089;521268;523673;22235.332940011827;22793.430164245365;22860.657090143995;23696.28911132669;39603.405948911364;41990.58009419867;42048.36927446152;42765.14469710651;42860.92847678833;43356.34965475457;34159.65840341565;34484.65515344815;34488.82755586206;34970;35489;33421.66578334186;34240.657593424745;34850.82574587111;35270.64729352674;35776.46335305025;34204.97385078452;34275.14312142217;34786.30427391388;34927.82536087405;35073.64926350704;29173.70826291795;30888.845555772077;31069;31163;31201.68798311988;19664.213431463155;23408.88295558511;23421.531569368177;23939.28182154538;24114 01:52:40 INFO - PROCESS | 1655 | |2;jquery.html;390.2039838728993;394.5462717874446;401.9769686148752;402.4124777824377;419.8412381826159;16190.83809161908;19418.126184321703;20270.39188824334;20355.49111272219;20854.37436876896;21013;21404.678929816066;21411.44022064995;21919.232826851065;22072.558548829013;5762.308522977238;6000.159977603139;6019.91641504529;6024.819255422344;6039.516838652898;5719.19931209631;5835.212246346752;5861;5934.228550288456;5939.4654481096695;5841.941580584183;5842.795502157425;5853.239078919734;5855.79504717335;5871.148683440899;5641.68970706613;5794.536437085044;5804.738786754606;5884.08796636522;5947.613405128653;5228.320318358589;5247.422783493813;5249.4488078751565;5256.894862102737;5257.211418287249;25812;25898.870505647352;25979.350516237057;26441.471170576675;26667.466650667073;2538.6065159900245;2633.8156329056783;2721.18364490654;2750.4911591355662;2771.584262360642;12796.744065118646;15936.203189840577;16059.91970040154;16267;16636.417725379673;1806.205269681336;1884.9717254241198;1886.3586380630513;1887.37716553537;1891.0355718583621;106351;118573;127802.72197278001;133064;136322;19960.403167746546;22359.88200589964;24520;24613.876930615592;24973.250802475955;10098.293119481566;12877.098603097693;41338.37992430116;42131;42191.94520137021;8322.292605128632;8405.70580029696;8465.449745766506;8505.532195729294;8546.700865469678;7265;8767.517786521803;8772.956135219283;8844.73465796027;8896.59965301563;4093.672506199497;4161.875143745692;4183.037901282722;4206.810693518799;4269.953861304;2060.1656329186703;2096.7500374419587;2098.548812005426;2100.537881666031;2107.2203284784423;1016.466355163545;1020.9132223761063;1027.7379268286538;1033.9069483746498;1066.5627092891878;18469.90765046166;21586.56826863454;22053;22057.889710551346;22566;1048.1771809129796;1049.9737506562244;1072.951717172729;1081.3565928272665;1091.8471414002047;11526.827097593543;11718.296902185895;11806.763864722829;11845.526178952918;11858.407079646156;741989;749276;752214;754566;773270;135070;148627;154352;159258.20370898073;159920;955.245356168633;1049.286485190078;1061.5329255127874;1081.8269076947652;1085.5657736905143;18713.409360204536;19596.11817468246;19618.9209593468;19634.410967670992;19653.60692786165;61750;62071.37928620656;62552.374476256475;62921.37078629338;63705;90015.09984900068;91288.54355728444;92470;92842;93379.5993060091;6382.297947225708;7301.306375894282;8023.558704271088;8422.5788710563;8495.915040849512;11727.589534366256;12919;12968.416421261254;13425.395857186646;13451.46194152223;11125.221234513507;11135.498902549567;11313.547458101584;11338.60314888975;11593.24643898144;9003.54982250898;10853.40306283162;10974;11238.213325067167;11626.360550169484;11371.488283027118;11614.941925290319;11662.367268582575;11765.47055382527;11792.882071179522;7813.749800031967;8271.090180080066;8382.706605268786;8499.320054395757;8569.314454843723;8232.917670823455;10238;11238.831417528907;11457.59898403552;11599.76800463969 01:52:40 INFO - PROCESS | 1655 | |3;mootools.html;1285.736424033074;1287.5300515311908;1423.9786403203948;1426.0944300369263;1427.4432971141252;7576.999999999986;7799.844003119934;8129.349652027839;8564.91435085649;8604.311655067595;6709.865802683943;8034.1965803419625;8378.706745263917;8382.371322150833;8425.578721063954;2294.7934685878267;2355.646653002046;2364.361622361961;2366.8224883133835;2368.5499755046485;1997.9200831966705;2078.085642317383;2328.406256404623;2345.718513778349;2354.3407845803204;2105.957880842382;2271.1483193802324;2357.669926210332;2359.3511784259294;2364.775346342103;2313.8611683298973;2318.953620927589;2324.5583339165505;2336.8714720690355;2352.4354155002848;2322.8722420266877;2329.301209637119;2385.5348207099623;2390.5935990881594;2396.0894859953105;7019.719211231544;8378.204070613281;8405.495670259743;8456.957715211445;8460.365472589581;4676.158291507527;5271.209318602202;5275.393329767087;5276.736163191864;5279.947200527984;3285.6057273127376;3423.058658868831;3430.433978393562;3486.1633208030144;3493.2489514754448;1140.4981808004452;1146.776378606172;1164.1524414450196;1183.0299154693155;1184.224333061846;10619.41593212373;10687.038166565046;10746.194035447374;10806.459677016117;10811.135109191246;4536.432945881765;4723.315119307681;4787.16224660683;4789.44921334051;4790.736509491941;9449.338546301831;9474.57364418589;9483.620655173854;9522.95238523803;9530.380525265835;4484.708493947883;5233.633645644768;5244.763985620656;5255.39562950258;5258.447862974409;4682.314306960607;4733.384659994179;4749.050189962021;4826.155422800995;4829.203181475087;3921.313770090223;3964;3998.080441498472;4058.5332686740812;4077.8776636700354;1210.4915935307192;1249.2129958126504;1296.0927350854251;1314.5267703626687;1327.5818117293022;635.7933671556763;721.7546034348346;726.6947881889619;790.9559381616211;829.1956801902145;5545.528630066409;5577.163425486128;5815.476607105381;5867.70661466925;5907.911381329283;991.2020823237219;995.3977843404635;995.6117114325419;1009.9949500252452;1053.146950969717;3313.4367157582788;3549.964500355015;3654.6162652921594;3793.6206379361843;3861.227754449121;9680.515974201262;9792.21662267017;10020.448875311928;10023.498825058718;10041.849372259421;9336.486493242937;9734.853977190347;9844.852327215098;9922.553485093043;9927.255455840841;7669.578173200416;7854.685812567547;7871.134175240604;7878.684852605947;7887.763367098996;5017.623678224075;5531.640443371329;5594.776208951596;5752.626079304831;5764;8915.37592368528;9078.910530736353;9309.487978161265;9325.440473571607;9330.860037099314;8939.955300223457;9302.348835581444;9306.627734890528;9319.953400232955;9339.066093390607;7120.359167674934;7224.385927196247;7261.745838895613;7274.30894065063;7283.053203083565;7793.883091753515;7846.607669616382;7879.975603171551;7886.487378320391;7903.130655627761;6845;7007.6145811978795;7011.50919435655;7182.0663313770965;7182.138143422822;6993.895091573732;7029.61337126463;7043.260457652078;7053.188883278283;7059.2940705928995;6391.169148010915;6395.488360931021;6401.967990160019;6459.386358295955;6464.127342808661;4210.305299625527;4916.459189489082;5021.548060674557;5074.213496907985;5074.492550744896;4696.483386827515;4899.873029203232;4944.258361245842;5120.02719483297;5156.432792392909 01:52:40 INFO - PROCESS | 1655 | |4;prototype.html;358.9712822974162;361.8245151101716;370.4036501233016;370.57384008390346;380.38567713143266;4357;4644.815572029132;4904.901901961958;5140.614453915957;5412.296401467808;5034.572061374778;5134.666246693962;5220.634555581111;5242.449542797999;5246.554042906348;3649;3958.6936311017294;4101.179764047188;4113.280175969208;4170.0817623893045;3460.8442620082033;3465.5494785677824;3613.4760459733325;4035.57626449223;4209.326507758759;3471.7916924984456;4092.6494256895303;4100.774457404841;4120.835166593348;4149.070682132808;3488.2674638325984;3920.921746519701;4075.572064933169;4119.032027473526;4151.91696166075;3412.129906873731;3667.211549516867;3676.4632403641403;3692.5015122958325;3711.6845068169237;4496.505384407713;4625.722456652578;4948.331975183341;5013.147764879943;5086.364204474441;4083.612056854594;4162.313218318974;4670.883227919295;4780.617550595944;4797.280407938837;5315.946840531584;5352.91970620441;5508.3114610673665;5545.445455454463;5568.331800183963;3521.3133438979407;3657.487951686766;3779.2441511697493;3827.75119617224;3891.8832435026993;5212.478752124757;5589.664620122806;5618.690971996498;5850.268716410449;5887.646741195542;3056.831874246938;3319.9502007469423;3654.9817250914107;3731.384321586962;3830.0041989082483;3635.018544992837;3763.6989040876665;3936.2324346752107;3936.940945885814;3970.4441378207075;3855.363864962306;4196.433481479961;4371.278739008092;4485.8112600160985;4533.138703646297;4676.462206846189;4758.333833263346;5043.4365346742625;5611.354694210137;5706.771729130871;1214.9210301330386;1222;1237.7833879071127;1268.9087384849022;1280;751.8796992481177;845.8031884882822;868.8783570300163;878.2754227762122;879.1516186879692;4410.757408342572;4750.643701722384;4969;4989.303636763518;5010.843168803631;5299.006061575197;5457.645253058538;5494.230807686927;5551.8889622207325;5565.1095824667855;4497.325401189848;4654.624652826333;4686.531346865286;4890.657653964188;4932.7533623319405;2569.910053148131;2835.5888396182436;2846.644169478815;2859.47099786536;2875.5686647003117;5062.443131255559;5186.662866913714;5361.954418888279;5441.455854414527;5683.158420789605;4707.599854012379;5155.453363990788;5649.406812284651;5658.443927919772;5668.943310566924;5065.341505604248;5425.7829686812875;5633.63381380209;5668.044524638993;5702.258706368229;4271.786410679391;4695.440984663298;5039.420466646236;5208.067908729037;5230.084735171406;4521.570450807168;5356.732163391893;5394.9460505394445;5414.566834653139;5433.565314774887;5394.946050539601;5456.727163641882;5672.87267274772;5693.4875861172695;5716.914246286392;3334.2497937963763;3662.340778659867;3682.987178525927;3690.6493883081066;3703.481512588186;4619.528552224544;4838.194166999544;5274.892272622792;5325.627206095536;5362.418086664521;4776.2119250324695;4831.883435184357;5263.6841789492755;5290.14332260575;5329.200619907045;4588.770561471846;4630.4443466784205;4876.78054487556;4972.632526055364;5218.712970786643;4413.624841888475;5018;5021.422536408214;5023.097860014542;5144.382674079135;4494.887627809331;4692.343071969859;5022.267317775361;5067.885065285779;5578.191162281528;5070.188769796815;5351.3043304370185;5406.972965135149;5410.540104091197;5418.756155973069 01:52:40 INFO - PROCESS | 1655 | |5;yui.html;685.4893104637047;719.2591630620462;727.4689476682025;819.7376839411389;829.5396055189369;14708.852911470896;15353.462628807994;15371.231438428062;15422.768658470131;15432.151231682254;13714.24571648559;14229.288535573205;14407.351669174912;14444.422223111089;14568.053076550017;678.2064983968744;847.3729440214228;862.9309655227567;863.9654413823439;865.03548543374;698.0541366448465;836.7657056024323;860.793409581699;872.2062922740307;873.9344549158807;922.4373132389237;930.2325581395376;930.7486978515831;931.0921851195098;933.4632586262892;920.5765347939956;924.5562130177485;927.6243121535755;928.0904713380856;928.22029495224;685.9725610975555;688.401091050784;692.7540723043297;692.8752824491589;693.9861202775967;14469.348879300456;14815.925920370437;14873.70252594942;14904.850951490454;14912.925435372754;12164.209326393844;13486.258255795927;13503.797443038362;13638.659033524142;13891.652708682263;11234.3259404436;11279.605213817558;11623.953844154066;11686.415679216005;11696.239744416585;3605.6214097519646;3673.669369756708;3678.779273243614;3684.281565094808;3700.333939890819;106798;107030;108320;109793;110263;10627.52176152075;10781.9460902695;10820.134389248999;10905.563777448971;10918.50866711;20576.279830205873;21358.825264610285;21989;22087.779122208573;22439.43901402478;7639.350655194371;7648.961755191189;7652.464327497022;7807.68769249235;8022.1175670676175;4220.451341325669;4282.828686852553;4319.654427645781;4377.890552736143;4387.298032314814;3092.9690703092683;3346.928982725553;3601.8019008954234;3664.0107171063664;3669.339518886626;573.9024365857731;641.2049059166693;680.557637535596;710.6198183971551;731.707317073175;596.9761209551656;660.1681880830189;698.6890833579008;705.6577559883452;722.1947528505679;9647.179989700953;10151.695449136538;10284.331518451427;10334.483275836328;10638.361698298128;656.5699466849126;669.8291935556499;684.948628852828;709.5246185056025;715.4741265170096;4973.6269779765935;4979.9542096159485;4982.427020892571;5041.319421878;5045.974770126126;90746;95913;99786;100037.49981250048;103023.48488257511;70654;87514.12485875186;88954.55522722345;90780.63829042569;91192.54403727938;59021.40978590159;75765.24234757692;78053;78331.60834195907;78629.4616742248;9246;9533.285003624616;9643.951780241334;9688.141998110716;9695.499623180227;42032.57967420287;48936.510634893195;53120.46879531155;53127.734361327944;53366.73316633392;55068.89862202814;57743.71128144332;68124.63750725056;68711;69428.30571694218;11427.828582571101;12113.273203607812;12518.93740531328;12813.74372512526;12912.096153269182;14199.361028753525;14406.552494415488;14433.92783036078;14575.416983320549;14726.674599286116;13234.404451799885;13645.317734113056;13741;13879.236641984788;14083;12989.545365912149;13260.336983150997;13333.20000799955;13542.59372218835;13930.512432064828;12415.94464470494;12581.74836503283;13191.142575732547;13413.128146670435;13709;9583.424994500352;10961.232713709964;11159;11195.552177912792;11308.603812467722;10418.583256669648;11030.889691102986;11119;11170;11177.273477223955 01:52:40 INFO - PROCESS | 1655 | __end_tp_report 01:52:40 INFO - PROCESS | 1655 | __start_cc_report 01:52:40 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,392 01:52:40 INFO - PROCESS | 1655 | __end_cc_report 01:52:40 INFO - PROCESS | 1655 | __startTimestamp1487670760034__endTimestamp 01:52:40 INFO - PROCESS | 1655 | 01:52:40 INFO - PROCESS | 1655 | ------- Summary: start ------- 01:52:40 INFO - PROCESS | 1655 | Number of tests: 6 01:52:40 INFO - PROCESS | 1655 | 01:52:40 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5707.22 Median:5889.88 stddev:665.08 (11.3%) stddev-sans-first:631.70 01:52:40 INFO - PROCESS | 1655 | Values: 2977.3 3356.9 3368.0 3396.3 3404.1 5639.1 5681.0 5689.3 5705.9 5708.6 5659.6 5738.8 5739.1 5768.0 5790.9 5133.2 5212.2 5227.3 5229.3 5273.8 5261.3 5292.0 5296.9 5307.0 5350.4 5123.4 5150.1 5281.7 5294.7 5306.2 3797.9 4382.3 4551.7 5041.5 5187.6 5111.9 5165.1 5188.2 5199.9 5217.9 5515.3 5628.4 5633.9 5745.5 5751.9 6057.7 6118.3 6119.3 6148.0 6233.9 5272.3 6298.9 6310.0 6316.2 6317.6 5773.5 5774.4 5775.9 5806.8 5826.1 6206.3 6234.0 6250.3 6255.3 6270.7 6087.1 6101.0 6151.6 6156.7 6157.5 6209.4 6283.5 6285.1 6294.8 6317.0 6003.6 6052.0 6129.3 6138.7 6203.0 6244.8 6253.2 6259.1 6265.7 6282.0 4959.5 4972.6 4975.1 4978.0 5001.2 4291.8 4339.9 4381.9 4446.4 4473.5 5737.9 5767.6 5818.8 5848.0 5878.9 6287.9 6290.2 6295.7 6306.8 6314.9 5529.6 5576.1 5682.6 5722.6 5725.6 5409.4 5427.7 5429.2 5435.6 5453.9 6285.7 6303.4 6305.5 6317.3 6321.2 6040.8 6115.4 6170.1 6174.3 6278.9 6293.2 6304.6 6308.7 6321.4 6323.2 6195.5 6197.5 6200.9 6207.8 6211.6 5869.1 5980.4 6131.9 6300.3 6301.7 5862.9 5992.2 6072.6 6088.8 6101.3 5974.7 5996.4 6038.4 6049.1 6061.2 5644.1 5697.1 5738.5 5881.2 5894.7 5966.2 5995.1 6012.8 6052.7 6102.8 5889.9 5897.9 5904.8 5908.9 5926.4 01:52:40 INFO - PROCESS | 1655 | 01:52:40 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:66990.69 Median:34257.90 stddev:144495.12 (421.8%) stddev-sans-first:144814.01 01:52:40 INFO - PROCESS | 1655 | Values: 415.9 464.4 469.1 471.7 493.7 30679.7 32110.7 34204.0 40362.4 41423.6 42198.0 42586.9 42758.8 42805.9 42903.6 8288.0 8544.8 9041.7 9342.3 9359.9 11005.7 11259.6 11296.9 11436.7 11444.0 11301.2 11352.0 11354.8 11374.8 11377.2 11242.4 11290.0 11313.8 11320.0 11325.4 11212.0 11258.3 11260.8 11274.9 11325.0 40785.0 40966.0 41019.4 41148.2 41179.0 3920.5 3977.1 4008.3 4036.4 4051.2 23500.6 28521.3 28799.7 29005.4 29283.9 3025.1 3041.1 3070.5 3086.6 3139.8 454342.0 486996.0 487787.0 487954.0 491749.0 55351.7 57311.0 57452.7 57625.0 62796.4 64593.7 65017.7 65304.0 65370.0 65712.0 16235.0 16704.0 16717.3 16764.3 16799.9 10638.8 11905.6 12631.5 12850.4 12994.4 16193.8 16266.2 16281.5 16291.0 16328.6 6649.5 6796.9 7235.9 7247.8 7251.1 838.9 848.3 857.8 860.3 882.8 28896.4 29484.0 29526.9 29886.8 30322.7 1027.7 1049.4 1062.3 1089.6 1185.1 12087.6 13614.0 14392.9 15251.5 15500.6 608332.0 609183.0 611421.0 615132.0 616922.0 56904.9 59442.4 59622.7 59747.4 59904.4 1260.0 1435.3 1452.8 1454.4 1468.1 28468.6 28857.7 29379.9 29895.9 30113.8 49485.0 49625.5 50001.7 50011.0 50042.5 519947.0 520780.4 521089.0 521268.0 523673.0 22235.3 22793.4 22860.7 23696.3 39603.4 41990.6 42048.4 42765.1 42860.9 43356.3 34159.7 34484.7 34488.8 34970.0 35489.0 33421.7 34240.7 34850.8 35270.6 35776.5 34205.0 34275.1 34786.3 34927.8 35073.6 29173.7 30888.8 31069.0 31163.0 31201.7 19664.2 23408.9 23421.5 23939.3 24114.0 01:52:40 INFO - PROCESS | 1655 | 01:52:40 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:41839.24 Median:23543.00 stddev:125352.92 (532.4%) stddev-sans-first:125665.93 01:52:40 INFO - PROCESS | 1655 | Values: 390.2 394.5 402.0 402.4 419.8 16190.8 19418.1 20270.4 20355.5 20854.4 21013.0 21404.7 21411.4 21919.2 22072.6 5762.3 6000.2 6019.9 6024.8 6039.5 5719.2 5835.2 5861.0 5934.2 5939.5 5841.9 5842.8 5853.2 5855.8 5871.1 5641.7 5794.5 5804.7 5884.1 5947.6 5228.3 5247.4 5249.4 5256.9 5257.2 25812.0 25898.9 25979.4 26441.5 26667.5 2538.6 2633.8 2721.2 2750.5 2771.6 12796.7 15936.2 16059.9 16267.0 16636.4 1806.2 1885.0 1886.4 1887.4 1891.0 106351.0 118573.0 127802.7 133064.0 136322.0 19960.4 22359.9 24520.0 24613.9 24973.3 10098.3 12877.1 41338.4 42131.0 42191.9 8322.3 8405.7 8465.4 8505.5 8546.7 7265.0 8767.5 8773.0 8844.7 8896.6 4093.7 4161.9 4183.0 4206.8 4270.0 2060.2 2096.8 2098.5 2100.5 2107.2 1016.5 1020.9 1027.7 1033.9 1066.6 18469.9 21586.6 22053.0 22057.9 22566.0 1048.2 1050.0 1073.0 1081.4 1091.8 11526.8 11718.3 11806.8 11845.5 11858.4 741989.0 749276.0 752214.0 754566.0 773270.0 135070.0 148627.0 154352.0 159258.2 159920.0 955.2 1049.3 1061.5 1081.8 1085.6 18713.4 19596.1 19618.9 19634.4 19653.6 61750.0 62071.4 62552.4 62921.4 63705.0 90015.1 91288.5 92470.0 92842.0 93379.6 6382.3 7301.3 8023.6 8422.6 8495.9 11727.6 12919.0 12968.4 13425.4 13451.5 11125.2 11135.5 11313.5 11338.6 11593.2 9003.5 10853.4 10974.0 11238.2 11626.4 11371.5 11614.9 11662.4 11765.5 11792.9 7813.7 8271.1 8382.7 8499.3 8569.3 8232.9 10238.0 11238.8 11457.6 11599.8 01:52:40 INFO - PROCESS | 1655 | 01:52:40 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5417.84 Median:5256.92 stddev:2938.45 (55.9%) stddev-sans-first:2930.28 01:52:40 INFO - PROCESS | 1655 | Values: 1285.7 1287.5 1424.0 1426.1 1427.4 7577.0 7799.8 8129.3 8564.9 8604.3 6709.9 8034.2 8378.7 8382.4 8425.6 2294.8 2355.6 2364.4 2366.8 2368.5 1997.9 2078.1 2328.4 2345.7 2354.3 2106.0 2271.1 2357.7 2359.4 2364.8 2313.9 2319.0 2324.6 2336.9 2352.4 2322.9 2329.3 2385.5 2390.6 2396.1 7019.7 8378.2 8405.5 8457.0 8460.4 4676.2 5271.2 5275.4 5276.7 5279.9 3285.6 3423.1 3430.4 3486.2 3493.2 1140.5 1146.8 1164.2 1183.0 1184.2 10619.4 10687.0 10746.2 10806.5 10811.1 4536.4 4723.3 4787.2 4789.4 4790.7 9449.3 9474.6 9483.6 9523.0 9530.4 4484.7 5233.6 5244.8 5255.4 5258.4 4682.3 4733.4 4749.1 4826.2 4829.2 3921.3 3964.0 3998.1 4058.5 4077.9 1210.5 1249.2 1296.1 1314.5 1327.6 635.8 721.8 726.7 791.0 829.2 5545.5 5577.2 5815.5 5867.7 5907.9 991.2 995.4 995.6 1010.0 1053.1 3313.4 3550.0 3654.6 3793.6 3861.2 9680.5 9792.2 10020.4 10023.5 10041.8 9336.5 9734.9 9844.9 9922.6 9927.3 7669.6 7854.7 7871.1 7878.7 7887.8 5017.6 5531.6 5594.8 5752.6 5764.0 8915.4 9078.9 9309.5 9325.4 9330.9 8940.0 9302.3 9306.6 9320.0 9339.1 7120.4 7224.4 7261.7 7274.3 7283.1 7793.9 7846.6 7880.0 7886.5 7903.1 6845.0 7007.6 7011.5 7182.1 7182.1 6993.9 7029.6 7043.3 7053.2 7059.3 6391.2 6395.5 6402.0 6459.4 6464.1 4210.3 4916.5 5021.5 5074.2 5074.5 4696.5 4899.9 4944.3 5120.0 5156.4 01:52:40 INFO - PROCESS | 1655 | 01:52:40 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4345.82 Median:4788.95 stddev:1302.79 (27.2%) stddev-sans-first:1271.61 01:52:40 INFO - PROCESS | 1655 | Values: 359.0 361.8 370.4 370.6 380.4 4357.0 4644.8 4904.9 5140.6 5412.3 5034.6 5134.7 5220.6 5242.4 5246.6 3649.0 3958.7 4101.2 4113.3 4170.1 3460.8 3465.5 3613.5 4035.6 4209.3 3471.8 4092.6 4100.8 4120.8 4149.1 3488.3 3920.9 4075.6 4119.0 4151.9 3412.1 3667.2 3676.5 3692.5 3711.7 4496.5 4625.7 4948.3 5013.1 5086.4 4083.6 4162.3 4670.9 4780.6 4797.3 5315.9 5352.9 5508.3 5545.4 5568.3 3521.3 3657.5 3779.2 3827.8 3891.9 5212.5 5589.7 5618.7 5850.3 5887.6 3056.8 3320.0 3655.0 3731.4 3830.0 3635.0 3763.7 3936.2 3936.9 3970.4 3855.4 4196.4 4371.3 4485.8 4533.1 4676.5 4758.3 5043.4 5611.4 5706.8 1214.9 1222.0 1237.8 1268.9 1280.0 751.9 845.8 868.9 878.3 879.2 4410.8 4750.6 4969.0 4989.3 5010.8 5299.0 5457.6 5494.2 5551.9 5565.1 4497.3 4654.6 4686.5 4890.7 4932.8 2569.9 2835.6 2846.6 2859.5 2875.6 5062.4 5186.7 5362.0 5441.5 5683.2 4707.6 5155.5 5649.4 5658.4 5668.9 5065.3 5425.8 5633.6 5668.0 5702.3 4271.8 4695.4 5039.4 5208.1 5230.1 4521.6 5356.7 5394.9 5414.6 5433.6 5394.9 5456.7 5672.9 5693.5 5716.9 3334.2 3662.3 3683.0 3690.6 3703.5 4619.5 4838.2 5274.9 5325.6 5362.4 4776.2 4831.9 5263.7 5290.1 5329.2 4588.8 4630.4 4876.8 4972.6 5218.7 4413.6 5018.0 5021.4 5023.1 5144.4 4494.9 4692.3 5022.3 5067.9 5578.2 5070.2 5351.3 5407.0 5410.5 5418.8 01:52:40 INFO - PROCESS | 1655 | 01:52:40 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:20042.78 Median:23126.52 stddev:28714.96 (124.2%) stddev-sans-first:28758.72 01:52:40 INFO - PROCESS | 1655 | Values: 685.5 719.3 727.5 819.7 829.5 14708.9 15353.5 15371.2 15422.8 15432.2 13714.2 14229.3 14407.4 14444.4 14568.1 678.2 847.4 862.9 864.0 865.0 698.1 836.8 860.8 872.2 873.9 922.4 930.2 930.7 931.1 933.5 920.6 924.6 927.6 928.1 928.2 686.0 688.4 692.8 692.9 694.0 14469.3 14815.9 14873.7 14904.9 14912.9 12164.2 13486.3 13503.8 13638.7 13891.7 11234.3 11279.6 11624.0 11686.4 11696.2 3605.6 3673.7 3678.8 3684.3 3700.3 106798.0 107030.0 108320.0 109793.0 110263.0 10627.5 10781.9 10820.1 10905.6 10918.5 20576.3 21358.8 21989.0 22087.8 22439.4 7639.4 7649.0 7652.5 7807.7 8022.1 4220.5 4282.8 4319.7 4377.9 4387.3 3093.0 3346.9 3601.8 3664.0 3669.3 573.9 641.2 680.6 710.6 731.7 597.0 660.2 698.7 705.7 722.2 9647.2 10151.7 10284.3 10334.5 10638.4 656.6 669.8 684.9 709.5 715.5 4973.6 4980.0 4982.4 5041.3 5046.0 90746.0 95913.0 99786.0 100037.5 103023.5 70654.0 87514.1 88954.6 90780.6 91192.5 59021.4 75765.2 78053.0 78331.6 78629.5 9246.0 9533.3 9644.0 9688.1 9695.5 42032.6 48936.5 53120.5 53127.7 53366.7 55068.9 57743.7 68124.6 68711.0 69428.3 11427.8 12113.3 12518.9 12813.7 12912.1 14199.4 14406.6 14433.9 14575.4 14726.7 13234.4 13645.3 13741.0 13879.2 14083.0 12989.5 13260.3 13333.2 13542.6 13930.5 12415.9 12581.7 13191.1 13413.1 13709.0 9583.4 10961.2 11159.0 11195.6 11308.6 10418.6 11030.9 11119.0 11170.0 11177.3 01:52:40 INFO - PROCESS | 1655 | -------- Summary: end -------- 01:52:40 INFO - PROCESS | 1655 | 01:52:40 INFO - TEST-INFO | 1655: exit 0 01:52:40 INFO - TEST-OK | dromaeo_css | took 1115035ms 01:52:40 INFO - TEST-START | kraken 01:52:40 INFO - operating with platform_type : mac_ 01:52:40 INFO - Initialising browser for kraken test... 01:52:40 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpcpcpyd/profile http://localhost:49243/getInfo.html) 01:52:43 INFO - PROCESS | 1662 | 2017-02-21 01:52:43.511 plugin-container[1664:11187] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 01:52:43 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:52:43 INFO - PROCESS | 1662 | 2017-02-21 01:52:43.512 plugin-container[1664:11187] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 01:52:43 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:52:43 INFO - PROCESS | 1662 | 2017-02-21 01:52:43.512 plugin-container[1664:11187] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:52:43 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 01:52:43 INFO - PROCESS | 1662 | colorDepth:24 01:52:43 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 01:52:43 INFO - PROCESS | 1662 | __metrics 01:52:43 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 01:52:44 INFO - TEST-INFO | 1662: exit 0 01:52:44 INFO - Browser initialized. 01:52:44 INFO - Running cycle 1/1 for kraken test... 01:52:44 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpcpcpyd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:47 INFO - PROCESS | 1665 | 2017-02-21 01:52:47.030 plugin-container[1666:11325] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 01:52:47 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:52:47 INFO - PROCESS | 1665 | 2017-02-21 01:52:47.030 plugin-container[1666:11325] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4327, name = 'com.apple.CFPasteboardClient' 01:52:47 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:52:47 INFO - PROCESS | 1665 | 2017-02-21 01:52:47.030 plugin-container[1666:11325] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:52:56 INFO - PROCESS | 1665 | RSS: Main: 219795456 01:52:56 INFO - PROCESS | 1665 | 01:52:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 01:53:00 INFO - PROCESS | 1665 | RSS: Main: 233824256 01:53:00 INFO - PROCESS | 1665 | 01:53:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 01:53:04 INFO - PROCESS | 1665 | RSS: Main: 241713152 01:53:04 INFO - PROCESS | 1665 | 01:53:07 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 01:53:08 INFO - PROCESS | 1665 | RSS: Main: 245465088 01:53:08 INFO - PROCESS | 1665 | 01:53:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 01:53:10 INFO - PROCESS | 1665 | RSS: Main: 245850112 01:53:10 INFO - PROCESS | 1665 | 01:53:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:53:13 INFO - PROCESS | 1665 | RSS: Main: 247103488 01:53:13 INFO - PROCESS | 1665 | 01:53:16 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 01:53:17 INFO - PROCESS | 1665 | RSS: Main: 250929152 01:53:17 INFO - PROCESS | 1665 | 01:53:20 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 01:53:20 INFO - PROCESS | 1665 | RSS: Main: 250363904 01:53:20 INFO - PROCESS | 1665 | 01:53:23 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 01:53:24 INFO - PROCESS | 1665 | RSS: Main: 250028032 01:53:24 INFO - PROCESS | 1665 | 01:53:26 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:53:26 INFO - PROCESS | 1665 | RSS: Main: 249683968 01:53:26 INFO - PROCESS | 1665 | 01:53:28 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:53:29 INFO - PROCESS | 1665 | RSS: Main: 249696256 01:53:29 INFO - PROCESS | 1665 | 01:53:31 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:53:32 INFO - PROCESS | 1665 | RSS: Main: 249778176 01:53:32 INFO - PROCESS | 1665 | 01:53:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:53:36 INFO - PROCESS | 1665 | RSS: Main: 250077184 01:53:36 INFO - PROCESS | 1665 | 01:53:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:53:39 INFO - PROCESS | 1665 | RSS: Main: 249892864 01:53:39 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 01:53:41 INFO - PROCESS | 1665 | RSS: Main: 251842560 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | __start_tp_report 01:53:41 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 01:53:41 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 01:53:41 INFO - PROCESS | 1665 | |i|pagename|runs| 01:53:41 INFO - PROCESS | 1665 | |0;ai-astar;107;120;120;120;148;175;156;118;119;119 01:53:41 INFO - PROCESS | 1665 | |1;audio-beat-detection;144;112;107;147;114;114;110;113;136;120 01:53:41 INFO - PROCESS | 1665 | |2;audio-dft;199;198;195;200;195;213;277;222;198;197 01:53:41 INFO - PROCESS | 1665 | |3;audio-fft;84;59;58;94;88;84;81;79;72;59 01:53:41 INFO - PROCESS | 1665 | |4;audio-oscillator;85;72;86;63;58;102;111;99;56;69 01:53:41 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;135;107;90;133;91;73;85;75;120;131 01:53:41 INFO - PROCESS | 1665 | |6;imaging-darkroom;131;103;163;103;105;100;171;169;102;103 01:53:41 INFO - PROCESS | 1665 | |7;imaging-desaturate;95;98;91;75;89;99;110;76;90;140 01:53:41 INFO - PROCESS | 1665 | |8;json-parse-financial;59;59;60;61;62;63;73;89;93;95 01:53:41 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;72;79;92;112;114;108;79;69;70;72 01:53:41 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;86;83;87;100;99;77;86;85;86;84 01:53:41 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;143;145;141;145;152;143;169;161;224;186 01:53:41 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;171;170;167;171;172;209;169;171;170;172 01:53:41 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;67;67;70;82;89;89;88;73;67;65 01:53:41 INFO - PROCESS | 1665 | __end_tp_report 01:53:41 INFO - PROCESS | 1665 | __start_cc_report 01:53:41 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,976 01:53:41 INFO - PROCESS | 1665 | __end_cc_report 01:53:41 INFO - PROCESS | 1665 | __startTimestamp1487670821720__endTimestamp 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | ------- Summary: start ------- 01:53:41 INFO - PROCESS | 1665 | Number of tests: 14 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:130.20 Median:120.00 stddev:21.70 (18.1%) stddev-sans-first:21.34 01:53:41 INFO - PROCESS | 1665 | Values: 107.0 120.0 120.0 120.0 148.0 175.0 156.0 118.0 119.0 119.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:121.70 Median:117.00 stddev:14.86 (12.7%) stddev-sans-first:13.39 01:53:41 INFO - PROCESS | 1665 | Values: 144.0 112.0 107.0 147.0 114.0 114.0 110.0 113.0 136.0 120.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:209.40 Median:199.50 stddev:25.31 (12.7%) stddev-sans-first:26.57 01:53:41 INFO - PROCESS | 1665 | Values: 199.0 198.0 195.0 200.0 195.0 213.0 277.0 222.0 198.0 197.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:75.80 Median:82.50 stddev:13.11 (15.9%) stddev-sans-first:13.57 01:53:41 INFO - PROCESS | 1665 | Values: 84.0 59.0 58.0 94.0 88.0 84.0 81.0 79.0 72.0 59.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:70.50 stddev:19.44 (27.6%) stddev-sans-first:20.54 01:53:41 INFO - PROCESS | 1665 | Values: 85.0 72.0 86.0 63.0 58.0 102.0 111.0 99.0 56.0 69.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:104.00 Median:74.00 stddev:24.32 (32.9%) stddev-sans-first:23.07 01:53:41 INFO - PROCESS | 1665 | Values: 135.0 107.0 90.0 133.0 91.0 73.0 85.0 75.0 120.0 131.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:125.00 Median:118.00 stddev:30.80 (26.1%) stddev-sans-first:32.59 01:53:41 INFO - PROCESS | 1665 | Values: 131.0 103.0 163.0 103.0 105.0 100.0 171.0 169.0 102.0 103.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:90.50 stddev:18.55 (20.5%) stddev-sans-first:19.67 01:53:41 INFO - PROCESS | 1665 | Values: 95.0 98.0 91.0 75.0 89.0 99.0 110.0 76.0 90.0 140.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:71.40 Median:68.00 stddev:15.06 (22.1%) stddev-sans-first:15.29 01:53:41 INFO - PROCESS | 1665 | Values: 59.0 59.0 60.0 61.0 62.0 63.0 73.0 89.0 93.0 95.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:86.70 Median:72.00 stddev:18.29 (25.4%) stddev-sans-first:18.61 01:53:41 INFO - PROCESS | 1665 | Values: 72.0 79.0 92.0 112.0 114.0 108.0 79.0 69.0 70.0 72.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.00 stddev:7.02 (8.2%) stddev-sans-first:7.43 01:53:41 INFO - PROCESS | 1665 | Values: 86.0 83.0 87.0 100.0 99.0 77.0 86.0 85.0 86.0 84.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:160.90 Median:156.50 stddev:26.46 (16.9%) stddev-sans-first:27.26 01:53:41 INFO - PROCESS | 1665 | Values: 143.0 145.0 141.0 145.0 152.0 143.0 169.0 161.0 224.0 186.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:171.00 stddev:12.32 (7.2%) stddev-sans-first:13.01 01:53:41 INFO - PROCESS | 1665 | Values: 171.0 170.0 167.0 171.0 172.0 209.0 169.0 171.0 170.0 172.0 01:53:41 INFO - PROCESS | 1665 | 01:53:41 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:77.50 stddev:10.14 (13.1%) stddev-sans-first:10.26 01:53:41 INFO - PROCESS | 1665 | Values: 67.0 67.0 70.0 82.0 89.0 89.0 88.0 73.0 67.0 65.0 01:53:41 INFO - PROCESS | 1665 | -------- Summary: end -------- 01:53:41 INFO - PROCESS | 1665 | 01:53:42 INFO - TEST-INFO | 1665: exit 0 01:53:42 INFO - TEST-OK | kraken | took 61964ms 01:53:42 INFO - SUITE-END | took 1176s 01:53:42 INFO - Completed test suite (00:19:37) 01:53:42 INFO - javascript benchmark 01:53:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7290.921164271801, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2977.315217499975, 3356.899293021209, 3368.040108569057, 3396.252824378636, 3404.14896275931, 5639.069553523669, 5681.005823980808, 5689.345725241598, 5705.9144112838285, 5708.571857110723, 5659.6321239119425, 5738.7991420300295, 5739.081746920494, 5767.990601644706, 5790.884182316351, 5133.204353325231, 5212.244224587433, 5227.26818245446, 5229.294045303874, 5273.789048438058, 5261.342332208474, 5291.973540132294, 5296.894062118756, 5306.973465132688, 5350.35795704516, 5123.385193776733, 5150.124478838607, 5281.70950597717, 5294.655847369928, 5306.177542480922, 3797.917593485871, 4382.342648602703, 4551.65862560306, 5041.470645582216, 5187.559057480119, 5111.897762044776, 5165.070287348276, 5188.247704082924, 5199.948000519984, 5217.895642087137, 5515.310586176728, 5628.380878103405, 5633.915491267593, 5745.511631511326, 5751.884962300731, 6057.697115144225, 6118.3146263159115, 6119.3197658210165, 6148.016317389241, 6233.87532249357, 5272.31459910213, 6298.905516417258, 6309.968450157766, 6316.1788967434395, 6317.589356691847, 5773.451522105393, 5774.422557744276, 5775.913361299584, 5806.767729290823, 5826.067829147359, 6206.286277078104, 6233.96883015582, 6250.312465628777, 6255.343188965184, 6270.6864656766975, 6087.120610201783, 6100.99362449148, 6151.630902145886, 6156.661383623854, 6157.507399408037, 6209.441150296495, 6283.497320214372, 6285.057241413733, 6294.842628934313, 6316.968415157987, 6003.609765365237, 6052.0, 6129.295131059896, 6138.6623735694075, 6203.0, 6244.781432649836, 6253.187085678833, 6259.061140828912, 6265.686715664198, 6282.0, 4959.479254678206, 4972.627052970969, 4975.0796102721115, 4977.9751101244265, 5001.224810154432, 4291.806868690916, 4339.891502712458, 4381.890452738707, 4446.399736035659, 4473.463184417826, 5737.913931291034, 5767.596268261265, 5818.796342128006, 5847.976604094267, 5878.941210587925, 6287.9056814147825, 6290.150829637941, 6295.716692748837, 6306.779262725782, 6314.905276420857, 5529.557635389159, 5576.1356989666665, 5682.573806964494, 5722.599418040781, 5725.570582206268, 5409.43200963901, 5427.728613569306, 5429.1856221566295, 5435.565154787608, 5453.863653408617, 6285.748570057238, 6303.432691057735, 6305.464035557029, 6317.3366796486625, 6321.1782468278825, 6040.788572399945, 6115.3578874217565, 6170.136180934583, 6174.289956655042, 6278.937210627835, 6293.150424692791, 6304.590201637063, 6308.71610777507, 6321.367863213642, 6323.241211054703, 6195.504359651307, 6197.4732147767945, 6200.906986395117, 6207.81376558704, 6211.627302361872, 5869.090291004901, 5980.43185897339, 6131.9272270139245, 6300.306966233802, 6301.6534090625455, 5862.912056319244, 5992.221011268507, 6072.60528065692, 6088.817335479943, 6101.298350689727, 5974.731137098754, 5996.37038110992, 6038.396160384103, 6049.062395328731, 6061.212042434456, 5644.125160600113, 5697.059985102412, 5738.512226460798, 5881.206037184926, 5894.70526473666, 5966.19456373384, 5995.100734889801, 6012.849678758066, 6052.697365131814, 6102.786402475892, 5889.882202355843, 5897.882042359043, 5904.822855314347, 5908.940910590839, 5926.407359264039], "value": 5662.809607631268, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.9022629682024, 464.44266879744316, 469.13912969700596, 471.7051842598376, 493.6914428482199, 30679.693203067964, 32110.67889321109, 34204.0, 40362.39456408153, 41423.58576414235, 42198.0, 42586.935326616775, 42758.786206069, 42805.929851753725, 42903.570964290346, 8288.046874609407, 8544.829103417927, 9041.683541076063, 9342.346035777498, 9359.906400936006, 11005.724856878602, 11259.605913793019, 11296.887031129707, 11436.71408214793, 11444.0, 11301.208915375926, 11351.978321951023, 11354.829677554842, 11374.829377559343, 11377.2035957483, 11242.437878106062, 11290.0, 11313.773724525463, 11319.999999999958, 11325.433728313552, 11212.04697600705, 11258.268212566158, 11260.831087533694, 11274.887251127466, 11324.9807517323, 40785.0, 40966.0, 41019.38470922939, 41148.17703645911, 41179.0, 3920.5491368492417, 3977.105151340954, 4008.2785098682225, 4036.3945408189006, 4051.169510250421, 23500.647490287487, 28521.286967825763, 28799.71200287991, 29005.41989160226, 29283.85358073196, 3025.13783571681, 3041.0724728957657, 3070.5394190871325, 3086.6141732283463, 3139.8116113033293, 454342.0, 486996.0, 487787.0, 487954.0, 491749.0, 55351.72324138354, 57311.0, 57452.71273643605, 57625.0, 62796.372036279055, 64593.67703161454, 65017.699646007764, 65304.04087877371, 65370.0, 65712.0, 16235.0, 16704.0, 16717.331306747838, 16764.329426823035, 16799.91600041992, 10638.840417393745, 11905.642830715093, 12631.494740210472, 12850.421731022127, 12994.415251313525, 16193.757093643604, 16266.18669066542, 16281.51155465338, 16291.0, 16328.591785205228, 6649.468042556584, 6796.93203067963, 7235.865419701201, 7247.782566523013, 7251.093613298338, 838.8741688746737, 848.2620120495209, 857.8455877941906, 860.3246451535515, 882.801823459581, 28896.422071558452, 29484.0, 29526.852365738036, 29886.823880507916, 30322.69677303243, 1027.7071034755058, 1049.3861091261545, 1062.3148069495132, 1089.6404186618397, 1185.1348515583672, 12087.637370878887, 13614.0, 14392.928035359757, 15251.542453726406, 15500.612484687974, 608332.0, 609183.0, 611421.0, 615132.0, 616922.0, 56904.86190276171, 59442.405575944555, 59622.70188649116, 59747.402525975056, 59904.40095599076, 1259.974800504003, 1435.3110506956718, 1452.8038714773581, 1454.3891565542708, 1468.08978433372, 28468.572971405032, 28857.711422885503, 29379.85310073436, 29895.850520747255, 30113.849430752707, 49485.0, 49625.50374496209, 50001.74999124981, 50010.999780004924, 50042.499575003785, 519947.0, 520780.39609803224, 521089.0, 521268.0, 523673.0, 22235.332940011827, 22793.430164245365, 22860.657090143995, 23696.28911132669, 39603.405948911364, 41990.58009419867, 42048.36927446152, 42765.14469710651, 42860.92847678833, 43356.34965475457, 34159.65840341565, 34484.65515344815, 34488.82755586206, 34970.0, 35489.0, 33421.66578334186, 34240.657593424745, 34850.82574587111, 35270.64729352674, 35776.46335305025, 34204.97385078452, 34275.14312142217, 34786.30427391388, 34927.82536087405, 35073.64926350704, 29173.70826291795, 30888.845555772077, 31069.0, 31163.0, 31201.68798311988, 19664.213431463155, 23408.88295558511, 23421.531569368177, 23939.28182154538, 24114.0], "value": 19556.903296128552, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.2039838728993, 394.5462717874446, 401.9769686148752, 402.4124777824377, 419.8412381826159, 16190.83809161908, 19418.126184321703, 20270.39188824334, 20355.49111272219, 20854.37436876896, 21013.0, 21404.678929816066, 21411.44022064995, 21919.232826851065, 22072.558548829013, 5762.308522977238, 6000.159977603139, 6019.91641504529, 6024.819255422344, 6039.516838652898, 5719.19931209631, 5835.212246346752, 5861.0, 5934.228550288456, 5939.4654481096695, 5841.941580584183, 5842.795502157425, 5853.239078919734, 5855.79504717335, 5871.148683440899, 5641.68970706613, 5794.536437085044, 5804.738786754606, 5884.08796636522, 5947.613405128653, 5228.320318358589, 5247.422783493813, 5249.4488078751565, 5256.894862102737, 5257.211418287249, 25812.0, 25898.870505647352, 25979.350516237057, 26441.471170576675, 26667.466650667073, 2538.6065159900245, 2633.8156329056783, 2721.18364490654, 2750.4911591355662, 2771.584262360642, 12796.744065118646, 15936.203189840577, 16059.91970040154, 16267.0, 16636.417725379673, 1806.205269681336, 1884.9717254241198, 1886.3586380630513, 1887.37716553537, 1891.0355718583621, 106351.0, 118573.0, 127802.72197278001, 133064.0, 136322.0, 19960.403167746546, 22359.88200589964, 24520.0, 24613.876930615592, 24973.250802475955, 10098.293119481566, 12877.098603097693, 41338.37992430116, 42131.0, 42191.94520137021, 8322.292605128632, 8405.70580029696, 8465.449745766506, 8505.532195729294, 8546.700865469678, 7265.0, 8767.517786521803, 8772.956135219283, 8844.73465796027, 8896.59965301563, 4093.672506199497, 4161.875143745692, 4183.037901282722, 4206.810693518799, 4269.953861304, 2060.1656329186703, 2096.7500374419587, 2098.548812005426, 2100.537881666031, 2107.2203284784423, 1016.466355163545, 1020.9132223761063, 1027.7379268286538, 1033.9069483746498, 1066.5627092891878, 18469.90765046166, 21586.56826863454, 22053.0, 22057.889710551346, 22566.0, 1048.1771809129796, 1049.9737506562244, 1072.951717172729, 1081.3565928272665, 1091.8471414002047, 11526.827097593543, 11718.296902185895, 11806.763864722829, 11845.526178952918, 11858.407079646156, 741989.0, 749276.0, 752214.0, 754566.0, 773270.0, 135070.0, 148627.0, 154352.0, 159258.20370898073, 159920.0, 955.245356168633, 1049.286485190078, 1061.5329255127874, 1081.8269076947652, 1085.5657736905143, 18713.409360204536, 19596.11817468246, 19618.9209593468, 19634.410967670992, 19653.60692786165, 61750.0, 62071.37928620656, 62552.374476256475, 62921.37078629338, 63705.0, 90015.09984900068, 91288.54355728444, 92470.0, 92842.0, 93379.5993060091, 6382.297947225708, 7301.306375894282, 8023.558704271088, 8422.5788710563, 8495.915040849512, 11727.589534366256, 12919.0, 12968.416421261254, 13425.395857186646, 13451.46194152223, 11125.221234513507, 11135.498902549567, 11313.547458101584, 11338.60314888975, 11593.24643898144, 9003.54982250898, 10853.40306283162, 10974.0, 11238.213325067167, 11626.360550169484, 11371.488283027118, 11614.941925290319, 11662.367268582575, 11765.47055382527, 11792.882071179522, 7813.749800031967, 8271.090180080066, 8382.706605268786, 8499.320054395757, 8569.314454843723, 8232.917670823455, 10238.0, 11238.831417528907, 11457.59898403552, 11599.76800463969], "value": 10476.962196527713, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.736424033074, 1287.5300515311908, 1423.9786403203948, 1426.0944300369263, 1427.4432971141252, 7576.999999999986, 7799.844003119934, 8129.349652027839, 8564.91435085649, 8604.311655067595, 6709.865802683943, 8034.1965803419625, 8378.706745263917, 8382.371322150833, 8425.578721063954, 2294.7934685878267, 2355.646653002046, 2364.361622361961, 2366.8224883133835, 2368.5499755046485, 1997.9200831966705, 2078.085642317383, 2328.406256404623, 2345.718513778349, 2354.3407845803204, 2105.957880842382, 2271.1483193802324, 2357.669926210332, 2359.3511784259294, 2364.775346342103, 2313.8611683298973, 2318.953620927589, 2324.5583339165505, 2336.8714720690355, 2352.4354155002848, 2322.8722420266877, 2329.301209637119, 2385.5348207099623, 2390.5935990881594, 2396.0894859953105, 7019.719211231544, 8378.204070613281, 8405.495670259743, 8456.957715211445, 8460.365472589581, 4676.158291507527, 5271.209318602202, 5275.393329767087, 5276.736163191864, 5279.947200527984, 3285.6057273127376, 3423.058658868831, 3430.433978393562, 3486.1633208030144, 3493.2489514754448, 1140.4981808004452, 1146.776378606172, 1164.1524414450196, 1183.0299154693155, 1184.224333061846, 10619.41593212373, 10687.038166565046, 10746.194035447374, 10806.459677016117, 10811.135109191246, 4536.432945881765, 4723.315119307681, 4787.16224660683, 4789.44921334051, 4790.736509491941, 9449.338546301831, 9474.57364418589, 9483.620655173854, 9522.95238523803, 9530.380525265835, 4484.708493947883, 5233.633645644768, 5244.763985620656, 5255.39562950258, 5258.447862974409, 4682.314306960607, 4733.384659994179, 4749.050189962021, 4826.155422800995, 4829.203181475087, 3921.313770090223, 3964.0, 3998.080441498472, 4058.5332686740812, 4077.8776636700354, 1210.4915935307192, 1249.2129958126504, 1296.0927350854251, 1314.5267703626687, 1327.5818117293022, 635.7933671556763, 721.7546034348346, 726.6947881889619, 790.9559381616211, 829.1956801902145, 5545.528630066409, 5577.163425486128, 5815.476607105381, 5867.70661466925, 5907.911381329283, 991.2020823237219, 995.3977843404635, 995.6117114325419, 1009.9949500252452, 1053.146950969717, 3313.4367157582788, 3549.964500355015, 3654.6162652921594, 3793.6206379361843, 3861.227754449121, 9680.515974201262, 9792.21662267017, 10020.448875311928, 10023.498825058718, 10041.849372259421, 9336.486493242937, 9734.853977190347, 9844.852327215098, 9922.553485093043, 9927.255455840841, 7669.578173200416, 7854.685812567547, 7871.134175240604, 7878.684852605947, 7887.763367098996, 5017.623678224075, 5531.640443371329, 5594.776208951596, 5752.626079304831, 5764.0, 8915.37592368528, 9078.910530736353, 9309.487978161265, 9325.440473571607, 9330.860037099314, 8939.955300223457, 9302.348835581444, 9306.627734890528, 9319.953400232955, 9339.066093390607, 7120.359167674934, 7224.385927196247, 7261.745838895613, 7274.30894065063, 7283.053203083565, 7793.883091753515, 7846.607669616382, 7879.975603171551, 7886.487378320391, 7903.130655627761, 6845.0, 7007.6145811978795, 7011.50919435655, 7182.0663313770965, 7182.138143422822, 6993.895091573732, 7029.61337126463, 7043.260457652078, 7053.188883278283, 7059.2940705928995, 6391.169148010915, 6395.488360931021, 6401.967990160019, 6459.386358295955, 6464.127342808661, 4210.305299625527, 4916.459189489082, 5021.548060674557, 5074.213496907985, 5074.492550744896, 4696.483386827515, 4899.873029203232, 4944.258361245842, 5120.02719483297, 5156.432792392909], "value": 4397.369007123526, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.9712822974162, 361.8245151101716, 370.4036501233016, 370.57384008390346, 380.38567713143266, 4357.0, 4644.815572029132, 4904.901901961958, 5140.614453915957, 5412.296401467808, 5034.572061374778, 5134.666246693962, 5220.634555581111, 5242.449542797999, 5246.554042906348, 3649.0, 3958.6936311017294, 4101.179764047188, 4113.280175969208, 4170.0817623893045, 3460.8442620082033, 3465.5494785677824, 3613.4760459733325, 4035.57626449223, 4209.326507758759, 3471.7916924984456, 4092.6494256895303, 4100.774457404841, 4120.835166593348, 4149.070682132808, 3488.2674638325984, 3920.921746519701, 4075.572064933169, 4119.032027473526, 4151.91696166075, 3412.129906873731, 3667.211549516867, 3676.4632403641403, 3692.5015122958325, 3711.6845068169237, 4496.505384407713, 4625.722456652578, 4948.331975183341, 5013.147764879943, 5086.364204474441, 4083.612056854594, 4162.313218318974, 4670.883227919295, 4780.617550595944, 4797.280407938837, 5315.946840531584, 5352.91970620441, 5508.3114610673665, 5545.445455454463, 5568.331800183963, 3521.3133438979407, 3657.487951686766, 3779.2441511697493, 3827.75119617224, 3891.8832435026993, 5212.478752124757, 5589.664620122806, 5618.690971996498, 5850.268716410449, 5887.646741195542, 3056.831874246938, 3319.9502007469423, 3654.9817250914107, 3731.384321586962, 3830.0041989082483, 3635.018544992837, 3763.6989040876665, 3936.2324346752107, 3936.940945885814, 3970.4441378207075, 3855.363864962306, 4196.433481479961, 4371.278739008092, 4485.8112600160985, 4533.138703646297, 4676.462206846189, 4758.333833263346, 5043.4365346742625, 5611.354694210137, 5706.771729130871, 1214.9210301330386, 1222.0, 1237.7833879071127, 1268.9087384849022, 1280.0, 751.8796992481177, 845.8031884882822, 868.8783570300163, 878.2754227762122, 879.1516186879692, 4410.757408342572, 4750.643701722384, 4969.0, 4989.303636763518, 5010.843168803631, 5299.006061575197, 5457.645253058538, 5494.230807686927, 5551.8889622207325, 5565.1095824667855, 4497.325401189848, 4654.624652826333, 4686.531346865286, 4890.657653964188, 4932.7533623319405, 2569.910053148131, 2835.5888396182436, 2846.644169478815, 2859.47099786536, 2875.5686647003117, 5062.443131255559, 5186.662866913714, 5361.954418888279, 5441.455854414527, 5683.158420789605, 4707.599854012379, 5155.453363990788, 5649.406812284651, 5658.443927919772, 5668.943310566924, 5065.341505604248, 5425.7829686812875, 5633.63381380209, 5668.044524638993, 5702.258706368229, 4271.786410679391, 4695.440984663298, 5039.420466646236, 5208.067908729037, 5230.084735171406, 4521.570450807168, 5356.732163391893, 5394.9460505394445, 5414.566834653139, 5433.565314774887, 5394.946050539601, 5456.727163641882, 5672.87267274772, 5693.4875861172695, 5716.914246286392, 3334.2497937963763, 3662.340778659867, 3682.987178525927, 3690.6493883081066, 3703.481512588186, 4619.528552224544, 4838.194166999544, 5274.892272622792, 5325.627206095536, 5362.418086664521, 4776.2119250324695, 4831.883435184357, 5263.6841789492755, 5290.14332260575, 5329.200619907045, 4588.770561471846, 4630.4443466784205, 4876.78054487556, 4972.632526055364, 5218.712970786643, 4413.624841888475, 5018.0, 5021.422536408214, 5023.097860014542, 5144.382674079135, 4494.887627809331, 4692.343071969859, 5022.267317775361, 5067.885065285779, 5578.191162281528, 5070.188769796815, 5351.3043304370185, 5406.972965135149, 5410.540104091197, 5418.756155973069], "value": 3948.4184258052637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.4893104637047, 719.2591630620462, 727.4689476682025, 819.7376839411389, 829.5396055189369, 14708.852911470896, 15353.462628807994, 15371.231438428062, 15422.768658470131, 15432.151231682254, 13714.24571648559, 14229.288535573205, 14407.351669174912, 14444.422223111089, 14568.053076550017, 678.2064983968744, 847.3729440214228, 862.9309655227567, 863.9654413823439, 865.03548543374, 698.0541366448465, 836.7657056024323, 860.793409581699, 872.2062922740307, 873.9344549158807, 922.4373132389237, 930.2325581395376, 930.7486978515831, 931.0921851195098, 933.4632586262892, 920.5765347939956, 924.5562130177485, 927.6243121535755, 928.0904713380856, 928.22029495224, 685.9725610975555, 688.401091050784, 692.7540723043297, 692.8752824491589, 693.9861202775967, 14469.348879300456, 14815.925920370437, 14873.70252594942, 14904.850951490454, 14912.925435372754, 12164.209326393844, 13486.258255795927, 13503.797443038362, 13638.659033524142, 13891.652708682263, 11234.3259404436, 11279.605213817558, 11623.953844154066, 11686.415679216005, 11696.239744416585, 3605.6214097519646, 3673.669369756708, 3678.779273243614, 3684.281565094808, 3700.333939890819, 106798.0, 107030.0, 108320.0, 109793.0, 110263.0, 10627.52176152075, 10781.9460902695, 10820.134389248999, 10905.563777448971, 10918.50866711, 20576.279830205873, 21358.825264610285, 21989.0, 22087.779122208573, 22439.43901402478, 7639.350655194371, 7648.961755191189, 7652.464327497022, 7807.68769249235, 8022.1175670676175, 4220.451341325669, 4282.828686852553, 4319.654427645781, 4377.890552736143, 4387.298032314814, 3092.9690703092683, 3346.928982725553, 3601.8019008954234, 3664.0107171063664, 3669.339518886626, 573.9024365857731, 641.2049059166693, 680.557637535596, 710.6198183971551, 731.707317073175, 596.9761209551656, 660.1681880830189, 698.6890833579008, 705.6577559883452, 722.1947528505679, 9647.179989700953, 10151.695449136538, 10284.331518451427, 10334.483275836328, 10638.361698298128, 656.5699466849126, 669.8291935556499, 684.948628852828, 709.5246185056025, 715.4741265170096, 4973.6269779765935, 4979.9542096159485, 4982.427020892571, 5041.319421878, 5045.974770126126, 90746.0, 95913.0, 99786.0, 100037.49981250048, 103023.48488257511, 70654.0, 87514.12485875186, 88954.55522722345, 90780.63829042569, 91192.54403727938, 59021.40978590159, 75765.24234757692, 78053.0, 78331.60834195907, 78629.4616742248, 9246.0, 9533.285003624616, 9643.951780241334, 9688.141998110716, 9695.499623180227, 42032.57967420287, 48936.510634893195, 53120.46879531155, 53127.734361327944, 53366.73316633392, 55068.89862202814, 57743.71128144332, 68124.63750725056, 68711.0, 69428.30571694218, 11427.828582571101, 12113.273203607812, 12518.93740531328, 12813.74372512526, 12912.096153269182, 14199.361028753525, 14406.552494415488, 14433.92783036078, 14575.416983320549, 14726.674599286116, 13234.404451799885, 13645.317734113056, 13741.0, 13879.236641984788, 14083.0, 12989.545365912149, 13260.336983150997, 13333.20000799955, 13542.59372218835, 13930.512432064828, 12415.94464470494, 12581.74836503283, 13191.142575732547, 13413.128146670435, 13709.0, 9583.424994500352, 10961.232713709964, 11159.0, 11195.552177912792, 11308.603812467722, 10418.583256669648, 11030.889691102986, 11119.0, 11170.0, 11177.273477223955], "value": 7455.228527117062, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 120.0, 120.0, 148.0, 175.0, 156.0, 118.0, 119.0, 119.0], "value": 130.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 107.0, 147.0, 114.0, 114.0, 110.0, 113.0, 136.0, 120.0], "value": 121.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 198.0, 195.0, 200.0, 195.0, 213.0, 277.0, 222.0, 198.0, 197.0], "value": 209.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 58.0, 94.0, 88.0, 84.0, 81.0, 79.0, 72.0, 59.0], "value": 75.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 86.0, 63.0, 58.0, 102.0, 111.0, 99.0, 56.0, 69.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 107.0, 90.0, 133.0, 91.0, 73.0, 85.0, 75.0, 120.0, 131.0], "value": 104.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 103.0, 163.0, 103.0, 105.0, 100.0, 171.0, 169.0, 102.0, 103.0], "value": 125.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 91.0, 75.0, 89.0, 99.0, 110.0, 76.0, 90.0, 140.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 61.0, 62.0, 63.0, 73.0, 89.0, 93.0, 95.0], "value": 71.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 92.0, 112.0, 114.0, 108.0, 79.0, 69.0, 70.0, 72.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 87.0, 100.0, 99.0, 77.0, 86.0, 85.0, 86.0, 84.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 145.0, 141.0, 145.0, 152.0, 143.0, 169.0, 161.0, 224.0, 186.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 167.0, 171.0, 172.0, 209.0, 169.0, 171.0, 170.0, 172.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 82.0, 89.0, 89.0, 88.0, 73.0, 67.0, 65.0], "value": 75.7, "unit": "score"}]}]} 01:53:42 INFO - Return code: 0 01:53:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:53:43 ERROR - # TBPL SUCCESS # 01:53:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:53:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:53:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:53:43 INFO - 2017-02-21 01:53:43.072 screenresolution[1670:11703] starting screenresolution argv=screenresolution get 01:53:43 INFO - 2017-02-21 01:53:43.074 screenresolution[1670:11703] Display 0: 1600x1200x32@60 01:53:43 INFO - 2017-02-21 01:53:43.080 screenresolution[1671:11706] starting screenresolution argv=screenresolution list 01:53:43 INFO - Available Modes on Display 0 01:53:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:53:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:53:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:53:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:53:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:53:43 INFO - Intel Iris: 01:53:43 INFO - Chipset Model: Intel Iris 01:53:43 INFO - Type: GPU 01:53:43 INFO - Bus: Built-In 01:53:43 INFO - VRAM (Dynamic, Max): 1536 MB 01:53:43 INFO - Vendor: Intel (0x8086) 01:53:43 INFO - Device ID: 0x0a2e 01:53:43 INFO - Revision ID: 0x0009 01:53:43 INFO - Displays: 01:53:43 INFO - Display: 01:53:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:53:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:53:43 INFO - Display Serial Number: 1600x1200 60 01:53:43 INFO - Main Display: Yes 01:53:43 INFO - Mirror: Off 01:53:43 INFO - Online: Yes 01:53:43 INFO - Rotation: Supported 01:53:43 INFO - Return code: 0 01:53:43 INFO - Running post-action listener: _resource_record_post_action 01:53:43 INFO - [mozharness: 2017-02-21 09:53:43.325610Z] Finished run-tests step (success) 01:53:43 INFO - Running post-run listener: _resource_record_post_run 01:53:43 INFO - Total resource usage - Wall time: 1198s; CPU: 55.0%; Read bytes: 33300480; Write bytes: 512877568; Read time: 196; Write time: 1654 01:53:43 INFO - TinderboxPrint: CPU usage
54.6% 01:53:43 INFO - TinderboxPrint: I/O read bytes / time
33,300,480 / 196 01:53:43 INFO - TinderboxPrint: I/O write bytes / time
512,877,568 / 1,654 01:53:43 INFO - TinderboxPrint: CPU idle
2,175.9 (45.4%) 01:53:43 INFO - TinderboxPrint: CPU system
965.7 (20.1%) 01:53:43 INFO - TinderboxPrint: CPU user
1,652.2 (34.5%) 01:53:43 INFO - TinderboxPrint: Swap in / out
237,715,456 / 0 01:53:43 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205539840; Write bytes: 198930432; Read time: 15683; Write time: 438 01:53:43 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 31236096; Write bytes: 302920704; Read time: 177; Write time: 1184 01:53:43 INFO - Running post-run listener: _upload_blobber_files 01:53:43 INFO - Blob upload gear active. 01:53:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:53:43 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 01:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:53:44 INFO - (blobuploader) - INFO - Open directory for files ... 01:53:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:53:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:53:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:44 INFO - (blobuploader) - INFO - Done attempting. 01:53:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:53:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:53:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:45 INFO - (blobuploader) - INFO - Done attempting. 01:53:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:53:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:53:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:46 INFO - (blobuploader) - INFO - Done attempting. 01:53:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:53:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:49 INFO - (blobuploader) - INFO - Done attempting. 01:53:49 INFO - (blobuploader) - INFO - Iteration through files over. 01:53:49 INFO - Return code: 0 01:53:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:53:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:53:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c94f88a8aa4df95fa01d4ba4f6ae6bdd556b0bae072959069a8323eb04da8accf11d18df84e2857403092274fab44ed474fa829d58d8f6ae0e8f0e95478257e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b01e19cac112b8c2de5cc810d852977f680e078a4d5ba4ff7ff63fe1011633a00e8ccc4bc7dbcad78603410427843f8da8da32707f0c89605e962f642db1483", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0eed808d4739cb909cf338a196fe5729854671d6c757f39a530244665933eb8022ca9eb2ffb88611f29658f58486df9aa2198a8b37a9445d713173631f1a2f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8a6182c82c1f6598eb8666b682408b7dc67b18458fa57bf0df2c91271aa02558d03569a42c444802f01f9dcc5d0f440bbefdce4b5a6781ff76372e2747250c6"} 01:53:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:53:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:53:49 INFO - Contents: 01:53:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c94f88a8aa4df95fa01d4ba4f6ae6bdd556b0bae072959069a8323eb04da8accf11d18df84e2857403092274fab44ed474fa829d58d8f6ae0e8f0e95478257e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b01e19cac112b8c2de5cc810d852977f680e078a4d5ba4ff7ff63fe1011633a00e8ccc4bc7dbcad78603410427843f8da8da32707f0c89605e962f642db1483", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0eed808d4739cb909cf338a196fe5729854671d6c757f39a530244665933eb8022ca9eb2ffb88611f29658f58486df9aa2198a8b37a9445d713173631f1a2f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8a6182c82c1f6598eb8666b682408b7dc67b18458fa57bf0df2c91271aa02558d03569a42c444802f01f9dcc5d0f440bbefdce4b5a6781ff76372e2747250c6"} 01:53:49 INFO - Running post-run listener: copy_logs_to_upload_dir 01:53:49 INFO - Copying logs to upload dir... 01:53:49 INFO - mkdir: /builds/slave/test/build/upload/logs 01:53:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.106867 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-21 01:53:49.818927) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 01:53:49.822808) ========= 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.Yl5T0AiPge/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.IS955dti3Y/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c94f88a8aa4df95fa01d4ba4f6ae6bdd556b0bae072959069a8323eb04da8accf11d18df84e2857403092274fab44ed474fa829d58d8f6ae0e8f0e95478257e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b01e19cac112b8c2de5cc810d852977f680e078a4d5ba4ff7ff63fe1011633a00e8ccc4bc7dbcad78603410427843f8da8da32707f0c89605e962f642db1483", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0eed808d4739cb909cf338a196fe5729854671d6c757f39a530244665933eb8022ca9eb2ffb88611f29658f58486df9aa2198a8b37a9445d713173631f1a2f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8a6182c82c1f6598eb8666b682408b7dc67b18458fa57bf0df2c91271aa02558d03569a42c444802f01f9dcc5d0f440bbefdce4b5a6781ff76372e2747250c6"} build_url:https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011116 build_url: 'https://queue.taskcluster.net/v1/task/F5a-daogS_SkXu46XZdAdA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c94f88a8aa4df95fa01d4ba4f6ae6bdd556b0bae072959069a8323eb04da8accf11d18df84e2857403092274fab44ed474fa829d58d8f6ae0e8f0e95478257e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b01e19cac112b8c2de5cc810d852977f680e078a4d5ba4ff7ff63fe1011633a00e8ccc4bc7dbcad78603410427843f8da8da32707f0c89605e962f642db1483", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0eed808d4739cb909cf338a196fe5729854671d6c757f39a530244665933eb8022ca9eb2ffb88611f29658f58486df9aa2198a8b37a9445d713173631f1a2f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8a6182c82c1f6598eb8666b682408b7dc67b18458fa57bf0df2c91271aa02558d03569a42c444802f01f9dcc5d0f440bbefdce4b5a6781ff76372e2747250c6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 01:53:49.857955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 01:53:49.858281) ========= 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.Yl5T0AiPge/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.IS955dti3Y/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.005226 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 01:53:49.907247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 01:53:49.907607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 01:53:49.907954) ========= ========= Total master_lag: 0.19 =========