builder: cedar_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0320 starttime: 1478100205.23 results: success (0) buildid: 20161102031920 builduid: 0c9ce0346bed4ec4ae20a59d4f0c3334 revision: 5a6416971be3800be91952c455ce8f41fa103d8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:25.229428) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:25.229867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:25.230197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:25.255783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:25.256355) ========= 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.e4vasAjFMX/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.HAvJy64vJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-02 08:23:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2016-11-02 08:23:25 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:25.365388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:25.365793) ========= 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.e4vasAjFMX/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.HAvJy64vJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.019075 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:25.415078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 08:23:25.415453) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 5a6416971be3800be91952c455ce8f41fa103d8b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 5a6416971be3800be91952c455ce8f41fa103d8b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e4vasAjFMX/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.HAvJy64vJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-02 08:23:25,440 truncating revision to first 12 chars 2016-11-02 08:23:25,440 Setting DEBUG logging. 2016-11-02 08:23:25,440 attempt 1/10 2016-11-02 08:23:25,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/5a6416971be3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-02 08:23:26,392 unpacking tar archive at: cedar-5a6416971be3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.216259 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 08:23:26.654582) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:26.655113) ========= script_repo_revision: 5a6416971be3800be91952c455ce8f41fa103d8b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:26.655676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:26.656075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 08:23:26.676251) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-02 08:23:26.676764) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e4vasAjFMX/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.HAvJy64vJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:23:26 INFO - MultiFileLogger online at 20161102 08:23:26 in /builds/slave/test 08:23:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 08:23:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:23:26 INFO - {'append_to_log': False, 08:23:26 INFO - 'base_work_dir': '/builds/slave/test', 08:23:26 INFO - 'blob_upload_branch': 'Cedar', 08:23:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:23:26 INFO - 'branch': 'Cedar', 08:23:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:23:26 INFO - 'config_files': ('talos/mac_config.py',), 08:23:26 INFO - 'default_actions': ('clobber', 08:23:26 INFO - 'read-buildbot-config', 08:23:26 INFO - 'download-and-extract', 08:23:26 INFO - 'populate-webroot', 08:23:26 INFO - 'create-virtualenv', 08:23:26 INFO - 'install', 08:23:26 INFO - 'run-tests'), 08:23:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:23:26 INFO - 'download_minidump_stackwalk': True, 08:23:26 INFO - 'download_symbols': 'ondemand', 08:23:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:23:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:23:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:23:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:23:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:23:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:23:26 INFO - 'installer_path': 'installer.exe', 08:23:26 INFO - 'log_level': 'info', 08:23:26 INFO - 'log_name': 'talos', 08:23:26 INFO - 'log_to_console': True, 08:23:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:23:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:23:26 INFO - 'opt_config_files': (), 08:23:26 INFO - 'pip_index': False, 08:23:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:23:26 INFO - 'cmd': ('bash', 08:23:26 INFO - '-c', 08:23:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:23:26 INFO - 'enabled': True, 08:23:26 INFO - 'halt_on_failure': False, 08:23:26 INFO - 'name': 'check_screen_resolution'},), 08:23:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:23:26 INFO - 'cmd': ('bash', 08:23:26 INFO - '-c', 08:23:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:23:26 INFO - 'enabled': True, 08:23:26 INFO - 'halt_on_failure': False, 08:23:26 INFO - 'name': 'check_screen_resolution'},), 08:23:26 INFO - 'run_cmd_checks_enabled': True, 08:23:26 INFO - 'sps_profile': False, 08:23:26 INFO - 'sps_profile_interval': 0, 08:23:26 INFO - 'suite': 'dromaeojs-e10s', 08:23:26 INFO - 'system_bits': '32', 08:23:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:23:26 INFO - 'title': 't-yosemite-r7-0320', 08:23:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:23:26 INFO - 'use_talos_json': True, 08:23:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:23:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:23:26 INFO - 'work_dir': 'build'} 08:23:26 INFO - [mozharness: 2016-11-02 15:23:26.819696Z] Running clobber step. 08:23:26 INFO - Running pre-action listener: _resource_record_pre_action 08:23:26 INFO - Running main action method: clobber 08:23:26 INFO - rmtree: /builds/slave/test/build 08:23:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:23:28 INFO - Running post-action listener: _resource_record_post_action 08:23:28 INFO - [mozharness: 2016-11-02 15:23:28.978550Z] Finished clobber step (success) 08:23:28 INFO - [mozharness: 2016-11-02 15:23:28.978705Z] Running read-buildbot-config step. 08:23:28 INFO - Running pre-action listener: _resource_record_pre_action 08:23:28 INFO - Running main action method: read_buildbot_config 08:23:28 INFO - Using buildbot properties: 08:23:28 INFO - { 08:23:28 INFO - "project": "", 08:23:28 INFO - "product": "firefox", 08:23:28 INFO - "script_repo_revision": "default", 08:23:28 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs-e10s", 08:23:28 INFO - "repository": "", 08:23:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs-e10s", 08:23:28 INFO - "buildid": "20161102031920", 08:23:28 INFO - "pgo_build": "False", 08:23:28 INFO - "basedir": "/builds/slave/test", 08:23:28 INFO - "buildnumber": 0, 08:23:28 INFO - "slavename": "t-yosemite-r7-0320", 08:23:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:23:28 INFO - "platform": "yosemite_r7", 08:23:28 INFO - "scheduler": "tests-cedar-macosx64-talos", 08:23:28 INFO - "branch": "cedar", 08:23:28 INFO - "repo_path": "projects/cedar", 08:23:28 INFO - "revision": "5a6416971be3800be91952c455ce8f41fa103d8b", 08:23:28 INFO - "stage_platform": "macosx64", 08:23:28 INFO - "builduid": "0c9ce0346bed4ec4ae20a59d4f0c3334", 08:23:28 INFO - "slavebuilddir": "test" 08:23:28 INFO - } 08:23:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 08:23:28 INFO - Running post-action listener: _resource_record_post_action 08:23:28 INFO - [mozharness: 2016-11-02 15:23:28.982044Z] Finished read-buildbot-config step (success) 08:23:28 INFO - [mozharness: 2016-11-02 15:23:28.982175Z] Running download-and-extract step. 08:23:28 INFO - Running pre-action listener: _resource_record_pre_action 08:23:28 INFO - Running main action method: download_and_extract 08:23:28 INFO - mkdir: /builds/slave/test/build/tests 08:23: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')]} 08:23:28 INFO - trying https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 08:23:28 INFO - Downloading https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:23:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 08:23:29 INFO - Downloaded 1199 bytes. 08:23:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:23:29 INFO - Using the following test package requirements: 08:23:29 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:23:29 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 08:23:29 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 08:23:29 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:23:29 INFO - u'jsshell-mac.zip'], 08:23:29 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 08:23:29 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:23:29 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 08:23:29 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 08:23:29 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 08:23:29 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 08:23:29 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:23:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:23:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:23:29 INFO - Fetch https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:23:30 INFO - Http code: 200 08:23:30 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 08:23:30 INFO - x-amz-cf-id: 2FP_FOOcBUJeq374nQA3C2-STXOtYsOYYfkl2gJO59r0MLlgWyqXZQ== 08:23:30 INFO - x-amz-version-id: 4suIaeceLPa2fcS74rfJ_nTkHxEc2IER 08:23:30 INFO - Expected file size: 16404894 08:23:30 INFO - Obtained file size: 16404894 08:23:37 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:23:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:23:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:23:37 INFO - Fetch https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:23:37 INFO - Http code: 200 08:23:37 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 08:23:37 INFO - x-amz-cf-id: 269VVGUR5CU_L4CI6CieyWSVzjC9tgK_f6m2jRqbfYO0sLgQfcv5iw== 08:23:37 INFO - x-amz-version-id: 4suIaeceLPa2fcS74rfJ_nTkHxEc2IER 08:23:38 INFO - Expected file size: 16404894 08:23:38 INFO - Obtained file size: 16404894 08:23:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 08:23:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:23:44 INFO - Fetch https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 08:23:45 INFO - Http code: 200 08:23:45 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 08:23:45 INFO - x-amz-cf-id: AuGgUM-pzFD6cX9i0CEiLGvz__szAydp17w5gHUEPqfmGOFHP-CwlA== 08:23:45 INFO - x-amz-version-id: pQhujBwuDjQl6W42zTvZg52Te2xESlNt 08:23:45 INFO - Expected file size: 14409038 08:23:45 INFO - Obtained file size: 14409038 08:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:46 INFO - trying https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:23:46 INFO - Downloading https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 08:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 08:23:49 INFO - Downloaded 112095494 bytes. 08:23:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:23:49 INFO - mkdir: /builds/slave/test/properties 08:23:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:49 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:49 INFO - Contents: 08:23:49 INFO - build_url:https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:23:49 INFO - Running post-action listener: _resource_record_post_action 08:23:49 INFO - Running post-action listener: set_extra_try_arguments 08:23:49 INFO - [mozharness: 2016-11-02 15:23:49.827496Z] Finished download-and-extract step (success) 08:23:49 INFO - [mozharness: 2016-11-02 15:23:49.827612Z] Running populate-webroot step. 08:23:49 INFO - Running pre-action listener: _resource_record_pre_action 08:23:49 INFO - Running main action method: populate_webroot 08:23:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:49 INFO - '--tppagecycles', 08:23:49 INFO - '7'], 08:23:49 INFO - 'tests': ['tsvgm']}}, 08:23:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['damp', 'tps']}, 08:23:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'tests': ['damp', 'tps']}, 08:23:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['dromaeo_dom']}, 08:23:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['basic_compositor_video']}, 08:23:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:23:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['tsvgx', 08:23:49 INFO - 'tsvgr_opacity', 08:23:49 INFO - 'tart', 08:23:49 INFO - 'tscrollx', 08:23:49 INFO - 'cart']}, 08:23:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:49 INFO - 'tsvgr_opacity', 08:23:49 INFO - 'tart', 08:23:49 INFO - 'tscrollx', 08:23:49 INFO - 'cart']}, 08:23:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['tp5o']}, 08:23:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'tests': ['tp5o']}, 08:23:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'talos_options': ['--disable-e10s', 08:23:49 INFO - '--xperf_path', 08:23:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:49 INFO - 'tests': ['tp5n']}, 08:23:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'talos_options': ['--xperf_path', 08:23:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:49 INFO - 'tests': ['tp5n']}}, 08:23:49 INFO - 'talos.zip': {'path': '', 08:23:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:49 INFO - Running post-action listener: _resource_record_post_action 08:23:49 INFO - [mozharness: 2016-11-02 15:23:49.846584Z] Finished populate-webroot step (success) 08:23:49 INFO - [mozharness: 2016-11-02 15:23:49.846716Z] Running create-virtualenv step. 08:23:49 INFO - Running pre-action listener: _resource_record_pre_action 08:23:49 INFO - Running main action method: create_virtualenv 08:23:49 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:49 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 08:23:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:49 INFO - Using real prefix '/tools/python27' 08:23:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:53 INFO - Installing pip.................done. 08:23:53 INFO - Return code: 0 08:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:23:53 INFO - Reading from file tmpfile_stdout 08:23:53 INFO - Output received: 08:23:53 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) 08:23:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:53 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 0x1045b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10452e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bbc6b370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, '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.e4vasAjFMX/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.HAvJy64vJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:23:53 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 08:23:53 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 08:23:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:23:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:53 INFO - 'HOME': '/Users/cltbld', 08:23:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:53 INFO - 'LOGNAME': 'cltbld', 08:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:53 INFO - 'MOZ_NO_REMOTE': '1', 08:23:53 INFO - 'NO_EM_RESTART': '1', 08:23:53 INFO - 'PAGER': '/bin/cat', 08:23:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:53 INFO - 'PWD': '/builds/slave/test', 08:23:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:53 INFO - 'SHELL': '/bin/bash', 08:23:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:23:53 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:23:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:53 INFO - 'USER': 'cltbld', 08:23:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:53 INFO - 'XPC_FLAGS': '0x0', 08:23:53 INFO - 'XPC_SERVICE_NAME': '0', 08:23:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:54 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 08:23:54 INFO - Cleaning up... 08:23:54 INFO - Return code: 0 08:23:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23:54 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')]} 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 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')]} 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 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 0x1045b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10452e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bbc6b370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, '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.e4vasAjFMX/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.HAvJy64vJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:23:54 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 08:23:54 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 08:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:54 INFO - 'HOME': '/Users/cltbld', 08:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:54 INFO - 'LOGNAME': 'cltbld', 08:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:54 INFO - 'MOZ_NO_REMOTE': '1', 08:23:54 INFO - 'NO_EM_RESTART': '1', 08:23:54 INFO - 'PAGER': '/bin/cat', 08:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:54 INFO - 'PWD': '/builds/slave/test', 08:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:54 INFO - 'SHELL': '/bin/bash', 08:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:23:54 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:54 INFO - 'USER': 'cltbld', 08:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:54 INFO - 'XPC_FLAGS': '0x0', 08:23:54 INFO - 'XPC_SERVICE_NAME': '0', 08:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:54 INFO - Downloading/unpacking psutil>=3.1.1 08:23:54 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 08:23:54 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 08:23:54 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 08:23:54 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 08:23:54 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 08:23:54 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 08:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:57 INFO - Installing collected packages: psutil 08:23:57 INFO - Running setup.py install for psutil 08:23:58 INFO - building 'psutil._psutil_osx' extension 08:23:58 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 08:23:58 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 08:23:58 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 08:23:58 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 08:23:58 INFO - building 'psutil._psutil_posix' extension 08:23:58 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 08:23:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:23:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:23:58 INFO - ^ 08:23:58 INFO - 1 warning generated. 08:23:58 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 08:23:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:58 INFO - Successfully installed psutil 08:23:58 INFO - Cleaning up... 08:23:58 INFO - Return code: 0 08:23:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1045b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10452e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bbc6b370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, '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.e4vasAjFMX/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.HAvJy64vJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:23:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:23:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:23:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:58 INFO - 'HOME': '/Users/cltbld', 08:23:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:58 INFO - 'LOGNAME': 'cltbld', 08:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:58 INFO - 'MOZ_NO_REMOTE': '1', 08:23:58 INFO - 'NO_EM_RESTART': '1', 08:23:58 INFO - 'PAGER': '/bin/cat', 08:23:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:58 INFO - 'PWD': '/builds/slave/test', 08:23:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:58 INFO - 'SHELL': '/bin/bash', 08:23:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:23:58 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:23:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:58 INFO - 'USER': 'cltbld', 08:23:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:58 INFO - 'XPC_FLAGS': '0x0', 08:23:58 INFO - 'XPC_SERVICE_NAME': '0', 08:23:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:24:01 INFO - Installing collected packages: mozsystemmonitor 08:24:01 INFO - Running setup.py install for mozsystemmonitor 08:24:01 INFO - Successfully installed mozsystemmonitor 08:24:01 INFO - Cleaning up... 08:24:01 INFO - Return code: 0 08:24:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:24:01 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')]} 08:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:01 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')]} 08:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:01 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 0x1045b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10452e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bbc6b370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, '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.e4vasAjFMX/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.HAvJy64vJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:24:01 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 08:24:01 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 08:24:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:24:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:01 INFO - 'HOME': '/Users/cltbld', 08:24:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:01 INFO - 'LOGNAME': 'cltbld', 08:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:01 INFO - 'MOZ_NO_REMOTE': '1', 08:24:01 INFO - 'NO_EM_RESTART': '1', 08:24:01 INFO - 'PAGER': '/bin/cat', 08:24:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:01 INFO - 'PWD': '/builds/slave/test', 08:24:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:01 INFO - 'SHELL': '/bin/bash', 08:24:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:24:01 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:24:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:01 INFO - 'USER': 'cltbld', 08:24:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:01 INFO - 'XPC_FLAGS': '0x0', 08:24:01 INFO - 'XPC_SERVICE_NAME': '0', 08:24:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:02 INFO - Downloading/unpacking jsonschema==2.5.1 08:24:02 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 08:24:02 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 08:24:02 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 08:24:02 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 08:24:02 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 08:24:02 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 08:24:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:24:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:24:04 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 08:24:04 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 08:24:04 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 08:24:04 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 08:24:04 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 08:24:04 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 08:24:05 INFO - Downloading functools32-3.2.3-2.tar.gz 08:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:24:05 INFO - warning: no files found matching '*.txt' 08:24:05 INFO - no previously-included directories found matching 'build' 08:24:05 INFO - no previously-included directories found matching 'dist' 08:24:05 INFO - no previously-included directories found matching '.git*' 08:24:05 INFO - Installing collected packages: jsonschema, functools32 08:24:05 INFO - Running setup.py install for functools32 08:24:05 INFO - warning: no files found matching '*.txt' 08:24:05 INFO - no previously-included directories found matching 'build' 08:24:05 INFO - no previously-included directories found matching 'dist' 08:24:05 INFO - no previously-included directories found matching '.git*' 08:24:05 INFO - Successfully installed jsonschema functools32 08:24:05 INFO - Cleaning up... 08:24:05 INFO - Return code: 0 08:24:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:24: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')]} 08:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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')]} 08:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:05 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 0x1045b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10452e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bbc6b370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, '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.e4vasAjFMX/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.HAvJy64vJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:24:05 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 08:24:05 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 08:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:05 INFO - 'HOME': '/Users/cltbld', 08:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:05 INFO - 'LOGNAME': 'cltbld', 08:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:05 INFO - 'MOZ_NO_REMOTE': '1', 08:24:05 INFO - 'NO_EM_RESTART': '1', 08:24:05 INFO - 'PAGER': '/bin/cat', 08:24:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:05 INFO - 'PWD': '/builds/slave/test', 08:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:05 INFO - 'SHELL': '/bin/bash', 08:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:24:05 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:05 INFO - 'USER': 'cltbld', 08:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:05 INFO - 'XPC_FLAGS': '0x0', 08:24:05 INFO - 'XPC_SERVICE_NAME': '0', 08:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:24:05 INFO - Cleaning up... 08:24:05 INFO - Return code: 0 08:24:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:24: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')]} 08:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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')]} 08:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:05 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 0x1045b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10452e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bbc6b370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, '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.e4vasAjFMX/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.HAvJy64vJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:24:05 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 08:24:05 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 08:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:05 INFO - 'HOME': '/Users/cltbld', 08:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:05 INFO - 'LOGNAME': 'cltbld', 08:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:05 INFO - 'MOZ_NO_REMOTE': '1', 08:24:05 INFO - 'NO_EM_RESTART': '1', 08:24:05 INFO - 'PAGER': '/bin/cat', 08:24:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:05 INFO - 'PWD': '/builds/slave/test', 08:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:05 INFO - 'SHELL': '/bin/bash', 08:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:24:05 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:05 INFO - 'USER': 'cltbld', 08:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:05 INFO - 'XPC_FLAGS': '0x0', 08:24:05 INFO - 'XPC_SERVICE_NAME': '0', 08:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:05 INFO - Downloading/unpacking blobuploader==1.2.4 08:24:05 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 08:24:05 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 08:24:05 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 08:24:05 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 08:24:05 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 08:24:05 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 08:24:08 INFO - Downloading blobuploader-1.2.4.tar.gz 08:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:24:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:24:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:09 INFO - Downloading docopt-0.6.1.tar.gz 08:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:24:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:24:09 INFO - Running setup.py install for blobuploader 08:24:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:24:09 INFO - Running setup.py install for requests 08:24:10 INFO - Running setup.py install for docopt 08:24:10 INFO - Successfully installed blobuploader requests docopt 08:24:10 INFO - Cleaning up... 08:24:10 INFO - Return code: 0 08:24:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:10 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 0x1045b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10452e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bbc6b370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, '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.e4vasAjFMX/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.HAvJy64vJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:24:10 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 08:24:10 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 08:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:10 INFO - 'HOME': '/Users/cltbld', 08:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:10 INFO - 'LOGNAME': 'cltbld', 08:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:10 INFO - 'MOZ_NO_REMOTE': '1', 08:24:10 INFO - 'NO_EM_RESTART': '1', 08:24:10 INFO - 'PAGER': '/bin/cat', 08:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:10 INFO - 'PWD': '/builds/slave/test', 08:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:10 INFO - 'SHELL': '/bin/bash', 08:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:24:10 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:10 INFO - 'USER': 'cltbld', 08:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:10 INFO - 'XPC_FLAGS': '0x0', 08:24:10 INFO - 'XPC_SERVICE_NAME': '0', 08:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-se5768-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-v7GUFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-rS48JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ZwVOaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-NFgcUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-CdRmb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-tYtj1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ohSQFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-wG6Jqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-j965Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:12 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-09r45C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:12 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-8sXzS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:12 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-cBOwkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:12 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-XfgFPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:12 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-1IIk93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:12 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-a8Gf_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:12 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-bStPT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:12 INFO - Running setup.py install for manifestparser 08:24:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Running setup.py install for mozcrash 08:24:13 INFO - Running setup.py install for mozdebug 08:24:13 INFO - Running setup.py install for mozdevice 08:24:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Running setup.py install for mozfile 08:24:13 INFO - Running setup.py install for mozhttpd 08:24:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Running setup.py install for mozinfo 08:24:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Running setup.py install for mozInstall 08:24:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Running setup.py install for mozleak 08:24:14 INFO - Running setup.py install for mozlog 08:24:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:24:14 INFO - Running setup.py install for moznetwork 08:24:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:24:14 INFO - Running setup.py install for mozprocess 08:24:14 INFO - Running setup.py install for mozprofile 08:24:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:24:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:24:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:24:14 INFO - Running setup.py install for mozrunner 08:24:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:24:14 INFO - Running setup.py install for mozscreenshot 08:24:15 INFO - Running setup.py install for moztest 08:24:15 INFO - Running setup.py install for mozversion 08:24:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:24:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:24:15 INFO - Cleaning up... 08:24:15 INFO - Return code: 0 08:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:15 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 0x1045b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10452e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bbc6b370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, '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.e4vasAjFMX/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.HAvJy64vJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:24:15 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 08:24:15 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 08:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:15 INFO - 'HOME': '/Users/cltbld', 08:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:15 INFO - 'LOGNAME': 'cltbld', 08:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:15 INFO - 'MOZ_NO_REMOTE': '1', 08:24:15 INFO - 'NO_EM_RESTART': '1', 08:24:15 INFO - 'PAGER': '/bin/cat', 08:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:15 INFO - 'PWD': '/builds/slave/test', 08:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:15 INFO - 'SHELL': '/bin/bash', 08:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:24:15 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:15 INFO - 'USER': 'cltbld', 08:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:15 INFO - 'XPC_FLAGS': '0x0', 08:24:15 INFO - 'XPC_SERVICE_NAME': '0', 08:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-i5h3zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-BkqYeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:15 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-kWUV6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:16 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-sO9Gjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:16 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Do2fUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:16 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)) 08:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:16 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-bTbxxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:16 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)) 08:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:16 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-pV1b3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:16 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)) 08:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:16 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Xc8zBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:16 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)) 08:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:16 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-o69wqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:16 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)) 08:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:16 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-xQGW5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:16 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)) 08:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:16 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ssvLrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:16 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)) 08:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:16 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-mNhNbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:16 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-pfAs1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:17 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-vxQg9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:17 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-hlmCxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:17 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-x2wIMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:17 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-2AhwlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:17 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)) 08:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:24:17 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)) 08:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:24:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:20 INFO - Downloading blessings-1.6.tar.gz 08:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:24:20 INFO - Installing collected packages: blessings 08:24:20 INFO - Running setup.py install for blessings 08:24:20 INFO - Successfully installed blessings 08:24:20 INFO - Cleaning up... 08:24:20 INFO - Return code: 0 08:24:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:20 INFO - Reading from file tmpfile_stdout 08:24:20 INFO - Current package versions: 08:24:20 INFO - blessings == 1.6 08:24:20 INFO - blobuploader == 1.2.4 08:24:20 INFO - docopt == 0.6.1 08:24:20 INFO - functools32 == 3.2.3-2 08:24:20 INFO - jsonschema == 2.5.1 08:24:20 INFO - manifestparser == 1.1 08:24:20 INFO - mozInstall == 1.12 08:24:20 INFO - mozcrash == 0.17 08:24:20 INFO - mozdebug == 0.1 08:24:20 INFO - mozdevice == 0.48 08:24:20 INFO - mozfile == 1.2 08:24:20 INFO - mozhttpd == 0.7 08:24:20 INFO - mozinfo == 0.9 08:24:20 INFO - mozleak == 0.1 08:24:20 INFO - mozlog == 3.4 08:24:20 INFO - moznetwork == 0.27 08:24:20 INFO - mozprocess == 0.23 08:24:20 INFO - mozprofile == 0.28 08:24:20 INFO - mozrunner == 6.12 08:24:20 INFO - mozscreenshot == 0.1 08:24:20 INFO - mozsystemmonitor == 0.3 08:24:20 INFO - moztest == 0.7 08:24:20 INFO - mozversion == 1.4 08:24:20 INFO - psutil == 3.1.1 08:24:20 INFO - requests == 1.2.3 08:24:20 INFO - wsgiref == 0.1.2 08:24:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:20 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')]} 08:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:20 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')]} 08:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:20 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 0x1045b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10452e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bbc6b370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, '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.e4vasAjFMX/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.HAvJy64vJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:24:20 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 08:24:20 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 08:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:20 INFO - 'HOME': '/Users/cltbld', 08:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:20 INFO - 'LOGNAME': 'cltbld', 08:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:20 INFO - 'MOZ_NO_REMOTE': '1', 08:24:20 INFO - 'NO_EM_RESTART': '1', 08:24:20 INFO - 'PAGER': '/bin/cat', 08:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:20 INFO - 'PWD': '/builds/slave/test', 08:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:20 INFO - 'SHELL': '/bin/bash', 08:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:24:20 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:20 INFO - 'USER': 'cltbld', 08:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:20 INFO - 'XPC_FLAGS': '0x0', 08:24:20 INFO - 'XPC_SERVICE_NAME': '0', 08:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 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)) 08:24:20 INFO - Cleaning up... 08:24:20 INFO - Return code: 0 08:24:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:24:20 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')]} 08:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:20 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')]} 08:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:20 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 0x1045b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10452e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bbc6b370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, '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.e4vasAjFMX/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.HAvJy64vJw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 08:24:20 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 08:24:20 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 08:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:20 INFO - 'HOME': '/Users/cltbld', 08:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:20 INFO - 'LOGNAME': 'cltbld', 08:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:20 INFO - 'MOZ_NO_REMOTE': '1', 08:24:20 INFO - 'NO_EM_RESTART': '1', 08:24:20 INFO - 'PAGER': '/bin/cat', 08:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:20 INFO - 'PWD': '/builds/slave/test', 08:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:20 INFO - 'SHELL': '/bin/bash', 08:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:24:20 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:20 INFO - 'USER': 'cltbld', 08:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:20 INFO - 'XPC_FLAGS': '0x0', 08:24:20 INFO - 'XPC_SERVICE_NAME': '0', 08:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:24:21 INFO - Cleaning up... 08:24:21 INFO - Return code: 0 08:24:21 INFO - Running post-action listener: _resource_record_post_action 08:24:21 INFO - Running post-action listener: _start_resource_monitoring 08:24:21 INFO - Starting resource monitoring. 08:24:21 INFO - [mozharness: 2016-11-02 15:24:21.260958Z] Finished create-virtualenv step (success) 08:24:21 INFO - [mozharness: 2016-11-02 15:24:21.261999Z] Running install step. 08:24:21 INFO - Running pre-action listener: _resource_record_pre_action 08:24:21 INFO - Running main action method: install 08:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:21 INFO - Reading from file tmpfile_stdout 08:24:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:24:21 INFO - Reading from file tmpfile_stdout 08:24:21 INFO - Output received: 08:24:21 INFO - Usage: mozinstall [options] installer 08:24:21 INFO - Options: 08:24:21 INFO - -h, --help show this help message and exit 08:24:21 INFO - -d DEST, --destination=DEST 08:24:21 INFO - Directory to install application into. [default: 08:24:21 INFO - "/builds/slave/test"] 08:24:21 INFO - --app=APP Application being installed. [default: firefox] 08:24:21 INFO - mkdir: /builds/slave/test/build/application 08:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:24:56 INFO - Reading from file tmpfile_stdout 08:24:56 INFO - Output received: 08:24:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:24:56 INFO - Running post-action listener: _resource_record_post_action 08:24:56 INFO - [mozharness: 2016-11-02 15:24:56.662317Z] Finished install step (success) 08:24:56 INFO - [mozharness: 2016-11-02 15:24:56.662460Z] Running run-tests step. 08:24:56 INFO - Running pre-action listener: _resource_record_pre_action 08:24:56 INFO - Running main action method: run_tests 08:24:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:24:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:24:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:24:56 INFO - 2016-11-02 08:24:56.677 screenresolution[1927:18130] starting screenresolution argv=screenresolution get 08:24:56 INFO - 2016-11-02 08:24:56.680 screenresolution[1927:18130] Display 0: 1600x1200x32@60 08:24:56 INFO - 2016-11-02 08:24:56.686 screenresolution[1928:18133] starting screenresolution argv=screenresolution list 08:24:56 INFO - Available Modes on Display 0 08:24:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:24:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:24:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:24:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:24:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:24:56 INFO - Intel Iris: 08:24:56 INFO - Chipset Model: Intel Iris 08:24:56 INFO - Type: GPU 08:24:56 INFO - Bus: Built-In 08:24:56 INFO - VRAM (Dynamic, Max): 1536 MB 08:24:56 INFO - Vendor: Intel (0x8086) 08:24:56 INFO - Device ID: 0x0a2e 08:24:56 INFO - Revision ID: 0x0009 08:24:56 INFO - Displays: 08:24:56 INFO - Display: 08:24:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:24:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:24:56 INFO - Display Serial Number: 1600x1200 60 08:24:56 INFO - Main Display: Yes 08:24:56 INFO - Mirror: Off 08:24:56 INFO - Online: Yes 08:24:56 INFO - Rotation: Supported 08:24:56 INFO - Return code: 0 08:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:24:56 INFO - Python 2.7.3 08:24:56 INFO - Return code: 0 08:24:56 INFO - grabbing minidump binary from tooltool 08:24:56 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')]} 08:24:56 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 0x1043ccd30>, '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 0x1041f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043c4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:24:56 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 08:24:56 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 08:24:56 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 08:24:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:57 INFO - Return code: 0 08:24:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:24:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:24:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:24:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:24:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 08:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0320 --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 08:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e4vasAjFMX/Render', 08:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:57 INFO - 'HOME': '/Users/cltbld', 08:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:57 INFO - 'LOGNAME': 'cltbld', 08:24:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:24:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:57 INFO - 'MOZ_NO_REMOTE': '1', 08:24:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:24:57 INFO - 'NO_EM_RESTART': '1', 08:24:57 INFO - 'PAGER': '/bin/cat', 08:24:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:57 INFO - 'PWD': '/builds/slave/test', 08:24:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:57 INFO - 'SHELL': '/bin/bash', 08:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HAvJy64vJw/Listeners', 08:24:57 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 08:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:57 INFO - 'USER': 'cltbld', 08:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:57 INFO - 'XPC_FLAGS': '0x0', 08:24:57 INFO - 'XPC_SERVICE_NAME': '0', 08:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 08:24:57 INFO - mozversion application_buildid: 20161102031920 08:24:57 INFO - mozversion application_changeset: 5a6416971be3800be91952c455ce8f41fa103d8b 08:24:57 INFO - mozversion application_display_name: Nightly 08:24:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:57 INFO - mozversion application_name: Firefox 08:24:57 INFO - mozversion application_remotingname: firefox 08:24:57 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 08:24:57 INFO - mozversion application_vendor: Mozilla 08:24:57 INFO - mozversion application_version: 52.0a1 08:24:57 INFO - mozversion platform_buildid: 20161102031920 08:24:57 INFO - mozversion platform_changeset: 5a6416971be3800be91952c455ce8f41fa103d8b 08:24:57 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 08:24:57 INFO - mozversion platform_version: 52.0a1 08:24:57 INFO - using testdate: 1478100297 08:24:57 INFO - actual date: 1478100297 08:24:57 INFO - starting webserver on 'localhost:57251' 08:24:57 INFO - SUITE-START | Running 2 tests 08:24:57 INFO - TEST-START | dromaeo_css 08:24:57 INFO - operating with platform_type : mac_ 08:24:57 INFO - Initialising browser for dromaeo_css test... 08:24:57 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpJriAd3/profile http://localhost:57251/getInfo.html) 08:24:59 INFO - PROCESS | 1938 | 2016-11-02 08:24:59.949 plugin-container[1940:18290] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f4b, name = 'com.apple.tsm.portname' 08:24:59 INFO - PROCESS | 1938 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:24:59 INFO - PROCESS | 1938 | 2016-11-02 08:24:59.951 plugin-container[1940:18290] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9517, name = 'com.apple.CFPasteboardClient' 08:24:59 INFO - PROCESS | 1938 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:24:59 INFO - PROCESS | 1938 | 2016-11-02 08:24:59.951 plugin-container[1940:18290] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:25:00 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 08:25:00 INFO - PROCESS | 1938 | colorDepth:24 08:25:00 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 08:25:00 INFO - PROCESS | 1938 | __metrics 08:25:00 ERROR - PROCESS | 1938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 08:25:00 INFO - TEST-INFO | 1938: exit 0 08:25:00 INFO - Browser initialized. 08:25:00 INFO - Running cycle 1/1 for dromaeo_css test... 08:25:00 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpJriAd3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:03 INFO - PROCESS | 1941 | 2016-11-02 08:25:03.231 plugin-container[1942:18408] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x894b, name = 'com.apple.tsm.portname' 08:25:03 INFO - PROCESS | 1941 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:25:03 INFO - PROCESS | 1941 | 2016-11-02 08:25:03.232 plugin-container[1942:18408] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 08:25:03 INFO - PROCESS | 1941 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:25:03 INFO - PROCESS | 1941 | 2016-11-02 08:25:03.232 plugin-container[1942:18408] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:25:12 INFO - PROCESS | 1941 | RSS: Main: 238051328 08:25:12 INFO - PROCESS | 1941 | 08:26:02 INFO - PROCESS | 1941 | 1478100362467 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:28:16 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57251/tests/dromaeo/cssquery-ext.html) 08:28:18 INFO - PROCESS | 1941 | RSS: Main: 251064320 08:28:18 INFO - PROCESS | 1941 | 08:31:20 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57251/tests/dromaeo/cssquery-ext.html (next: http://localhost:57251/tests/dromaeo/cssquery-jquery.html) 08:31:21 INFO - PROCESS | 1941 | RSS: Main: 263364608 08:31:21 INFO - PROCESS | 1941 | 08:34:23 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57251/tests/dromaeo/cssquery-mootools.html) 08:34:23 INFO - PROCESS | 1941 | RSS: Main: 267370496 08:34:23 INFO - PROCESS | 1941 | 08:37:25 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57251/tests/dromaeo/cssquery-prototype.html) 08:37:26 INFO - PROCESS | 1941 | RSS: Main: 266121216 08:37:26 INFO - PROCESS | 1941 | 08:40:29 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57251/tests/dromaeo/cssquery-yui.html) 08:40:29 INFO - PROCESS | 1941 | RSS: Main: 270512128 08:40:29 INFO - PROCESS | 1941 | 08:43:32 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57251/tests/dromaeo/cssquery-yui.html (next: http://localhost:57251/tests/dromaeo/cssquery-dojo.html) 08:43:32 INFO - PROCESS | 1941 | RSS: Main: 273215488 08:43:32 INFO - PROCESS | 1941 | 08:43:32 INFO - PROCESS | 1941 | __start_tp_report 08:43:32 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 08:43:32 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 08:43:32 INFO - PROCESS | 1941 | |i|pagename|runs| 08:43:32 INFO - PROCESS | 1941 | |0;dojo.html;3274.1814546363407;3298.818564978926;3322.053214833772;3337.415952208363;3337.8831740889073;5435.864103397417;5575.275214222151;5579.553635709139;5580.609357344987;5662.886742265152;5528.419515950827;5610.69141197234;5655.632383895054;5706.9429305707035;5707.65754054757;5103.591712662978;5125.436202017775;5152.175651895697;5248.448912864152;5275.894482110355;5123.333966584358;5258.079836028699;5264.736763161845;5265.9473405266035;5338.946610533903;4160.9375859362135;4908.165611845995;5100.846974590768;5213.556847667915;5245;5177.534021938043;5184.922226166611;5200.6879587224885;5201.40183878855;5261.947380526184;4977.9751101244265;5080.695158290514;5141.100307446182;5180.4042535108565;5197.610179236534;4615.653825963032;5473.507384335429;5502.147167189092;5556.388797232301;5683.886322273573;5317.946820531823;5954.2259506264345;6118.7105509428;6138.324784273726;6154.353792851731;6183.783567575113;6192.349803270637;6198.256209254873;6219.937800621981;6222.253329600477;5653.321601407857;5736.483716465538;5742.253507044057;5752.02215623345;5781.4507621775865;6128.992047069329;6145.617236121837;6164.845878852975;6247.75008999644;6266.68666566679;6072.51419886408;6074.490024101157;6076.392360763976;6098.786542470993;6108.0992441897915;6036.245469316335;6072.39276072398;6129.846753831101;6173.135760993465;6181.505479561624;6090;6097;6134.723937422827;6135.508280839814;6141.293751218667;5186.703324168958;6115.724792384353;6126.975740326312;6154.599951003171;6159.753609855646;4847.103285892122;4911.631627627942;4924;4937.40751109862;4953.678010929278;4370.890727731832;4373.103513779667;4379.693421460531;4399.824007039682;4462.219111655448;5690.118031705092;5851.795187168514;5867.442592953663;5900.380460051632;5967.731452084667;6181.196444462191;6183.4125758053815;6186.4741496973265;6215.036669316263;6237;5645.2096706461125;5807.128930660435;5818.418158184148;5838.824835254949;5848.239728835224;5283;5328.760205790749;5332.733363331818;5347.25138480613;5383.488568585978;6253.187085678924;6277.905831412441;6282.2147231596055;6287.874242515216;6320.304766475776;6167.198264225622;6187.381261873777;6194.178628389082;6199.56603037783;6245.875082498415;6139.798803208881;6146.125431743361;6147.815565533041;6169.290531588925;6200.81397558074;6133.8855759873895;6134.957077261001;6143.481172719164;6143.938560614515;6146.801373732258;6134.191681014119;6175;6177.135201071944;6188.257409110935;6197.566170368031;4774.546418090275;5618.410066942912;5995.2206213192;6030.758769649165;6112.633242005494;6073.30157031947;6100.550895826202;6119.258838874149;6122.051082082285;6136.048912418582;5816.912746308724;5848.941510584839;5886;5926.733297001731;5956.761729530944;5001.199808030843;5223.981323641853;5433.483819037185;5542.722863856871;5959.433853783884;5873.324567674772;5874.17761513397;5896.145058966512;5896.616719913192;5901.350851406256 08:43:32 INFO - PROCESS | 1941 | |1;ext.html;457.2569574441533;499.94250661173965;509.1700528139133;513.3198511971639;514.7066172281799;35308.64691353086;39048.21903561934;39093.82718518449;39132;39166.8041659792;40051;40093.398599021035;40861.59138408615;40875.77372678824;40917.181656366854;9396.295277854155;9521.285903557226;9549.949505554383;9552.57013434397;9561.235101191887;9414.293927955396;9448.338616296862;9502.572384242725;9519.333646644738;9525.857112143323;9474;9502.097300756417;9549.997250288723;9550.474723890184;9567.42595444272;9356.064393560691;9400.012998635182;9447.055294470567;9456.101670341306;9527.142557169818;9241.907580924171;9335;9339.392939458914;9353.298502612332;9360.391574547633;38875;38985.80507097475;39413.60586394128;39466.408003879966;39487.21025579472;3274.197821533716;3290.7038366547126;3297.422950983568;3328.3916600528187;3396.9469464465847;29782.95759648402;29828.8508557458;30545.694543054506;30586.541201881988;31384.686153138406;3155.794873333226;3181.840907954593;3201.951970720441;3294.390537750524;3328.0681409205463;478033;478277;479431;481800.59099704627;482148;57508;57903.13145302824;58030.41969580334;58132.41867581355;58236;49526.75236623794;61287;61333.69333153395;61500.69249653723;61666.76666466735;15448.382064717285;15623.218839058001;15670.9216453917;15685.333493306165;15749.13379764101;11914.166008379503;12049.216800907912;12122.75754484923;12141.69645758863;12168.2699038058;16936.57658558521;18197.45407637773;18276.908615456836;18300.54248643768;18316.725249121275;3128.2961333699736;7448.180700123091;7740.26467485588;7792.493487923267;7852.528848269122;850.6044689219419;974.8976357482504;976.1751320134475;988.9554970026367;1033.6382266206767;25573.74426255751;28585.57121643177;29014.7098529012;29260.561091583644;30072.84963575168;977.1108291454742;1020.8417695257247;1025.6512785652765;1036.8081904847627;1063.9361638301727;13417.731645367037;15084.396624135132;15333.386664533517;15435.536933891777;15454.922725386301;647925;650241;651350;656748;659094;55768.721156393956;56204.15693764597;56558;56702.7164864173;56754;1291.8837304642627;1327.2169420042028;1339.995003747209;1345.1369852754005;1346.5219846954385;23013;29106.12681619555;29164.27089322784;29832.552511712776;30032.549511756904;46453.767731161126;47182.05635887332;47473.52526474691;47542.76228618835;47830.521694782605;575514;577312;577851;579904;579965;25128.874355628104;25416.856241469548;25557.48885022252;25720.742792572582;25721.485570288114;37917.48330066766;42695.57304426916;44431;45753.08493830171;46069.30896036629;31080.378392432478;35500.64499355077;37506;38452.92376609809;38657.42013869851;31114;35690.46464302985;36787.08032299214;37901;38287.61712382841;28120;35879.64120358763;36105.841238142784;36689.63310366969;37228.25543489169;32753.83623081965;33840;34294.65594422212;34457.96626101221;34656;19787.703184451955;23402.88298558496;25081.749182508673;25520.9984152138;25548.616770748824 08:43:32 INFO - PROCESS | 1941 | |2;jquery.html;363.094080269727;371.12229577050283;377.36602507786915;379.95630502492224;397.09462425669466;19421.805781942177;20909.790902090976;21297;21314;21403.6789448158;19201;19387.709184362247;19939.900300498513;20050.69923951138;20314.593708125827;5111;5350.705711185903;5749.683767392792;5882.529397648178;5899;5877.089051197071;5878.1476685880525;5911.586188966774;5913.852153696149;5951.077582974646;5010.974945125269;5741.913871291934;5782.797602083928;5785.623934444247;5853.970730146343;5696.629719068289;5759.654420734749;5793.13103034544;5794.304683437972;5825.15535247391;4972.726500042496;5079.780852595388;5268.6575372600655;5308.70802105884;5341.626086173969;10335.638252661196;12786.232826030375;12837.614871553867;23054.65418018731;24168.63747043778;2133.487962888911;2137.241279345841;2207.4481379655085;2213.3249358945513;2333.8949747261245;9707.786526684164;9769.90230097697;10266.79466410675;11437.428128593538;15874.96812707182;1495.484057999999;1565.7729629203702;1774.609585891102;1869.813018698133;1933.8742981706143;96647;118020;122464;123394;126819.09771353529;9051.683191088412;11310.434478276053;11388.430578471043;11435.885641143648;11606.651800446;14113.2943352834;14147.787783183261;14224.573262802132;14225.00424970242;14243.572692819233;7242.710291588278;8015.118336983044;8051.5571643559;8303.377246706401;8469.661213551512;8217.876731849026;8224.054233763074;8231.46495477792;8374;8385.95807020961;4430.601245887886;4466.9553304466535;4491.371208030879;4492.595666390041;4574.6569007323915;1910.2645481489726;1952.541152829084;1965.528273214447;1994.1524851937868;1995.5709522452453;731.5829976913109;787.9527228366317;877.4691311756295;905.805251870851;932.3659911260272;17750.91124544369;20691.58616827655;20867.478313041993;21092.781443711014;21450.92745362757;839.9496030238083;877.3902138014018;899.3389858454032;914.9405288656216;926.393212445849;9501.762455938519;10696.572137114585;11145.442727863574;11339.433028348549;11389;574162;575362;576803;588314.0584297051;589040;109380.35929461065;127064.36467817602;130694;133997;134950;875.9518226497477;1016.4917541229386;1043.3739756146251;1045.3257648816623;1049.302214027663;18208.635827283644;19157.61684766325;19354.419367419;19410.514737131685;19412.8058719411;47522.81192970203;52110;53285.4671453296;55001.72499137479;55222.44777552173;78275;78409;79347;79679.80480292917;80787.78818317848;6035.5473339500595;7925.167857375123;8095.797605059921;8191.8771218430575;8468.915310846813;12036.699082523008;12633.684157896127;12773.020181871825;12915.677108072374;13217.537386191438;9628.229741620513;10752.516136773707;11119.833202501806;11287.097032237238;11330;8396;9386.436813791195;9828.803423931624;10162;11391.601293954673;9789.363691360324;10535.57857685684;11255.718607034889;11646.941765291458;11726.589569365031;7198.71205151788;7371.299726525972;7938.6030698466;8055.919440805751;8194.754157375288;8877.911220887709;9295.488748118918;10996.670099896695;11161.386123763272;11262.267952583055 08:43:32 INFO - PROCESS | 1941 | |3;mootools.html;1471.359958418088;1509.803725515683;1636.909969951652;1750.1511766793103;1750.9124543772807;7679.57762323072;7798.454108212427;8076.596170191489;8469.745907622773;8508.872366914502;7708.535378278138;7761.146273909865;8043.316318112953;8333;8354;2107.8735275883496;2204.559088182362;2302.2747834432143;2321.802646775026;2327.7555856635063;2323.94190145246;2351.7413084560685;2372.54921564903;2380.1074597026113;2386.3914701751028;2322.477442575424;2324;2341.894614742332;2344.8593084414906;2354.2701762453607;2314.9884250578725;2316.05522210081;2333.7316208636053;2343.6015877300815;2347.1432926981615;2303.124812571229;2359.8112151027876;2364.113457453455;2369.324742448394;2374.358923090756;8430.620622072021;8431.19903609156;8465.365097617703;8499.490030598185;8501.702440414618;3993.5008123984503;5169.663971841818;5180.715060671661;5193.272941788153;5195.376554813409;2896.8551572421293;3134.8275844828527;3414.13929408473;3599.6040435552068;3599.712023038177;1031.334789061059;1045.5033858916954;1075.9946200269028;1091.5360971587122;1093.0272057868503;9617;10830.40432776197;10956.959088886622;10988.780224395467;10993.835092473619;4398.670099742532;4541.886452838706;4630.72215667061;4650.67445278834;4656.8602941911795;9383.5308234588;9439.433633981984;9490.525473726286;9502.90497095034;9505.90494095064;5150.639455238173;5159.329287192641;5159.922601160985;5164.04465173944;5169.25045868347;4227.387028880795;4587.518310577408;4678.7660616969015;4683.180443422388;4739.620830333634;3738.2523495300507;3754.4931434256027;3828.48315477407;3828.73198876076;3854.5567259765485;1226.2029680707433;1235.092207227687;1245.0910835090435;1253.8683438239036;1261.1928365845865;600.4535872356134;860.2043110123111;890.8485557455248;906.981860362789;922.7462447826902;5599.916001259984;5644.6613203207935;5766.971165144148;5888.205092312483;5915.053591425351;403.54399528533156;415.9313713237282;423.80504967715194;424.2956691891507;429.44172575651527;3762.6049264826797;3779.3197224499304;3839.846406143779;3891.7081218908697;3919.451276821247;8451.45065570736;9750.658726944665;10135.239857010754;10140.087392134596;10160.4919754012;9737.221022318197;9800.705978820646;9950;10062.547185376676;10110.494475276208;7784.221577842283;7880.724174653859;7894.289513943658;7908.130105688369;7912.208779122157;5421;5541.5289700375915;5570.637908536094;5619.185218143428;5630.296212973379;9281.071892810665;9283.62865485373;9318.62725491;9338.159565638853;9343.53282335867;9308.44149351041;9363.110504502061;9378.765530861783;9431.481268530297;9538.523073846418;7018.368346848604;7117.181524124585;7174.42604591621;7176.892346614701;7277.454190935595;7975.80060498469;8046.356291496783;8061.758147255592;8063.637136328762;8063.637136328762;6904.654767261516;7037.964810176121;7144.035555199982;7220.711171553079;7286.271372862671;6882.810364959917;7062.293770623102;7097.325754053357;7160.069191005345;7164.319389657974;6623.701933412912;6654.201495820533;6734.663266836541;6737.629430381376;6738.35985581369;4479.395281636937;4756.310335001474;4791.832285869978;4816.373871396696;4830.396200474941;3969.9206015878945;4717.150912835723;4768.976155119202;4782.521747825329;4952.702837829742 08:43:32 INFO - PROCESS | 1941 | |4;prototype.html;301.1642691531002;304.669433664474;308.1203164964027;310.6458637153645;310.9160526657801;4568.657350698699;5453.809116680917;5548.389677135512;5552.555795536357;5590.664560126395;4961.404631444232;5403.189521571766;5442.2380866678595;5456.454354564542;5535.446455354462;3415.8556883444076;3510.4558793387064;3899.610038996106;3959.722819402643;4081.3877918312196;3075.630924289077;3774.169682669808;4061.3298805697023;4070.5522392536795;4074.694397920153;3357.8153201573905;3623.6376362363817;4061.97969010156;4079.367698006799;4105.398894431174;3324.3683700097026;3525.347810655024;3769;4050.696197785178;4089.3865920111925;3512.6662967018347;3516.7186625069935;3521.383757842393;3531.7880927144197;3558.733095017884;4526.615237704799;5235.424103348629;5304.55990244488;5312.335958005249;5342.824578592704;4181.142865712522;4509.413776209105;4658.950061972755;4662.114198302312;4738.810447582093;4944.901101977976;5123.564497017758;5485.6982865942355;5654.858628534278;5691.971540142315;3412.778169419005;3866.1881004988986;3876.980615096935;3899.493065901443;3929.292727309083;4933.210686290176;5591.12697246427;6029.794041191779;6087.634741915455;6103.755849766004;3166.651668316483;3380.3408335374365;3929.626685464876;3965.78188199646;3969.583193764671;3517.4196257617205;3925.803709814498;4009.6190861868076;4020.9396859047138;4045.2516284487465;3895.5130608673917;4690.296455531629;4690.577847993697;4719.811207551659;4725.5510726480925;5213.661112027706;5664.51851592611;5764.798232061941;5860.384659610765;5882.970585147133;1178.9174757767046;1343.8980036370278;1348.9208633093485;1365.9521916732867;1368.206440264644;764.9388048956071;814.0475643497123;821.5727821532889;822.6092606012096;829.2039641943802;5094.77073531692;5242.7378631068295;5326.733663316819;5508.6970216637665;5517.248271175559;5636.464535869086;5919.141724450017;5921.319048309413;5969.940300596939;5977.731002104916;4289;4887.853364399074;4969.2546118081855;5387.892242155135;5454.563634909197;2737.466194092133;3108.0986513911166;3108.8134711916905;3134.3574567214123;3142.177537028518;6074.574779765374;6094.65593959278;6143.354947730513;6165.753369865155;6170.889239936765;5005.374328208974;5779;5978.85052873673;6034.306054803754;6118.265808103056;5369.812056578001;6016.909746353808;6096;6130.938690613215;6136.907946380718;4764.595009424238;5062.797488100435;5817.243758311392;5849.163155869315;5925.733341999707;5806.332271788799;5822.505087067478;5843.357230704704;5849.093390524476;5865.384134665969;4854.563089321978;5994.520438364833;6059.6364218147055;6061.605995610271;6124.908126378019;3659.6157403472253;3906.746061506107;3917.843286268517;3966.8809935701975;3975.4633124528978;5158.871028224325;5181.455947125498;5979.760809567569;6016.789412370546;6046.3046749624355;5634.234171931646;5849.3858144894175;5857.209276747584;5875.911861321998;5880.706244626175;4057.3711074782277;4821.566059054702;5460.754266058117;5696.515796157208;5771.480566749013;5104.6727850758325;5210.947890521046;5646.548276137817;5657.773689052392;5664.631798933056;4832.734199619054;5501.3948465667945;5740.569457290637;5777.306723193244;5844.305151506016;4926.610593862046;5639.407862174413;5662.716864156858;5682.5453963681975;5682.829515114553 08:43:32 INFO - PROCESS | 1941 | |5;yui.html;601.3265143039796;662.423691388492;706.7561691216532;737.8007937856783;797.5732982854171;14354;15279.847201527982;15296.235188240598;15323.616909577253;15388.769168462482;13766.311684415765;13936;13946.581602551914;13951.232682202475;13959;652.7878439507156;665.8302132956113;805.8630032894392;809.1988930958368;832.1678321678322;817.1705718695529;822.173715416009;839.3327304792705;840.306746933779;841.6969890839293;885.9468431894107;886.9822603547925;888.6356593796545;889.3641046651643;889.5818965086431;878.97802554936;882.3073886998708;882.9117088291151;883.8409086364452;887.0907319996991;598.3776872053103;644.4361183964031;646.6120327803327;653.2226650286192;653.5523166630873;12225.266484010988;12436.440360183813;13612.31938403076;14718.55844324672;15005.174715390649;12599.496020159182;14122.576322710334;14128.799052080585;14252;14277.928610356985;10882.857299983547;11589.710257243552;11719.238249513839;11951.760964780742;12089.758204835942;3360.915977100592;3486.6687664672068;3731.440283957401;3847.7883716395586;3905.648491635738;78570.6071469639;85965.57017214937;86089;87894.56052719695;89005;9313.254939604816;10232.181425486093;10265.948670256601;10290;10653.57385704563;16363;18737.812621873607;18999.905000474908;19094.331698390488;19322.8067719321;7295.671694773748;7403.9629801851725;7451.515651482637;7523.962380188064;7584.241575842371;4281.935770963438;4317.568243175658;4332.956670433318;4352.107817897323;4386.627136693417;3383.1034775784437;3456.032310952937;3462.8787992420143;3501.8599256029984;3502.5972013218807;620.268083661284;644.8484606117559;647.4723100672936;662.7713438863584;664.6842749693857;560.2742656973793;572.567711377907;582.5368831778746;599.8920194365056;619.9318075011745;8382.245597896219;9023.323250756219;9100.544972751335;9110.498922559324;9134.834353155546;567.6650776042072;623.3268070483866;659.8878190707495;660.9471242300605;668.9331066893369;3743.6630703236838;4166.270902592034;4335.848245311462;4377.879039351189;4387.42963414754;101359.98640013653;113064.86935130543;117859.41070294766;123974;125722;85858.71211931825;106113.46943265389;106180;107293;107779;54722.726386367816;58717.532061697944;63226.68386658037;80623.59688201638;83965.74051389234;9504.19214366759;9625.56684949193;9650.542706481503;9715.854262185932;9733.853992190265;42755.786221068694;46180;52254.69363265797;56353;58639.48163110227;76203.61898190696;76938.23061769534;79675.60162199152;79948.00129996796;80231.59884200542;10077.546510406903;11932.522699091938;11983.76032479363;12089.637310880687;12323.69190770238;13588.59234222975;13962.650933726738;14102.717945641234;14111.364988575744;14294.785578216542;12758.170718903242;12807.551735689207;12817.743645126859;12821.423035963218;12913.354332283161;11179.720506987065;12553.560625378068;13013.349332533146;13046.869531304945;13301.582743785782;12475.376231188222;12651.620451386472;12689.23864568129;12769.808452873029;12927.353632318534;8286.834263314578;10502.422366769595;10594.205434592282;10816.242862999514;10935.945320273666;9647.565859536197;10112.577929941614;10173.796524069625;11078.889211108108;11180.55277788912 08:43:32 INFO - PROCESS | 1941 | __end_tp_report 08:43:32 INFO - PROCESS | 1941 | __start_cc_report 08:43:32 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,377 08:43:32 INFO - PROCESS | 1941 | __end_cc_report 08:43:32 INFO - PROCESS | 1941 | __startTimestamp1478101412779__endTimestamp 08:43:32 INFO - PROCESS | 1941 | 08:43:32 INFO - PROCESS | 1941 | ------- Summary: start ------- 08:43:32 INFO - PROCESS | 1941 | Number of tests: 6 08:43:32 INFO - PROCESS | 1941 | 08:43:32 INFO - PROCESS | 1941 | [#0] dojo.html Cycles:165 Average:5647.93 Median:5867.44 stddev:647.02 (11.0%) stddev-sans-first:621.63 08:43:32 INFO - PROCESS | 1941 | Values: 3274.2 3298.8 3322.1 3337.4 3337.9 5435.9 5575.3 5579.6 5580.6 5662.9 5528.4 5610.7 5655.6 5706.9 5707.7 5103.6 5125.4 5152.2 5248.4 5275.9 5123.3 5258.1 5264.7 5265.9 5338.9 4160.9 4908.2 5100.8 5213.6 5245.0 5177.5 5184.9 5200.7 5201.4 5261.9 4978.0 5080.7 5141.1 5180.4 5197.6 4615.7 5473.5 5502.1 5556.4 5683.9 5317.9 5954.2 6118.7 6138.3 6154.4 6183.8 6192.3 6198.3 6219.9 6222.3 5653.3 5736.5 5742.3 5752.0 5781.5 6129.0 6145.6 6164.8 6247.8 6266.7 6072.5 6074.5 6076.4 6098.8 6108.1 6036.2 6072.4 6129.8 6173.1 6181.5 6090.0 6097.0 6134.7 6135.5 6141.3 5186.7 6115.7 6127.0 6154.6 6159.8 4847.1 4911.6 4924.0 4937.4 4953.7 4370.9 4373.1 4379.7 4399.8 4462.2 5690.1 5851.8 5867.4 5900.4 5967.7 6181.2 6183.4 6186.5 6215.0 6237.0 5645.2 5807.1 5818.4 5838.8 5848.2 5283.0 5328.8 5332.7 5347.3 5383.5 6253.2 6277.9 6282.2 6287.9 6320.3 6167.2 6187.4 6194.2 6199.6 6245.9 6139.8 6146.1 6147.8 6169.3 6200.8 6133.9 6135.0 6143.5 6143.9 6146.8 6134.2 6175.0 6177.1 6188.3 6197.6 4774.5 5618.4 5995.2 6030.8 6112.6 6073.3 6100.6 6119.3 6122.1 6136.0 5816.9 5848.9 5886.0 5926.7 5956.8 5001.2 5224.0 5433.5 5542.7 5959.4 5873.3 5874.2 5896.1 5896.6 5901.4 08:43:32 INFO - PROCESS | 1941 | 08:43:32 INFO - PROCESS | 1941 | [#1] ext.html Cycles:180 Average:69333.84 Median:39071.02 stddev:153823.38 (393.7%) stddev-sans-first:154167.96 08:43:32 INFO - PROCESS | 1941 | Values: 457.3 499.9 509.2 513.3 514.7 35308.6 39048.2 39093.8 39132.0 39166.8 40051.0 40093.4 40861.6 40875.8 40917.2 9396.3 9521.3 9549.9 9552.6 9561.2 9414.3 9448.3 9502.6 9519.3 9525.9 9474.0 9502.1 9550.0 9550.5 9567.4 9356.1 9400.0 9447.1 9456.1 9527.1 9241.9 9335.0 9339.4 9353.3 9360.4 38875.0 38985.8 39413.6 39466.4 39487.2 3274.2 3290.7 3297.4 3328.4 3396.9 29783.0 29828.9 30545.7 30586.5 31384.7 3155.8 3181.8 3202.0 3294.4 3328.1 478033.0 478277.0 479431.0 481800.6 482148.0 57508.0 57903.1 58030.4 58132.4 58236.0 49526.8 61287.0 61333.7 61500.7 61666.8 15448.4 15623.2 15670.9 15685.3 15749.1 11914.2 12049.2 12122.8 12141.7 12168.3 16936.6 18197.5 18276.9 18300.5 18316.7 3128.3 7448.2 7740.3 7792.5 7852.5 850.6 974.9 976.2 989.0 1033.6 25573.7 28585.6 29014.7 29260.6 30072.8 977.1 1020.8 1025.7 1036.8 1063.9 13417.7 15084.4 15333.4 15435.5 15454.9 647925.0 650241.0 651350.0 656748.0 659094.0 55768.7 56204.2 56558.0 56702.7 56754.0 1291.9 1327.2 1340.0 1345.1 1346.5 23013.0 29106.1 29164.3 29832.6 30032.5 46453.8 47182.1 47473.5 47542.8 47830.5 575514.0 577312.0 577851.0 579904.0 579965.0 25128.9 25416.9 25557.5 25720.7 25721.5 37917.5 42695.6 44431.0 45753.1 46069.3 31080.4 35500.6 37506.0 38452.9 38657.4 31114.0 35690.5 36787.1 37901.0 38287.6 28120.0 35879.6 36105.8 36689.6 37228.3 32753.8 33840.0 34294.7 34458.0 34656.0 19787.7 23402.9 25081.7 25521.0 25548.6 08:43:32 INFO - PROCESS | 1941 | 08:43:32 INFO - PROCESS | 1941 | [#2] jquery.html Cycles:180 Average:34155.22 Median:388.53 stddev:97181.24 (25012.8%) stddev-sans-first:97420.74 08:43:32 INFO - PROCESS | 1941 | Values: 363.1 371.1 377.4 380.0 397.1 19421.8 20909.8 21297.0 21314.0 21403.7 19201.0 19387.7 19939.9 20050.7 20314.6 5111.0 5350.7 5749.7 5882.5 5899.0 5877.1 5878.1 5911.6 5913.9 5951.1 5011.0 5741.9 5782.8 5785.6 5854.0 5696.6 5759.7 5793.1 5794.3 5825.2 4972.7 5079.8 5268.7 5308.7 5341.6 10335.6 12786.2 12837.6 23054.7 24168.6 2133.5 2137.2 2207.4 2213.3 2333.9 9707.8 9769.9 10266.8 11437.4 15875.0 1495.5 1565.8 1774.6 1869.8 1933.9 96647.0 118020.0 122464.0 123394.0 126819.1 9051.7 11310.4 11388.4 11435.9 11606.7 14113.3 14147.8 14224.6 14225.0 14243.6 7242.7 8015.1 8051.6 8303.4 8469.7 8217.9 8224.1 8231.5 8374.0 8386.0 4430.6 4467.0 4491.4 4492.6 4574.7 1910.3 1952.5 1965.5 1994.2 1995.6 731.6 788.0 877.5 905.8 932.4 17750.9 20691.6 20867.5 21092.8 21450.9 839.9 877.4 899.3 914.9 926.4 9501.8 10696.6 11145.4 11339.4 11389.0 574162.0 575362.0 576803.0 588314.1 589040.0 109380.4 127064.4 130694.0 133997.0 134950.0 876.0 1016.5 1043.4 1045.3 1049.3 18208.6 19157.6 19354.4 19410.5 19412.8 47522.8 52110.0 53285.5 55001.7 55222.4 78275.0 78409.0 79347.0 79679.8 80787.8 6035.5 7925.2 8095.8 8191.9 8468.9 12036.7 12633.7 12773.0 12915.7 13217.5 9628.2 10752.5 11119.8 11287.1 11330.0 8396.0 9386.4 9828.8 10162.0 11391.6 9789.4 10535.6 11255.7 11646.9 11726.6 7198.7 7371.3 7938.6 8055.9 8194.8 8877.9 9295.5 10996.7 11161.4 11262.3 08:43:32 INFO - PROCESS | 1941 | 08:43:32 INFO - PROCESS | 1941 | [#3] mootools.html Cycles:180 Average:5412.47 Median:5154.98 stddev:2985.19 (57.9%) stddev-sans-first:2978.87 08:43:32 INFO - PROCESS | 1941 | Values: 1471.4 1509.8 1636.9 1750.2 1750.9 7679.6 7798.5 8076.6 8469.7 8508.9 7708.5 7761.1 8043.3 8333.0 8354.0 2107.9 2204.6 2302.3 2321.8 2327.8 2323.9 2351.7 2372.5 2380.1 2386.4 2322.5 2324.0 2341.9 2344.9 2354.3 2315.0 2316.1 2333.7 2343.6 2347.1 2303.1 2359.8 2364.1 2369.3 2374.4 8430.6 8431.2 8465.4 8499.5 8501.7 3993.5 5169.7 5180.7 5193.3 5195.4 2896.9 3134.8 3414.1 3599.6 3599.7 1031.3 1045.5 1076.0 1091.5 1093.0 9617.0 10830.4 10957.0 10988.8 10993.8 4398.7 4541.9 4630.7 4650.7 4656.9 9383.5 9439.4 9490.5 9502.9 9505.9 5150.6 5159.3 5159.9 5164.0 5169.3 4227.4 4587.5 4678.8 4683.2 4739.6 3738.3 3754.5 3828.5 3828.7 3854.6 1226.2 1235.1 1245.1 1253.9 1261.2 600.5 860.2 890.8 907.0 922.7 5599.9 5644.7 5767.0 5888.2 5915.1 403.5 415.9 423.8 424.3 429.4 3762.6 3779.3 3839.8 3891.7 3919.5 8451.5 9750.7 10135.2 10140.1 10160.5 9737.2 9800.7 9950.0 10062.5 10110.5 7784.2 7880.7 7894.3 7908.1 7912.2 5421.0 5541.5 5570.6 5619.2 5630.3 9281.1 9283.6 9318.6 9338.2 9343.5 9308.4 9363.1 9378.8 9431.5 9538.5 7018.4 7117.2 7174.4 7176.9 7277.5 7975.8 8046.4 8061.8 8063.6 8063.6 6904.7 7038.0 7144.0 7220.7 7286.3 6882.8 7062.3 7097.3 7160.1 7164.3 6623.7 6654.2 6734.7 6737.6 6738.4 4479.4 4756.3 4791.8 4816.4 4830.4 3969.9 4717.2 4769.0 4782.5 4952.7 08:43:32 INFO - PROCESS | 1941 | 08:43:32 INFO - PROCESS | 1941 | [#4] prototype.html Cycles:180 Average:4600.23 Median:5196.20 stddev:1467.21 (28.2%) stddev-sans-first:1435.41 08:43:32 INFO - PROCESS | 1941 | Values: 301.2 304.7 308.1 310.6 310.9 4568.7 5453.8 5548.4 5552.6 5590.7 4961.4 5403.2 5442.2 5456.5 5535.4 3415.9 3510.5 3899.6 3959.7 4081.4 3075.6 3774.2 4061.3 4070.6 4074.7 3357.8 3623.6 4062.0 4079.4 4105.4 3324.4 3525.3 3769.0 4050.7 4089.4 3512.7 3516.7 3521.4 3531.8 3558.7 4526.6 5235.4 5304.6 5312.3 5342.8 4181.1 4509.4 4659.0 4662.1 4738.8 4944.9 5123.6 5485.7 5654.9 5692.0 3412.8 3866.2 3877.0 3899.5 3929.3 4933.2 5591.1 6029.8 6087.6 6103.8 3166.7 3380.3 3929.6 3965.8 3969.6 3517.4 3925.8 4009.6 4020.9 4045.3 3895.5 4690.3 4690.6 4719.8 4725.6 5213.7 5664.5 5764.8 5860.4 5883.0 1178.9 1343.9 1348.9 1366.0 1368.2 764.9 814.0 821.6 822.6 829.2 5094.8 5242.7 5326.7 5508.7 5517.2 5636.5 5919.1 5921.3 5969.9 5977.7 4289.0 4887.9 4969.3 5387.9 5454.6 2737.5 3108.1 3108.8 3134.4 3142.2 6074.6 6094.7 6143.4 6165.8 6170.9 5005.4 5779.0 5978.9 6034.3 6118.3 5369.8 6016.9 6096.0 6130.9 6136.9 4764.6 5062.8 5817.2 5849.2 5925.7 5806.3 5822.5 5843.4 5849.1 5865.4 4854.6 5994.5 6059.6 6061.6 6124.9 3659.6 3906.7 3917.8 3966.9 3975.5 5158.9 5181.5 5979.8 6016.8 6046.3 5634.2 5849.4 5857.2 5875.9 5880.7 4057.4 4821.6 5460.8 5696.5 5771.5 5104.7 5210.9 5646.5 5657.8 5664.6 4832.7 5501.4 5740.6 5777.3 5844.3 4926.6 5639.4 5662.7 5682.5 5682.8 08:43:32 INFO - PROCESS | 1941 | 08:43:32 INFO - PROCESS | 1941 | [#5] yui.html Cycles:180 Average:20339.87 Median:4325.26 stddev:30368.50 (702.1%) stddev-sans-first:30417.52 08:43:32 INFO - PROCESS | 1941 | Values: 601.3 662.4 706.8 737.8 797.6 14354.0 15279.8 15296.2 15323.6 15388.8 13766.3 13936.0 13946.6 13951.2 13959.0 652.8 665.8 805.9 809.2 832.2 817.2 822.2 839.3 840.3 841.7 885.9 887.0 888.6 889.4 889.6 879.0 882.3 882.9 883.8 887.1 598.4 644.4 646.6 653.2 653.6 12225.3 12436.4 13612.3 14718.6 15005.2 12599.5 14122.6 14128.8 14252.0 14277.9 10882.9 11589.7 11719.2 11951.8 12089.8 3360.9 3486.7 3731.4 3847.8 3905.6 78570.6 85965.6 86089.0 87894.6 89005.0 9313.3 10232.2 10265.9 10290.0 10653.6 16363.0 18737.8 18999.9 19094.3 19322.8 7295.7 7404.0 7451.5 7524.0 7584.2 4281.9 4317.6 4333.0 4352.1 4386.6 3383.1 3456.0 3462.9 3501.9 3502.6 620.3 644.8 647.5 662.8 664.7 560.3 572.6 582.5 599.9 619.9 8382.2 9023.3 9100.5 9110.5 9134.8 567.7 623.3 659.9 660.9 668.9 3743.7 4166.3 4335.8 4377.9 4387.4 101360.0 113064.9 117859.4 123974.0 125722.0 85858.7 106113.5 106180.0 107293.0 107779.0 54722.7 58717.5 63226.7 80623.6 83965.7 9504.2 9625.6 9650.5 9715.9 9733.9 42755.8 46180.0 52254.7 56353.0 58639.5 76203.6 76938.2 79675.6 79948.0 80231.6 10077.5 11932.5 11983.8 12089.6 12323.7 13588.6 13962.7 14102.7 14111.4 14294.8 12758.2 12807.6 12817.7 12821.4 12913.4 11179.7 12553.6 13013.3 13046.9 13301.6 12475.4 12651.6 12689.2 12769.8 12927.4 8286.8 10502.4 10594.2 10816.2 10935.9 9647.6 10112.6 10173.8 11078.9 11180.6 08:43:32 INFO - PROCESS | 1941 | -------- Summary: end -------- 08:43:32 INFO - PROCESS | 1941 | 08:43:33 INFO - TEST-INFO | 1941: exit 0 08:43:33 INFO - TEST-OK | dromaeo_css | took 1116244ms 08:43:33 INFO - TEST-START | kraken 08:43:33 INFO - operating with platform_type : mac_ 08:43:33 INFO - Initialising browser for kraken test... 08:43:33 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmp6SxkZP/profile http://localhost:57251/getInfo.html) 08:43:36 INFO - PROCESS | 1947 | 2016-11-02 08:43:36.244 plugin-container[1948:20357] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 08:43:36 INFO - PROCESS | 1947 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:43:36 INFO - PROCESS | 1947 | 2016-11-02 08:43:36.247 plugin-container[1948:20357] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c13, name = 'com.apple.CFPasteboardClient' 08:43:36 INFO - PROCESS | 1947 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:43:36 INFO - PROCESS | 1947 | 2016-11-02 08:43:36.247 plugin-container[1948:20357] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:43:36 INFO - PROCESS | 1947 | __metrics Screen width/height:1600/1200 08:43:36 INFO - PROCESS | 1947 | colorDepth:24 08:43:36 INFO - PROCESS | 1947 | Browser inner width/height: 1024/689 08:43:36 INFO - PROCESS | 1947 | __metrics 08:43:36 ERROR - PROCESS | 1947 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 08:43:37 INFO - TEST-INFO | 1947: exit 0 08:43:37 INFO - Browser initialized. 08:43:37 INFO - Running cycle 1/1 for kraken test... 08:43:37 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmp6SxkZP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:39 INFO - PROCESS | 1949 | 2016-11-02 08:43:39.607 plugin-container[1950:20475] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 08:43:39 INFO - PROCESS | 1949 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:43:39 INFO - PROCESS | 1949 | 2016-11-02 08:43:39.610 plugin-container[1950:20475] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 08:43:39 INFO - PROCESS | 1949 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:43:39 INFO - PROCESS | 1949 | 2016-11-02 08:43:39.610 plugin-container[1950:20475] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:43:49 INFO - PROCESS | 1949 | RSS: Main: 238338048 08:43:49 INFO - PROCESS | 1949 | 08:43:52 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57251/tests/kraken/driver.html?testName=audio-beat-detection) 08:43:53 INFO - PROCESS | 1949 | RSS: Main: 250925056 08:43:53 INFO - PROCESS | 1949 | 08:43:55 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57251/tests/kraken/driver.html?testName=audio-dft) 08:43:56 INFO - PROCESS | 1949 | RSS: Main: 258355200 08:43:56 INFO - PROCESS | 1949 | 08:44:00 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57251/tests/kraken/driver.html?testName=audio-fft) 08:44:00 INFO - PROCESS | 1949 | RSS: Main: 261255168 08:44:00 INFO - PROCESS | 1949 | 08:44:02 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57251/tests/kraken/driver.html?testName=audio-oscillator) 08:44:03 INFO - PROCESS | 1949 | RSS: Main: 263954432 08:44:03 INFO - PROCESS | 1949 | 08:44:05 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:44:06 INFO - PROCESS | 1949 | RSS: Main: 263761920 08:44:06 INFO - PROCESS | 1949 | 08:44:09 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57251/tests/kraken/driver.html?testName=imaging-darkroom) 08:44:09 INFO - PROCESS | 1949 | RSS: Main: 264093696 08:44:09 INFO - PROCESS | 1949 | 08:44:12 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57251/tests/kraken/driver.html?testName=imaging-desaturate) 08:44:13 INFO - PROCESS | 1949 | RSS: Main: 264519680 08:44:13 INFO - PROCESS | 1949 | 08:44:16 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57251/tests/kraken/driver.html?testName=json-parse-financial) 08:44:16 INFO - PROCESS | 1949 | RSS: Main: 264646656 08:44:16 INFO - PROCESS | 1949 | 08:44:18 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:44:19 INFO - PROCESS | 1949 | RSS: Main: 264310784 08:44:19 INFO - PROCESS | 1949 | 08:44:21 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57251/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:44:21 INFO - PROCESS | 1949 | RSS: Main: 264380416 08:44:21 INFO - PROCESS | 1949 | 08:44:24 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:44:24 INFO - PROCESS | 1949 | RSS: Main: 264458240 08:44:24 INFO - PROCESS | 1949 | 08:44:27 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:44:28 INFO - PROCESS | 1949 | RSS: Main: 264986624 08:44:28 INFO - PROCESS | 1949 | 08:44:31 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:44:32 INFO - PROCESS | 1949 | RSS: Main: 264589312 08:44:32 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:57251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57251/tests/kraken/driver.html?testName=ai-astar) 08:44:34 INFO - PROCESS | 1949 | RSS: Main: 266272768 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | __start_tp_report 08:44:34 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 08:44:34 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 08:44:34 INFO - PROCESS | 1949 | |i|pagename|runs| 08:44:34 INFO - PROCESS | 1949 | |0;ai-astar;106;117;118;119;117;118;118;119;118;118 08:44:34 INFO - PROCESS | 1949 | |1;audio-beat-detection;147;116;115;150;123;153;132;115;146;117 08:44:34 INFO - PROCESS | 1949 | |2;audio-dft;214;250;222;249;278;266;195;207;209;226 08:44:34 INFO - PROCESS | 1949 | |3;audio-fft;76;83;82;86;75;87;86;54;84;82 08:44:34 INFO - PROCESS | 1949 | |4;audio-oscillator;96;92;88;96;100;105;99;70;70;89 08:44:34 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;108;91;136;134;110;87;91;90;112;88 08:44:34 INFO - PROCESS | 1949 | |6;imaging-darkroom;98;97;97;100;101;154;98;98;107;98 08:44:34 INFO - PROCESS | 1949 | |7;imaging-desaturate;109;144;97;86;87;92;88;92;88;88 08:44:34 INFO - PROCESS | 1949 | |8;json-parse-financial;58;57;57;72;89;91;67;59;58;58 08:44:34 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;68;70;76;82;77;72;72;62;96;113 08:44:34 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;88;92;109;108;109;99;87;88;89;92 08:44:34 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;149;150;164;172;173;163;169;138;209;192 08:44:34 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;176;176;176;174;177;175;176;177;244;176 08:44:34 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;65;87;92;95;95;80;67;70;68;69 08:44:34 INFO - PROCESS | 1949 | __end_tp_report 08:44:34 INFO - PROCESS | 1949 | __start_cc_report 08:44:34 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,949 08:44:34 INFO - PROCESS | 1949 | __end_cc_report 08:44:34 INFO - PROCESS | 1949 | __startTimestamp1478101474352__endTimestamp 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | ------- Summary: start ------- 08:44:34 INFO - PROCESS | 1949 | Number of tests: 14 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:116.80 Median:118.00 stddev:3.85 (3.3%) stddev-sans-first:0.71 08:44:34 INFO - PROCESS | 1949 | Values: 106.0 117.0 118.0 119.0 117.0 118.0 118.0 119.0 118.0 118.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:139.00 stddev:16.06 (11.6%) stddev-sans-first:16.02 08:44:34 INFO - PROCESS | 1949 | Values: 147.0 116.0 115.0 150.0 123.0 153.0 132.0 115.0 146.0 117.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:231.60 Median:237.50 stddev:27.62 (11.6%) stddev-sans-first:28.55 08:44:34 INFO - PROCESS | 1949 | Values: 214.0 250.0 222.0 249.0 278.0 266.0 195.0 207.0 209.0 226.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:79.50 Median:83.50 stddev:9.82 (11.8%) stddev-sans-first:10.34 08:44:34 INFO - PROCESS | 1949 | Values: 76.0 83.0 82.0 86.0 75.0 87.0 86.0 54.0 84.0 82.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:90.50 stddev:11.95 (13.2%) stddev-sans-first:12.50 08:44:34 INFO - PROCESS | 1949 | Values: 96.0 92.0 88.0 96.0 100.0 105.0 99.0 70.0 70.0 89.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:104.70 Median:87.50 stddev:18.60 (21.3%) stddev-sans-first:19.69 08:44:34 INFO - PROCESS | 1949 | Values: 108.0 91.0 136.0 134.0 110.0 87.0 91.0 90.0 112.0 88.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:104.80 Median:97.50 stddev:17.54 (18.0%) stddev-sans-first:18.43 08:44:34 INFO - PROCESS | 1949 | Values: 98.0 97.0 97.0 100.0 101.0 154.0 98.0 98.0 107.0 98.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:88.00 stddev:17.85 (20.3%) stddev-sans-first:18.40 08:44:34 INFO - PROCESS | 1949 | Values: 109.0 144.0 97.0 86.0 87.0 92.0 88.0 92.0 88.0 88.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:63.00 stddev:13.29 (21.1%) stddev-sans-first:13.73 08:44:34 INFO - PROCESS | 1949 | Values: 58.0 57.0 57.0 72.0 89.0 91.0 67.0 59.0 58.0 58.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:78.80 Median:74.00 stddev:15.11 (20.4%) stddev-sans-first:15.52 08:44:34 INFO - PROCESS | 1949 | Values: 68.0 70.0 76.0 82.0 77.0 72.0 72.0 62.0 96.0 113.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:96.10 Median:88.50 stddev:9.31 (10.5%) stddev-sans-first:9.41 08:44:34 INFO - PROCESS | 1949 | Values: 88.0 92.0 109.0 108.0 109.0 99.0 87.0 88.0 89.0 92.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:167.90 Median:170.50 stddev:20.88 (12.2%) stddev-sans-first:21.00 08:44:34 INFO - PROCESS | 1949 | Values: 149.0 150.0 164.0 172.0 173.0 163.0 169.0 138.0 209.0 192.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:176.00 stddev:21.56 (12.2%) stddev-sans-first:22.73 08:44:34 INFO - PROCESS | 1949 | Values: 176.0 176.0 176.0 174.0 177.0 175.0 176.0 177.0 244.0 176.0 08:44:34 INFO - PROCESS | 1949 | 08:44:34 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.80 Median:83.50 stddev:12.42 (14.9%) stddev-sans-first:12.12 08:44:34 INFO - PROCESS | 1949 | Values: 65.0 87.0 92.0 95.0 95.0 80.0 67.0 70.0 68.0 69.0 08:44:34 INFO - PROCESS | 1949 | -------- Summary: end -------- 08:44:34 INFO - PROCESS | 1949 | 08:44:35 INFO - TEST-INFO | 1949: exit 0 08:44:35 INFO - TEST-OK | kraken | took 61702ms 08:44:35 INFO - SUITE-END | took 1177s 08:44:35 INFO - Completed test suite (00:19:38) 08:44:35 INFO - javascript benchmark 08:44:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7099.348367592762, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3274.1814546363407, 3298.818564978926, 3322.053214833772, 3337.415952208363, 3337.8831740889073, 5435.864103397417, 5575.275214222151, 5579.553635709139, 5580.609357344987, 5662.886742265152, 5528.419515950827, 5610.69141197234, 5655.632383895054, 5706.9429305707035, 5707.65754054757, 5103.591712662978, 5125.436202017775, 5152.175651895697, 5248.448912864152, 5275.894482110355, 5123.333966584358, 5258.079836028699, 5264.736763161845, 5265.9473405266035, 5338.946610533903, 4160.9375859362135, 4908.165611845995, 5100.846974590768, 5213.556847667915, 5245.0, 5177.534021938043, 5184.922226166611, 5200.6879587224885, 5201.40183878855, 5261.947380526184, 4977.9751101244265, 5080.695158290514, 5141.100307446182, 5180.4042535108565, 5197.610179236534, 4615.653825963032, 5473.507384335429, 5502.147167189092, 5556.388797232301, 5683.886322273573, 5317.946820531823, 5954.2259506264345, 6118.7105509428, 6138.324784273726, 6154.353792851731, 6183.783567575113, 6192.349803270637, 6198.256209254873, 6219.937800621981, 6222.253329600477, 5653.321601407857, 5736.483716465538, 5742.253507044057, 5752.02215623345, 5781.4507621775865, 6128.992047069329, 6145.617236121837, 6164.845878852975, 6247.75008999644, 6266.68666566679, 6072.51419886408, 6074.490024101157, 6076.392360763976, 6098.786542470993, 6108.0992441897915, 6036.245469316335, 6072.39276072398, 6129.846753831101, 6173.135760993465, 6181.505479561624, 6090.0, 6097.0, 6134.723937422827, 6135.508280839814, 6141.293751218667, 5186.703324168958, 6115.724792384353, 6126.975740326312, 6154.599951003171, 6159.753609855646, 4847.103285892122, 4911.631627627942, 4924.0, 4937.40751109862, 4953.678010929278, 4370.890727731832, 4373.103513779667, 4379.693421460531, 4399.824007039682, 4462.219111655448, 5690.118031705092, 5851.795187168514, 5867.442592953663, 5900.380460051632, 5967.731452084667, 6181.196444462191, 6183.4125758053815, 6186.4741496973265, 6215.036669316263, 6237.0, 5645.2096706461125, 5807.128930660435, 5818.418158184148, 5838.824835254949, 5848.239728835224, 5283.0, 5328.760205790749, 5332.733363331818, 5347.25138480613, 5383.488568585978, 6253.187085678924, 6277.905831412441, 6282.2147231596055, 6287.874242515216, 6320.304766475776, 6167.198264225622, 6187.381261873777, 6194.178628389082, 6199.56603037783, 6245.875082498415, 6139.798803208881, 6146.125431743361, 6147.815565533041, 6169.290531588925, 6200.81397558074, 6133.8855759873895, 6134.957077261001, 6143.481172719164, 6143.938560614515, 6146.801373732258, 6134.191681014119, 6175.0, 6177.135201071944, 6188.257409110935, 6197.566170368031, 4774.546418090275, 5618.410066942912, 5995.2206213192, 6030.758769649165, 6112.633242005494, 6073.30157031947, 6100.550895826202, 6119.258838874149, 6122.051082082285, 6136.048912418582, 5816.912746308724, 5848.941510584839, 5886.0, 5926.733297001731, 5956.761729530944, 5001.199808030843, 5223.981323641853, 5433.483819037185, 5542.722863856871, 5959.433853783884, 5873.324567674772, 5874.17761513397, 5896.145058966512, 5896.616719913192, 5901.350851406256], "value": 5607.28802774095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.2569574441533, 499.94250661173965, 509.1700528139133, 513.3198511971639, 514.7066172281799, 35308.64691353086, 39048.21903561934, 39093.82718518449, 39132.0, 39166.8041659792, 40051.0, 40093.398599021035, 40861.59138408615, 40875.77372678824, 40917.181656366854, 9396.295277854155, 9521.285903557226, 9549.949505554383, 9552.57013434397, 9561.235101191887, 9414.293927955396, 9448.338616296862, 9502.572384242725, 9519.333646644738, 9525.857112143323, 9474.0, 9502.097300756417, 9549.997250288723, 9550.474723890184, 9567.42595444272, 9356.064393560691, 9400.012998635182, 9447.055294470567, 9456.101670341306, 9527.142557169818, 9241.907580924171, 9335.0, 9339.392939458914, 9353.298502612332, 9360.391574547633, 38875.0, 38985.80507097475, 39413.60586394128, 39466.408003879966, 39487.21025579472, 3274.197821533716, 3290.7038366547126, 3297.422950983568, 3328.3916600528187, 3396.9469464465847, 29782.95759648402, 29828.8508557458, 30545.694543054506, 30586.541201881988, 31384.686153138406, 3155.794873333226, 3181.840907954593, 3201.951970720441, 3294.390537750524, 3328.0681409205463, 478033.0, 478277.0, 479431.0, 481800.59099704627, 482148.0, 57508.0, 57903.13145302824, 58030.41969580334, 58132.41867581355, 58236.0, 49526.75236623794, 61287.0, 61333.69333153395, 61500.69249653723, 61666.76666466735, 15448.382064717285, 15623.218839058001, 15670.9216453917, 15685.333493306165, 15749.13379764101, 11914.166008379503, 12049.216800907912, 12122.75754484923, 12141.69645758863, 12168.2699038058, 16936.57658558521, 18197.45407637773, 18276.908615456836, 18300.54248643768, 18316.725249121275, 3128.2961333699736, 7448.180700123091, 7740.26467485588, 7792.493487923267, 7852.528848269122, 850.6044689219419, 974.8976357482504, 976.1751320134475, 988.9554970026367, 1033.6382266206767, 25573.74426255751, 28585.57121643177, 29014.7098529012, 29260.561091583644, 30072.84963575168, 977.1108291454742, 1020.8417695257247, 1025.6512785652765, 1036.8081904847627, 1063.9361638301727, 13417.731645367037, 15084.396624135132, 15333.386664533517, 15435.536933891777, 15454.922725386301, 647925.0, 650241.0, 651350.0, 656748.0, 659094.0, 55768.721156393956, 56204.15693764597, 56558.0, 56702.7164864173, 56754.0, 1291.8837304642627, 1327.2169420042028, 1339.995003747209, 1345.1369852754005, 1346.5219846954385, 23013.0, 29106.12681619555, 29164.27089322784, 29832.552511712776, 30032.549511756904, 46453.767731161126, 47182.05635887332, 47473.52526474691, 47542.76228618835, 47830.521694782605, 575514.0, 577312.0, 577851.0, 579904.0, 579965.0, 25128.874355628104, 25416.856241469548, 25557.48885022252, 25720.742792572582, 25721.485570288114, 37917.48330066766, 42695.57304426916, 44431.0, 45753.08493830171, 46069.30896036629, 31080.378392432478, 35500.64499355077, 37506.0, 38452.92376609809, 38657.42013869851, 31114.0, 35690.46464302985, 36787.08032299214, 37901.0, 38287.61712382841, 28120.0, 35879.64120358763, 36105.841238142784, 36689.63310366969, 37228.25543489169, 32753.83623081965, 33840.0, 34294.65594422212, 34457.96626101221, 34656.0, 19787.703184451955, 23402.88298558496, 25081.749182508673, 25520.9984152138, 25548.616770748824], "value": 19286.994973433957, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.094080269727, 371.12229577050283, 377.36602507786915, 379.95630502492224, 397.09462425669466, 19421.805781942177, 20909.790902090976, 21297.0, 21314.0, 21403.6789448158, 19201.0, 19387.709184362247, 19939.900300498513, 20050.69923951138, 20314.593708125827, 5111.0, 5350.705711185903, 5749.683767392792, 5882.529397648178, 5899.0, 5877.089051197071, 5878.1476685880525, 5911.586188966774, 5913.852153696149, 5951.077582974646, 5010.974945125269, 5741.913871291934, 5782.797602083928, 5785.623934444247, 5853.970730146343, 5696.629719068289, 5759.654420734749, 5793.13103034544, 5794.304683437972, 5825.15535247391, 4972.726500042496, 5079.780852595388, 5268.6575372600655, 5308.70802105884, 5341.626086173969, 10335.638252661196, 12786.232826030375, 12837.614871553867, 23054.65418018731, 24168.63747043778, 2133.487962888911, 2137.241279345841, 2207.4481379655085, 2213.3249358945513, 2333.8949747261245, 9707.786526684164, 9769.90230097697, 10266.79466410675, 11437.428128593538, 15874.96812707182, 1495.484057999999, 1565.7729629203702, 1774.609585891102, 1869.813018698133, 1933.8742981706143, 96647.0, 118020.0, 122464.0, 123394.0, 126819.09771353529, 9051.683191088412, 11310.434478276053, 11388.430578471043, 11435.885641143648, 11606.651800446, 14113.2943352834, 14147.787783183261, 14224.573262802132, 14225.00424970242, 14243.572692819233, 7242.710291588278, 8015.118336983044, 8051.5571643559, 8303.377246706401, 8469.661213551512, 8217.876731849026, 8224.054233763074, 8231.46495477792, 8374.0, 8385.95807020961, 4430.601245887886, 4466.9553304466535, 4491.371208030879, 4492.595666390041, 4574.6569007323915, 1910.2645481489726, 1952.541152829084, 1965.528273214447, 1994.1524851937868, 1995.5709522452453, 731.5829976913109, 787.9527228366317, 877.4691311756295, 905.805251870851, 932.3659911260272, 17750.91124544369, 20691.58616827655, 20867.478313041993, 21092.781443711014, 21450.92745362757, 839.9496030238083, 877.3902138014018, 899.3389858454032, 914.9405288656216, 926.393212445849, 9501.762455938519, 10696.572137114585, 11145.442727863574, 11339.433028348549, 11389.0, 574162.0, 575362.0, 576803.0, 588314.0584297051, 589040.0, 109380.35929461065, 127064.36467817602, 130694.0, 133997.0, 134950.0, 875.9518226497477, 1016.4917541229386, 1043.3739756146251, 1045.3257648816623, 1049.302214027663, 18208.635827283644, 19157.61684766325, 19354.419367419, 19410.514737131685, 19412.8058719411, 47522.81192970203, 52110.0, 53285.4671453296, 55001.72499137479, 55222.44777552173, 78275.0, 78409.0, 79347.0, 79679.80480292917, 80787.78818317848, 6035.5473339500595, 7925.167857375123, 8095.797605059921, 8191.8771218430575, 8468.915310846813, 12036.699082523008, 12633.684157896127, 12773.020181871825, 12915.677108072374, 13217.537386191438, 9628.229741620513, 10752.516136773707, 11119.833202501806, 11287.097032237238, 11330.0, 8396.0, 9386.436813791195, 9828.803423931624, 10162.0, 11391.601293954673, 9789.363691360324, 10535.57857685684, 11255.718607034889, 11646.941765291458, 11726.589569365031, 7198.71205151788, 7371.299726525972, 7938.6030698466, 8055.919440805751, 8194.754157375288, 8877.911220887709, 9295.488748118918, 10996.670099896695, 11161.386123763272, 11262.267952583055], "value": 9255.313313068964, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.359958418088, 1509.803725515683, 1636.909969951652, 1750.1511766793103, 1750.9124543772807, 7679.57762323072, 7798.454108212427, 8076.596170191489, 8469.745907622773, 8508.872366914502, 7708.535378278138, 7761.146273909865, 8043.316318112953, 8333.0, 8354.0, 2107.8735275883496, 2204.559088182362, 2302.2747834432143, 2321.802646775026, 2327.7555856635063, 2323.94190145246, 2351.7413084560685, 2372.54921564903, 2380.1074597026113, 2386.3914701751028, 2322.477442575424, 2324.0, 2341.894614742332, 2344.8593084414906, 2354.2701762453607, 2314.9884250578725, 2316.05522210081, 2333.7316208636053, 2343.6015877300815, 2347.1432926981615, 2303.124812571229, 2359.8112151027876, 2364.113457453455, 2369.324742448394, 2374.358923090756, 8430.620622072021, 8431.19903609156, 8465.365097617703, 8499.490030598185, 8501.702440414618, 3993.5008123984503, 5169.663971841818, 5180.715060671661, 5193.272941788153, 5195.376554813409, 2896.8551572421293, 3134.8275844828527, 3414.13929408473, 3599.6040435552068, 3599.712023038177, 1031.334789061059, 1045.5033858916954, 1075.9946200269028, 1091.5360971587122, 1093.0272057868503, 9617.0, 10830.40432776197, 10956.959088886622, 10988.780224395467, 10993.835092473619, 4398.670099742532, 4541.886452838706, 4630.72215667061, 4650.67445278834, 4656.8602941911795, 9383.5308234588, 9439.433633981984, 9490.525473726286, 9502.90497095034, 9505.90494095064, 5150.639455238173, 5159.329287192641, 5159.922601160985, 5164.04465173944, 5169.25045868347, 4227.387028880795, 4587.518310577408, 4678.7660616969015, 4683.180443422388, 4739.620830333634, 3738.2523495300507, 3754.4931434256027, 3828.48315477407, 3828.73198876076, 3854.5567259765485, 1226.2029680707433, 1235.092207227687, 1245.0910835090435, 1253.8683438239036, 1261.1928365845865, 600.4535872356134, 860.2043110123111, 890.8485557455248, 906.981860362789, 922.7462447826902, 5599.916001259984, 5644.6613203207935, 5766.971165144148, 5888.205092312483, 5915.053591425351, 403.54399528533156, 415.9313713237282, 423.80504967715194, 424.2956691891507, 429.44172575651527, 3762.6049264826797, 3779.3197224499304, 3839.846406143779, 3891.7081218908697, 3919.451276821247, 8451.45065570736, 9750.658726944665, 10135.239857010754, 10140.087392134596, 10160.4919754012, 9737.221022318197, 9800.705978820646, 9950.0, 10062.547185376676, 10110.494475276208, 7784.221577842283, 7880.724174653859, 7894.289513943658, 7908.130105688369, 7912.208779122157, 5421.0, 5541.5289700375915, 5570.637908536094, 5619.185218143428, 5630.296212973379, 9281.071892810665, 9283.62865485373, 9318.62725491, 9338.159565638853, 9343.53282335867, 9308.44149351041, 9363.110504502061, 9378.765530861783, 9431.481268530297, 9538.523073846418, 7018.368346848604, 7117.181524124585, 7174.42604591621, 7176.892346614701, 7277.454190935595, 7975.80060498469, 8046.356291496783, 8061.758147255592, 8063.637136328762, 8063.637136328762, 6904.654767261516, 7037.964810176121, 7144.035555199982, 7220.711171553079, 7286.271372862671, 6882.810364959917, 7062.293770623102, 7097.325754053357, 7160.069191005345, 7164.319389657974, 6623.701933412912, 6654.201495820533, 6734.663266836541, 6737.629430381376, 6738.35985581369, 4479.395281636937, 4756.310335001474, 4791.832285869978, 4816.373871396696, 4830.396200474941, 3969.9206015878945, 4717.150912835723, 4768.976155119202, 4782.521747825329, 4952.702837829742], "value": 4308.258152970534, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.1642691531002, 304.669433664474, 308.1203164964027, 310.6458637153645, 310.9160526657801, 4568.657350698699, 5453.809116680917, 5548.389677135512, 5552.555795536357, 5590.664560126395, 4961.404631444232, 5403.189521571766, 5442.2380866678595, 5456.454354564542, 5535.446455354462, 3415.8556883444076, 3510.4558793387064, 3899.610038996106, 3959.722819402643, 4081.3877918312196, 3075.630924289077, 3774.169682669808, 4061.3298805697023, 4070.5522392536795, 4074.694397920153, 3357.8153201573905, 3623.6376362363817, 4061.97969010156, 4079.367698006799, 4105.398894431174, 3324.3683700097026, 3525.347810655024, 3769.0, 4050.696197785178, 4089.3865920111925, 3512.6662967018347, 3516.7186625069935, 3521.383757842393, 3531.7880927144197, 3558.733095017884, 4526.615237704799, 5235.424103348629, 5304.55990244488, 5312.335958005249, 5342.824578592704, 4181.142865712522, 4509.413776209105, 4658.950061972755, 4662.114198302312, 4738.810447582093, 4944.901101977976, 5123.564497017758, 5485.6982865942355, 5654.858628534278, 5691.971540142315, 3412.778169419005, 3866.1881004988986, 3876.980615096935, 3899.493065901443, 3929.292727309083, 4933.210686290176, 5591.12697246427, 6029.794041191779, 6087.634741915455, 6103.755849766004, 3166.651668316483, 3380.3408335374365, 3929.626685464876, 3965.78188199646, 3969.583193764671, 3517.4196257617205, 3925.803709814498, 4009.6190861868076, 4020.9396859047138, 4045.2516284487465, 3895.5130608673917, 4690.296455531629, 4690.577847993697, 4719.811207551659, 4725.5510726480925, 5213.661112027706, 5664.51851592611, 5764.798232061941, 5860.384659610765, 5882.970585147133, 1178.9174757767046, 1343.8980036370278, 1348.9208633093485, 1365.9521916732867, 1368.206440264644, 764.9388048956071, 814.0475643497123, 821.5727821532889, 822.6092606012096, 829.2039641943802, 5094.77073531692, 5242.7378631068295, 5326.733663316819, 5508.6970216637665, 5517.248271175559, 5636.464535869086, 5919.141724450017, 5921.319048309413, 5969.940300596939, 5977.731002104916, 4289.0, 4887.853364399074, 4969.2546118081855, 5387.892242155135, 5454.563634909197, 2737.466194092133, 3108.0986513911166, 3108.8134711916905, 3134.3574567214123, 3142.177537028518, 6074.574779765374, 6094.65593959278, 6143.354947730513, 6165.753369865155, 6170.889239936765, 5005.374328208974, 5779.0, 5978.85052873673, 6034.306054803754, 6118.265808103056, 5369.812056578001, 6016.909746353808, 6096.0, 6130.938690613215, 6136.907946380718, 4764.595009424238, 5062.797488100435, 5817.243758311392, 5849.163155869315, 5925.733341999707, 5806.332271788799, 5822.505087067478, 5843.357230704704, 5849.093390524476, 5865.384134665969, 4854.563089321978, 5994.520438364833, 6059.6364218147055, 6061.605995610271, 6124.908126378019, 3659.6157403472253, 3906.746061506107, 3917.843286268517, 3966.8809935701975, 3975.4633124528978, 5158.871028224325, 5181.455947125498, 5979.760809567569, 6016.789412370546, 6046.3046749624355, 5634.234171931646, 5849.3858144894175, 5857.209276747584, 5875.911861321998, 5880.706244626175, 4057.3711074782277, 4821.566059054702, 5460.754266058117, 5696.515796157208, 5771.480566749013, 5104.6727850758325, 5210.947890521046, 5646.548276137817, 5657.773689052392, 5664.631798933056, 4832.734199619054, 5501.3948465667945, 5740.569457290637, 5777.306723193244, 5844.305151506016, 4926.610593862046, 5639.407862174413, 5662.716864156858, 5682.5453963681975, 5682.829515114553], "value": 4127.768447982789, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.3265143039796, 662.423691388492, 706.7561691216532, 737.8007937856783, 797.5732982854171, 14354.0, 15279.847201527982, 15296.235188240598, 15323.616909577253, 15388.769168462482, 13766.311684415765, 13936.0, 13946.581602551914, 13951.232682202475, 13959.0, 652.7878439507156, 665.8302132956113, 805.8630032894392, 809.1988930958368, 832.1678321678322, 817.1705718695529, 822.173715416009, 839.3327304792705, 840.306746933779, 841.6969890839293, 885.9468431894107, 886.9822603547925, 888.6356593796545, 889.3641046651643, 889.5818965086431, 878.97802554936, 882.3073886998708, 882.9117088291151, 883.8409086364452, 887.0907319996991, 598.3776872053103, 644.4361183964031, 646.6120327803327, 653.2226650286192, 653.5523166630873, 12225.266484010988, 12436.440360183813, 13612.31938403076, 14718.55844324672, 15005.174715390649, 12599.496020159182, 14122.576322710334, 14128.799052080585, 14252.0, 14277.928610356985, 10882.857299983547, 11589.710257243552, 11719.238249513839, 11951.760964780742, 12089.758204835942, 3360.915977100592, 3486.6687664672068, 3731.440283957401, 3847.7883716395586, 3905.648491635738, 78570.6071469639, 85965.57017214937, 86089.0, 87894.56052719695, 89005.0, 9313.254939604816, 10232.181425486093, 10265.948670256601, 10290.0, 10653.57385704563, 16363.0, 18737.812621873607, 18999.905000474908, 19094.331698390488, 19322.8067719321, 7295.671694773748, 7403.9629801851725, 7451.515651482637, 7523.962380188064, 7584.241575842371, 4281.935770963438, 4317.568243175658, 4332.956670433318, 4352.107817897323, 4386.627136693417, 3383.1034775784437, 3456.032310952937, 3462.8787992420143, 3501.8599256029984, 3502.5972013218807, 620.268083661284, 644.8484606117559, 647.4723100672936, 662.7713438863584, 664.6842749693857, 560.2742656973793, 572.567711377907, 582.5368831778746, 599.8920194365056, 619.9318075011745, 8382.245597896219, 9023.323250756219, 9100.544972751335, 9110.498922559324, 9134.834353155546, 567.6650776042072, 623.3268070483866, 659.8878190707495, 660.9471242300605, 668.9331066893369, 3743.6630703236838, 4166.270902592034, 4335.848245311462, 4377.879039351189, 4387.42963414754, 101359.98640013653, 113064.86935130543, 117859.41070294766, 123974.0, 125722.0, 85858.71211931825, 106113.46943265389, 106180.0, 107293.0, 107779.0, 54722.726386367816, 58717.532061697944, 63226.68386658037, 80623.59688201638, 83965.74051389234, 9504.19214366759, 9625.56684949193, 9650.542706481503, 9715.854262185932, 9733.853992190265, 42755.786221068694, 46180.0, 52254.69363265797, 56353.0, 58639.48163110227, 76203.61898190696, 76938.23061769534, 79675.60162199152, 79948.00129996796, 80231.59884200542, 10077.546510406903, 11932.522699091938, 11983.76032479363, 12089.637310880687, 12323.69190770238, 13588.59234222975, 13962.650933726738, 14102.717945641234, 14111.364988575744, 14294.785578216542, 12758.170718903242, 12807.551735689207, 12817.743645126859, 12821.423035963218, 12913.354332283161, 11179.720506987065, 12553.560625378068, 13013.349332533146, 13046.869531304945, 13301.582743785782, 12475.376231188222, 12651.620451386472, 12689.23864568129, 12769.808452873029, 12927.353632318534, 8286.834263314578, 10502.422366769595, 10594.205434592282, 10816.242862999514, 10935.945320273666, 9647.565859536197, 10112.577929941614, 10173.796524069625, 11078.889211108108, 11180.55277788912], "value": 7191.824496758427, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1627.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 118.0, 119.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 115.0, 150.0, 123.0, 153.0, 132.0, 115.0, 146.0, 117.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 250.0, 222.0, 249.0, 278.0, 266.0, 195.0, 207.0, 209.0, 226.0], "value": 231.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 82.0, 86.0, 75.0, 87.0, 86.0, 54.0, 84.0, 82.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 92.0, 88.0, 96.0, 100.0, 105.0, 99.0, 70.0, 70.0, 89.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 91.0, 136.0, 134.0, 110.0, 87.0, 91.0, 90.0, 112.0, 88.0], "value": 104.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 97.0, 100.0, 101.0, 154.0, 98.0, 98.0, 107.0, 98.0], "value": 104.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 144.0, 97.0, 86.0, 87.0, 92.0, 88.0, 92.0, 88.0, 88.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 72.0, 89.0, 91.0, 67.0, 59.0, 58.0, 58.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 76.0, 82.0, 77.0, 72.0, 72.0, 62.0, 96.0, 113.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 109.0, 108.0, 109.0, 99.0, 87.0, 88.0, 89.0, 92.0], "value": 96.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 164.0, 172.0, 173.0, 163.0, 169.0, 138.0, 209.0, 192.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 176.0, 174.0, 177.0, 175.0, 176.0, 177.0, 244.0, 176.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 87.0, 92.0, 95.0, 95.0, 80.0, 67.0, 70.0, 68.0, 69.0], "value": 78.8, "unit": "score"}]}]} 08:44:35 INFO - Return code: 0 08:44:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:44:35 ERROR - # TBPL SUCCESS # 08:44:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:44:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:44:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:44:35 INFO - 2016-11-02 08:44:35.680 screenresolution[1954:20864] starting screenresolution argv=screenresolution get 08:44:35 INFO - 2016-11-02 08:44:35.682 screenresolution[1954:20864] Display 0: 1600x1200x32@60 08:44:35 INFO - 2016-11-02 08:44:35.688 screenresolution[1955:20867] starting screenresolution argv=screenresolution list 08:44:35 INFO - Available Modes on Display 0 08:44:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:44:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:44:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:44:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:44:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:44:35 INFO - Intel Iris: 08:44:35 INFO - Chipset Model: Intel Iris 08:44:35 INFO - Type: GPU 08:44:35 INFO - Bus: Built-In 08:44:35 INFO - VRAM (Dynamic, Max): 1536 MB 08:44:35 INFO - Vendor: Intel (0x8086) 08:44:35 INFO - Device ID: 0x0a2e 08:44:35 INFO - Revision ID: 0x0009 08:44:35 INFO - Displays: 08:44:35 INFO - Display: 08:44:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:44:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:44:35 INFO - Display Serial Number: 1600x1200 60 08:44:35 INFO - Main Display: Yes 08:44:35 INFO - Mirror: Off 08:44:35 INFO - Online: Yes 08:44:35 INFO - Rotation: Supported 08:44:35 INFO - Return code: 0 08:44:35 INFO - Running post-action listener: _resource_record_post_action 08:44:35 INFO - [mozharness: 2016-11-02 15:44:35.923489Z] Finished run-tests step (success) 08:44:35 INFO - Running post-run listener: _resource_record_post_run 08:44:35 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 1091072; Write bytes: 711543808; Read time: 11; Write time: 1993 08:44:35 INFO - TinderboxPrint: CPU usage
54.3% 08:44:35 INFO - TinderboxPrint: I/O read bytes / time
1,091,072 / 11 08:44:35 INFO - TinderboxPrint: I/O write bytes / time
711,543,808 / 1,993 08:44:35 INFO - TinderboxPrint: CPU idle
2,217.8 (45.7%) 08:44:35 INFO - TinderboxPrint: CPU system
982.5 (20.2%) 08:44:35 INFO - TinderboxPrint: CPU user
1,657.5 (34.1%) 08:44:35 INFO - TinderboxPrint: Swap in / out
408,494,080 / 0 08:44:35 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 401957376; Write bytes: 397309440; Read time: 30594; Write time: 802 08:44:36 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 1091072; Write bytes: 299755008; Read time: 11; Write time: 1145 08:44:36 INFO - Running post-run listener: _upload_blobber_files 08:44:36 INFO - Blob upload gear active. 08:44:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:44:36 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 08:44:36 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:44:36 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:44:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:37 INFO - (blobuploader) - INFO - Done attempting. 08:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:44:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:38 INFO - (blobuploader) - INFO - Done attempting. 08:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:44:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:42 INFO - (blobuploader) - INFO - Done attempting. 08:44:42 INFO - (blobuploader) - INFO - Iteration through files over. 08:44:42 INFO - Return code: 0 08:44:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:44:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:44:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b4d8da3046f90c97f1ad45017ac31d3a61f707643e19a1a71396246f21c946b8a4efa18b0e7156e2c05fa483dc2cef269dcd3be339419a7ad461ee8d123ca544", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0b8a5629e3b1a8f12d9bd433362cc132f49ff2663031b1a8d6299542022590489a0e143bface858fd2f03d7d458446d1b2b47fd633be5d043a88e05b9a099e77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0b517cf808a32257e9b6e17477ffe7e4d86620cc94ecdc74c065036eb2a9579f27d4af58a1819439efb3ff2deae0005043a54308c78d0c7a739e5e893f4f92d2"} 08:44:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:44:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:44:42 INFO - Contents: 08:44:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b4d8da3046f90c97f1ad45017ac31d3a61f707643e19a1a71396246f21c946b8a4efa18b0e7156e2c05fa483dc2cef269dcd3be339419a7ad461ee8d123ca544", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0b8a5629e3b1a8f12d9bd433362cc132f49ff2663031b1a8d6299542022590489a0e143bface858fd2f03d7d458446d1b2b47fd633be5d043a88e05b9a099e77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0b517cf808a32257e9b6e17477ffe7e4d86620cc94ecdc74c065036eb2a9579f27d4af58a1819439efb3ff2deae0005043a54308c78d0c7a739e5e893f4f92d2"} 08:44:42 INFO - Running post-run listener: copy_logs_to_upload_dir 08:44:42 INFO - Copying logs to upload dir... 08:44:42 INFO - mkdir: /builds/slave/test/build/upload/logs 08:44:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.089067 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-02 08:44:42.806518) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 08:44:42.810844) ========= 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.e4vasAjFMX/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.HAvJy64vJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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/Cedar/sha512/b4d8da3046f90c97f1ad45017ac31d3a61f707643e19a1a71396246f21c946b8a4efa18b0e7156e2c05fa483dc2cef269dcd3be339419a7ad461ee8d123ca544", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0b8a5629e3b1a8f12d9bd433362cc132f49ff2663031b1a8d6299542022590489a0e143bface858fd2f03d7d458446d1b2b47fd633be5d043a88e05b9a099e77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0b517cf808a32257e9b6e17477ffe7e4d86620cc94ecdc74c065036eb2a9579f27d4af58a1819439efb3ff2deae0005043a54308c78d0c7a739e5e893f4f92d2"} build_url:https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/THBtC9R-RY-ZkDdF5ucbzQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b4d8da3046f90c97f1ad45017ac31d3a61f707643e19a1a71396246f21c946b8a4efa18b0e7156e2c05fa483dc2cef269dcd3be339419a7ad461ee8d123ca544", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0b8a5629e3b1a8f12d9bd433362cc132f49ff2663031b1a8d6299542022590489a0e143bface858fd2f03d7d458446d1b2b47fd633be5d043a88e05b9a099e77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/0b517cf808a32257e9b6e17477ffe7e4d86620cc94ecdc74c065036eb2a9579f27d4af58a1819439efb3ff2deae0005043a54308c78d0c7a739e5e893f4f92d2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 08:44:42.850086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 08:44:42.850418) ========= 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.e4vasAjFMX/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.HAvJy64vJw/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.005247 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 08:44:42.899362) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 08:44:42.899691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 08:44:42.900053) ========= ========= Total master_lag: 0.19 =========