builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1486663540.3 results: success (0) revision: c8eeb0d150df26360bb162db3da74ed686c8bca5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:40.301230) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:40.301706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:40.301983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:40.314546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:40.314851) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 10:05:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2017-02-09 10:05:40 (218 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081919 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:40.410089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:40.410519) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017456 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:40.460644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 10:05:40.461000) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c8eeb0d150df26360bb162db3da74ed686c8bca5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c8eeb0d150df26360bb162db3da74ed686c8bca5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 10:05:40,644 truncating revision to first 12 chars 2017-02-09 10:05:40,644 Setting DEBUG logging. 2017-02-09 10:05:40,644 attempt 1/10 2017-02-09 10:05:40,644 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c8eeb0d150df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 10:05:41,932 unpacking tar archive at: mozilla-aurora-c8eeb0d150df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.594309 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 10:05:42.068532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:42.069031) ========= script_repo_revision: c8eeb0d150df26360bb162db3da74ed686c8bca5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:42.069704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:42.070141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 10:05:42.080043) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 10:05:42.080465) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:42 INFO - MultiFileLogger online at 20170209 10:05:42 in /builds/slave/test 10:05:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:05:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:42 INFO - {'append_to_log': False, 10:05:42 INFO - 'base_work_dir': '/builds/slave/test', 10:05:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:05:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:42 INFO - 'branch': 'Mozilla-Aurora', 10:05:42 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:42 INFO - 'config_files': ('talos/linux_config.py',), 10:05:42 INFO - 'default_actions': ('clobber', 10:05:42 INFO - 'read-buildbot-config', 10:05:42 INFO - 'download-and-extract', 10:05:42 INFO - 'populate-webroot', 10:05:42 INFO - 'create-virtualenv', 10:05:42 INFO - 'install', 10:05:42 INFO - 'run-tests'), 10:05:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:42 INFO - 'download_minidump_stackwalk': True, 10:05:42 INFO - 'download_symbols': 'ondemand', 10:05:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:42 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:42 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:42 INFO - 'installer_path': 'installer.exe', 10:05:42 INFO - 'log_level': 'info', 10:05:42 INFO - 'log_name': 'talos', 10:05:42 INFO - 'log_to_console': True, 10:05:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:42 INFO - 'opt_config_files': (), 10:05:42 INFO - 'pip_index': False, 10:05:42 INFO - 'sps_profile': False, 10:05:42 INFO - 'sps_profile_interval': 0, 10:05:42 INFO - 'suite': 'dromaeojs', 10:05:42 INFO - 'system_bits': '32', 10:05:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:42 INFO - 'title': 'talos-linux64-ix-005', 10:05:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:42 INFO - 'use_talos_json': True, 10:05:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:42 INFO - 'work_dir': 'build'} 10:05:42 INFO - [mozharness: 2017-02-09 18:05:42.364501Z] Running clobber step. 10:05:42 INFO - Running pre-action listener: _resource_record_pre_action 10:05:42 INFO - Running main action method: clobber 10:05:42 INFO - rmtree: /builds/slave/test/build 10:05:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:42 INFO - Running post-action listener: _resource_record_post_action 10:05:42 INFO - [mozharness: 2017-02-09 18:05:42.887968Z] Finished clobber step (success) 10:05:42 INFO - [mozharness: 2017-02-09 18:05:42.888071Z] Running read-buildbot-config step. 10:05:42 INFO - Running pre-action listener: _resource_record_pre_action 10:05:42 INFO - Running main action method: read_buildbot_config 10:05:42 INFO - Using buildbot properties: 10:05:42 INFO - { 10:05:42 INFO - "project": "", 10:05:42 INFO - "product": "firefox", 10:05:42 INFO - "who": "ryanvm@gmail.com", 10:05:42 INFO - "installer_path": "public/build/target.tar.bz2", 10:05:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:05:42 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 10:05:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:05:42 INFO - "stage_platform": "linux64-pgo", 10:05:42 INFO - "basedir": "/builds/slave/test", 10:05:42 INFO - "buildnumber": 746, 10:05:42 INFO - "platform": "ubuntu64_hw", 10:05:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:05:42 INFO - "slavebuilddir": "test", 10:05:42 INFO - "taskId": "LwMd4IQyQQiMJw1IsJP8Fw", 10:05:42 INFO - "branch": "mozilla-aurora", 10:05:42 INFO - "script_repo_revision": "production", 10:05:42 INFO - "revision": "c8eeb0d150df26360bb162db3da74ed686c8bca5", 10:05:42 INFO - "slavename": "talos-linux64-ix-005", 10:05:42 INFO - "repo_path": "releases/mozilla-aurora" 10:05:42 INFO - } 10:05:42 INFO - Finding installer, test and symbols from parent task. 10:05:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LwMd4IQyQQiMJw1IsJP8Fw'}, attempt #1 10:05:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LwMd4IQyQQiMJw1IsJP8Fw'}, attempt #1 10:05:43 INFO - Task dependencies: NqU0E1HiSEW19SH7wT7Y-Q 10:05:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q'}, attempt #1 10:05:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.tar.bz2 10:05:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/test_packages.json 10:05:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.crashreporter-symbols.zip 10:05:44 INFO - Running post-action listener: _resource_record_post_action 10:05:44 INFO - [mozharness: 2017-02-09 18:05:44.288784Z] Finished read-buildbot-config step (success) 10:05:44 INFO - [mozharness: 2017-02-09 18:05:44.289000Z] Running download-and-extract step. 10:05:44 INFO - Running pre-action listener: _resource_record_pre_action 10:05:44 INFO - Running main action method: download_and_extract 10:05:44 INFO - mkdir: /builds/slave/test/build/tests 10:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:44 INFO - trying https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.test_packages.json 10:05:44 INFO - Downloading https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:05:44 INFO - Downloaded 896 bytes. 10:05:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:05:44 INFO - Using the following test package requirements: 10:05:44 INFO - {u'common': [u'target.common.tests.zip'], 10:05:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:05:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:05:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:05:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:05:44 INFO - u'mozbase': [u'target.common.tests.zip'], 10:05:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:05:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:05:44 INFO - u'web-platform': [u'target.common.tests.zip', 10:05:44 INFO - u'target.web-platform.tests.zip'], 10:05:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:05:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:05:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.common.tests.zip 10:05:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:05:44 INFO - Fetch https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.common.tests.zip into memory 10:05:45 INFO - Expected file size: 21854908 10:05:45 INFO - Obtained file size: 21854908 10:05:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:05:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.common.tests.zip 10:05:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:05:49 INFO - Fetch https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.common.tests.zip into memory 10:05:50 INFO - Expected file size: 21854908 10:05:50 INFO - Obtained file size: 21854908 10:05:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.talos.tests.zip 10:05:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:05:54 INFO - Fetch https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.talos.tests.zip into memory 10:05:55 INFO - Expected file size: 14403485 10:05:55 INFO - Obtained file size: 14403485 10:05:55 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')]} 10:05:55 INFO - trying https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.tar.bz2 10:05:55 INFO - Downloading https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:05:57 INFO - Downloaded 66100125 bytes. 10:05:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.tar.bz2 10:05:57 INFO - mkdir: /builds/slave/test/properties 10:05:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:57 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:57 INFO - Contents: 10:05:57 INFO - build_url:https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.tar.bz2 10:05:57 INFO - Running post-action listener: _resource_record_post_action 10:05:57 INFO - Running post-action listener: set_extra_try_arguments 10:05:57 INFO - [mozharness: 2017-02-09 18:05:57.120888Z] Finished download-and-extract step (success) 10:05:57 INFO - [mozharness: 2017-02-09 18:05:57.120985Z] Running populate-webroot step. 10:05:57 INFO - Running pre-action listener: _resource_record_pre_action 10:05:57 INFO - Running main action method: populate_webroot 10:05:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:57 INFO - '--tppagecycles', 10:05:57 INFO - '7'], 10:05:57 INFO - 'tests': ['tsvgm']}}, 10:05:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:05:57 INFO - 'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:05:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:05:57 INFO - 'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['damp', 'tps']}, 10:05:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:05:57 INFO - 'tests': ['damp', 'tps']}, 10:05:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['dromaeo_dom']}, 10:05:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['basic_compositor_video']}, 10:05:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:05:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['a11yr', 10:05:57 INFO - 'ts_paint', 10:05:57 INFO - 'tpaint', 10:05:57 INFO - 'sessionrestore', 10:05:57 INFO - 'sessionrestore_no_auto_restore', 10:05:57 INFO - 'tabpaint']}, 10:05:57 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:57 INFO - 'ts_paint', 10:05:57 INFO - 'tpaint', 10:05:57 INFO - 'sessionrestore', 10:05:57 INFO - 'sessionrestore_no_auto_restore', 10:05:57 INFO - 'tabpaint']}, 10:05:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:57 INFO - 'ts_paint', 10:05:57 INFO - 'tpaint', 10:05:57 INFO - 'sessionrestore', 10:05:57 INFO - 'sessionrestore_no_auto_restore', 10:05:57 INFO - 'tabpaint']}, 10:05:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:57 INFO - 'ts_paint', 10:05:57 INFO - 'tpaint', 10:05:57 INFO - 'sessionrestore', 10:05:57 INFO - 'sessionrestore_no_auto_restore', 10:05:57 INFO - 'tabpaint']}, 10:05:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['a11yr', 10:05:57 INFO - 'ts_paint', 10:05:57 INFO - 'tpaint', 10:05:57 INFO - 'sessionrestore', 10:05:57 INFO - 'sessionrestore_no_auto_restore', 10:05:57 INFO - 'tabpaint']}, 10:05:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['a11yr', 10:05:57 INFO - 'ts_paint', 10:05:57 INFO - 'tpaint', 10:05:57 INFO - 'sessionrestore', 10:05:57 INFO - 'sessionrestore_no_auto_restore', 10:05:57 INFO - 'tabpaint']}, 10:05:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['tsvgx', 10:05:57 INFO - 'tsvgr_opacity', 10:05:57 INFO - 'tart', 10:05:57 INFO - 'tscrollx', 10:05:57 INFO - 'cart', 10:05:57 INFO - 'tsvg_static']}, 10:05:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:57 INFO - 'tsvgr_opacity', 10:05:57 INFO - 'tart', 10:05:57 INFO - 'tscrollx', 10:05:57 INFO - 'cart', 10:05:57 INFO - 'tsvg_static']}, 10:05:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:05:57 INFO - 'talos_options': ['--disable-e10s'], 10:05:57 INFO - 'tests': ['tp5o']}, 10:05:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:05:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:05:57 INFO - 'talos_options': ['--disable-e10s', 10:05:57 INFO - '--xperf_path', 10:05:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:57 INFO - 'tests': ['tp5n']}, 10:05:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:05:57 INFO - 'talos_options': ['--xperf_path', 10:05:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:57 INFO - 'tests': ['tp5n']}}, 10:05:57 INFO - 'talos.zip': {'path': '', 10:05:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:57 INFO - Running post-action listener: _resource_record_post_action 10:05:57 INFO - [mozharness: 2017-02-09 18:05:57.134109Z] Finished populate-webroot step (success) 10:05:57 INFO - [mozharness: 2017-02-09 18:05:57.134199Z] Running create-virtualenv step. 10:05:57 INFO - Running pre-action listener: _resource_record_pre_action 10:05:57 INFO - Running main action method: create_virtualenv 10:05:57 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:57 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 10:05:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:57 INFO - Using real prefix '/usr' 10:05:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:57 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:59 INFO - Installing pip.................done. 10:05:59 INFO - Return code: 0 10:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:05:59 INFO - Reading from file tmpfile_stdout 10:05:59 INFO - Output received: 10:05:59 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:05:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:05:59 INFO - Using env: {'DISPLAY': ':0', 10:05:59 INFO - 'HOME': '/home/cltbld', 10:05:59 INFO - 'LANG': 'en_US.UTF-8', 10:05:59 INFO - 'LANGUAGE': 'en_US:en', 10:05:59 INFO - 'LOGNAME': 'cltbld', 10:05:59 INFO - 'MAIL': '/var/mail/cltbld', 10:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:59 INFO - 'MOZ_NO_REMOTE': '1', 10:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:59 INFO - 'NO_EM_RESTART': '1', 10:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:59 INFO - 'PWD': '/builds/slave/test', 10:05:59 INFO - 'SHELL': '/bin/bash', 10:05:59 INFO - 'SHLVL': '1', 10:05:59 INFO - 'TERM': 'linux', 10:05:59 INFO - 'TMOUT': '86400', 10:05:59 INFO - 'USER': 'cltbld', 10:05:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:59 INFO - '_': '/tools/buildbot/bin/python'} 10:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:00 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 10:06:00 INFO - Cleaning up... 10:06:00 INFO - Return code: 0 10:06:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 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 0xb931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:00 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 10:06:00 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 10:06:00 INFO - Using env: {'DISPLAY': ':0', 10:06:00 INFO - 'HOME': '/home/cltbld', 10:06:00 INFO - 'LANG': 'en_US.UTF-8', 10:06:00 INFO - 'LANGUAGE': 'en_US:en', 10:06:00 INFO - 'LOGNAME': 'cltbld', 10:06:00 INFO - 'MAIL': '/var/mail/cltbld', 10:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:00 INFO - 'MOZ_NO_REMOTE': '1', 10:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:00 INFO - 'NO_EM_RESTART': '1', 10:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:00 INFO - 'PWD': '/builds/slave/test', 10:06:00 INFO - 'SHELL': '/bin/bash', 10:06:00 INFO - 'SHLVL': '1', 10:06:00 INFO - 'TERM': 'linux', 10:06:00 INFO - 'TMOUT': '86400', 10:06:00 INFO - 'USER': 'cltbld', 10:06:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:00 INFO - '_': '/tools/buildbot/bin/python'} 10:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:00 INFO - Downloading/unpacking psutil>=3.1.1 10:06:00 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 10:06:00 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 10:06:00 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 10:06:00 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 10:06:00 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 10:06:00 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 10:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:02 INFO - Installing collected packages: psutil 10:06:02 INFO - Running setup.py install for psutil 10:06:02 INFO - building 'psutil._psutil_linux' extension 10:06:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:06:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:06:02 INFO - building 'psutil._psutil_posix' extension 10:06:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:06:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:06:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:02 INFO - Successfully installed psutil 10:06:02 INFO - Cleaning up... 10:06:03 INFO - Return code: 0 10:06:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:06:03 INFO - Using env: {'DISPLAY': ':0', 10:06:03 INFO - 'HOME': '/home/cltbld', 10:06:03 INFO - 'LANG': 'en_US.UTF-8', 10:06:03 INFO - 'LANGUAGE': 'en_US:en', 10:06:03 INFO - 'LOGNAME': 'cltbld', 10:06:03 INFO - 'MAIL': '/var/mail/cltbld', 10:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:03 INFO - 'MOZ_NO_REMOTE': '1', 10:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:03 INFO - 'NO_EM_RESTART': '1', 10:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:03 INFO - 'PWD': '/builds/slave/test', 10:06:03 INFO - 'SHELL': '/bin/bash', 10:06:03 INFO - 'SHLVL': '1', 10:06:03 INFO - 'TERM': 'linux', 10:06:03 INFO - 'TMOUT': '86400', 10:06:03 INFO - 'USER': 'cltbld', 10:06:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:03 INFO - '_': '/tools/buildbot/bin/python'} 10:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:06:05 INFO - Installing collected packages: mozsystemmonitor 10:06:05 INFO - Running setup.py install for mozsystemmonitor 10:06:05 INFO - Successfully installed mozsystemmonitor 10:06:05 INFO - Cleaning up... 10:06:05 INFO - Return code: 0 10:06:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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', '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 0xb931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:06: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 jsonschema==2.5.1 10:06:05 INFO - Using env: {'DISPLAY': ':0', 10:06:05 INFO - 'HOME': '/home/cltbld', 10:06:05 INFO - 'LANG': 'en_US.UTF-8', 10:06:05 INFO - 'LANGUAGE': 'en_US:en', 10:06:05 INFO - 'LOGNAME': 'cltbld', 10:06:05 INFO - 'MAIL': '/var/mail/cltbld', 10:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:05 INFO - 'MOZ_NO_REMOTE': '1', 10:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:05 INFO - 'NO_EM_RESTART': '1', 10:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:05 INFO - 'PWD': '/builds/slave/test', 10:06:05 INFO - 'SHELL': '/bin/bash', 10:06:05 INFO - 'SHLVL': '1', 10:06:05 INFO - 'TERM': 'linux', 10:06:05 INFO - 'TMOUT': '86400', 10:06:05 INFO - 'USER': 'cltbld', 10:06:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:05 INFO - '_': '/tools/buildbot/bin/python'} 10:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:05 INFO - Downloading/unpacking jsonschema==2.5.1 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:06:07 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 10:06:07 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 10:06:07 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 10:06:07 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 10:06:07 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 10:06:07 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 10:06:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:08 INFO - warning: no files found matching '*.txt' 10:06:08 INFO - no previously-included directories found matching 'build' 10:06:08 INFO - no previously-included directories found matching 'dist' 10:06:08 INFO - no previously-included directories found matching '.git*' 10:06:08 INFO - Installing collected packages: jsonschema, functools32 10:06:08 INFO - Running setup.py install for functools32 10:06:08 INFO - warning: no files found matching '*.txt' 10:06:08 INFO - no previously-included directories found matching 'build' 10:06:08 INFO - no previously-included directories found matching 'dist' 10:06:08 INFO - no previously-included directories found matching '.git*' 10:06:08 INFO - Successfully installed jsonschema functools32 10:06:08 INFO - Cleaning up... 10:06:08 INFO - Return code: 0 10:06:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:06:08 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')]} 10:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:08 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')]} 10:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:08 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 0xb931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:08 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 10:06:08 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 10:06:08 INFO - Using env: {'DISPLAY': ':0', 10:06:08 INFO - 'HOME': '/home/cltbld', 10:06:08 INFO - 'LANG': 'en_US.UTF-8', 10:06:08 INFO - 'LANGUAGE': 'en_US:en', 10:06:08 INFO - 'LOGNAME': 'cltbld', 10:06:08 INFO - 'MAIL': '/var/mail/cltbld', 10:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:08 INFO - 'MOZ_NO_REMOTE': '1', 10:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:08 INFO - 'NO_EM_RESTART': '1', 10:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:08 INFO - 'PWD': '/builds/slave/test', 10:06:08 INFO - 'SHELL': '/bin/bash', 10:06:08 INFO - 'SHLVL': '1', 10:06:08 INFO - 'TERM': 'linux', 10:06:08 INFO - 'TMOUT': '86400', 10:06:08 INFO - 'USER': 'cltbld', 10:06:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:08 INFO - '_': '/tools/buildbot/bin/python'} 10:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:06:08 INFO - Cleaning up... 10:06:08 INFO - Return code: 0 10:06:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:08 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')]} 10:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:08 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')]} 10:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:08 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 0xb931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:08 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 10:06:08 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 10:06:08 INFO - Using env: {'DISPLAY': ':0', 10:06:08 INFO - 'HOME': '/home/cltbld', 10:06:08 INFO - 'LANG': 'en_US.UTF-8', 10:06:08 INFO - 'LANGUAGE': 'en_US:en', 10:06:08 INFO - 'LOGNAME': 'cltbld', 10:06:08 INFO - 'MAIL': '/var/mail/cltbld', 10:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:08 INFO - 'MOZ_NO_REMOTE': '1', 10:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:08 INFO - 'NO_EM_RESTART': '1', 10:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:08 INFO - 'PWD': '/builds/slave/test', 10:06:08 INFO - 'SHELL': '/bin/bash', 10:06:08 INFO - 'SHLVL': '1', 10:06:08 INFO - 'TERM': 'linux', 10:06:08 INFO - 'TMOUT': '86400', 10:06:08 INFO - 'USER': 'cltbld', 10:06:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:08 INFO - '_': '/tools/buildbot/bin/python'} 10:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:08 INFO - Downloading/unpacking blobuploader==1.2.4 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:10 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:11 INFO - Downloading docopt-0.6.1.tar.gz 10:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:11 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:11 INFO - Running setup.py install for blobuploader 10:06:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:11 INFO - Running setup.py install for requests 10:06:11 INFO - Running setup.py install for docopt 10:06:12 INFO - Successfully installed blobuploader requests docopt 10:06:12 INFO - Cleaning up... 10:06:12 INFO - Return code: 0 10:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:12 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')]} 10:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:12 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')]} 10:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:12 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 0xb931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:12 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 10:06:12 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 10:06:12 INFO - Using env: {'DISPLAY': ':0', 10:06:12 INFO - 'HOME': '/home/cltbld', 10:06:12 INFO - 'LANG': 'en_US.UTF-8', 10:06:12 INFO - 'LANGUAGE': 'en_US:en', 10:06:12 INFO - 'LOGNAME': 'cltbld', 10:06:12 INFO - 'MAIL': '/var/mail/cltbld', 10:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:12 INFO - 'MOZ_NO_REMOTE': '1', 10:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:12 INFO - 'NO_EM_RESTART': '1', 10:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:12 INFO - 'PWD': '/builds/slave/test', 10:06:12 INFO - 'SHELL': '/bin/bash', 10:06:12 INFO - 'SHLVL': '1', 10:06:12 INFO - 'TERM': 'linux', 10:06:12 INFO - 'TMOUT': '86400', 10:06:12 INFO - 'USER': 'cltbld', 10:06:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:12 INFO - '_': '/tools/buildbot/bin/python'} 10:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:12 INFO - Running setup.py (path:/tmp/pip-fe8ftO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:12 INFO - Running setup.py (path:/tmp/pip-t5XI9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:12 INFO - Running setup.py (path:/tmp/pip-2BtikW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:12 INFO - Running setup.py (path:/tmp/pip-tACtbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:12 INFO - Running setup.py (path:/tmp/pip-Zw9p2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:12 INFO - Running setup.py (path:/tmp/pip-Crhe06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:12 INFO - Running setup.py (path:/tmp/pip-v8w0HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:12 INFO - Running setup.py (path:/tmp/pip-kuAOEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:12 INFO - Running setup.py (path:/tmp/pip-Ui5gXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:13 INFO - Running setup.py (path:/tmp/pip-57vTLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:13 INFO - Running setup.py (path:/tmp/pip-TwUgI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:13 INFO - Running setup.py (path:/tmp/pip-_ZJeD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:13 INFO - Running setup.py (path:/tmp/pip-5dHZet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:13 INFO - Running setup.py (path:/tmp/pip-gVFL1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:13 INFO - Running setup.py (path:/tmp/pip-iMjrJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:13 INFO - Running setup.py (path:/tmp/pip-Qq9uQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:13 INFO - Running setup.py (path:/tmp/pip-cdwGwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:13 INFO - Running setup.py install for manifestparser 10:06:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:13 INFO - Running setup.py install for mozcrash 10:06:13 INFO - Running setup.py install for mozdebug 10:06:13 INFO - Running setup.py install for mozdevice 10:06:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:06:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Running setup.py install for mozfile 10:06:14 INFO - Running setup.py install for mozhttpd 10:06:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Running setup.py install for mozinfo 10:06:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Running setup.py install for mozInstall 10:06:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Running setup.py install for mozleak 10:06:14 INFO - Running setup.py install for mozlog 10:06:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Running setup.py install for moznetwork 10:06:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Running setup.py install for mozprocess 10:06:14 INFO - Running setup.py install for mozprofile 10:06:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Running setup.py install for mozrunner 10:06:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:15 INFO - Running setup.py install for mozscreenshot 10:06:15 INFO - Running setup.py install for moztest 10:06:15 INFO - Running setup.py install for mozversion 10:06:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:15 INFO - Cleaning up... 10:06:15 INFO - Return code: 0 10:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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 0xb931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06: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 10:06: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 10:06:15 INFO - Using env: {'DISPLAY': ':0', 10:06:15 INFO - 'HOME': '/home/cltbld', 10:06:15 INFO - 'LANG': 'en_US.UTF-8', 10:06:15 INFO - 'LANGUAGE': 'en_US:en', 10:06:15 INFO - 'LOGNAME': 'cltbld', 10:06:15 INFO - 'MAIL': '/var/mail/cltbld', 10:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:15 INFO - 'MOZ_NO_REMOTE': '1', 10:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:15 INFO - 'NO_EM_RESTART': '1', 10:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:15 INFO - 'PWD': '/builds/slave/test', 10:06:15 INFO - 'SHELL': '/bin/bash', 10:06:15 INFO - 'SHLVL': '1', 10:06:15 INFO - 'TERM': 'linux', 10:06:15 INFO - 'TMOUT': '86400', 10:06:15 INFO - 'USER': 'cltbld', 10:06:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:15 INFO - '_': '/tools/buildbot/bin/python'} 10:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:15 INFO - Running setup.py (path:/tmp/pip-xRXZm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06: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)) 10:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:15 INFO - Running setup.py (path:/tmp/pip-ZrTYXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:15 INFO - Running setup.py (path:/tmp/pip-N0ICWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06: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)) 10:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:15 INFO - Running setup.py (path:/tmp/pip-1_bknt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:15 INFO - Running setup.py (path:/tmp/pip-Q0jFsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:15 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)) 10:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:15 INFO - Running setup.py (path:/tmp/pip-zyYEvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06: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)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:16 INFO - Running setup.py (path:/tmp/pip-y5fUi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06: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)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:16 INFO - Running setup.py (path:/tmp/pip-fXVp3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06: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)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:16 INFO - Running setup.py (path:/tmp/pip-M6ouV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06: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)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:16 INFO - Running setup.py (path:/tmp/pip-HpGXs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06: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)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:16 INFO - Running setup.py (path:/tmp/pip-pLrnsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06: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)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:16 INFO - Running setup.py (path:/tmp/pip-8CKuYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:16 INFO - Running setup.py (path:/tmp/pip-r1xSty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:16 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)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:16 INFO - Running setup.py (path:/tmp/pip-0YtgaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:16 INFO - Running setup.py (path:/tmp/pip-pnUVUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:16 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)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:16 INFO - Running setup.py (path:/tmp/pip-zgA5Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:16 INFO - Running setup.py (path:/tmp/pip-vhWbrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:16 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)) 10:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:16 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)) 10:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:18 INFO - Downloading blessings-1.6.tar.gz 10:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:18 INFO - Installing collected packages: blessings 10:06:18 INFO - Running setup.py install for blessings 10:06:19 INFO - Successfully installed blessings 10:06:19 INFO - Cleaning up... 10:06:19 INFO - Return code: 0 10:06:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:19 INFO - Reading from file tmpfile_stdout 10:06:19 INFO - Current package versions: 10:06:19 INFO - argparse == 1.2.1 10:06:19 INFO - blessings == 1.6 10:06:19 INFO - blobuploader == 1.2.4 10:06:19 INFO - docopt == 0.6.1 10:06:19 INFO - functools32 == 3.2.3-2 10:06:19 INFO - jsonschema == 2.5.1 10:06:19 INFO - manifestparser == 1.1 10:06:19 INFO - mozInstall == 1.12 10:06:19 INFO - mozcrash == 1.0 10:06:19 INFO - mozdebug == 0.1 10:06:19 INFO - mozdevice == 0.49 10:06:19 INFO - mozfile == 1.2 10:06:19 INFO - mozhttpd == 0.7 10:06:19 INFO - mozinfo == 0.9 10:06:19 INFO - mozleak == 0.1 10:06:19 INFO - mozlog == 3.4 10:06:19 INFO - moznetwork == 0.27 10:06:19 INFO - mozprocess == 0.24 10:06:19 INFO - mozprofile == 0.28 10:06:19 INFO - mozrunner == 6.13 10:06:19 INFO - mozscreenshot == 0.1 10:06:19 INFO - mozsystemmonitor == 0.3 10:06:19 INFO - moztest == 0.8 10:06:19 INFO - mozversion == 1.4 10:06:19 INFO - psutil == 3.1.1 10:06:19 INFO - requests == 1.2.3 10:06:19 INFO - wsgiref == 0.1.2 10:06:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 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 0xb931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:19 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 10:06:19 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 10:06:19 INFO - Using env: {'DISPLAY': ':0', 10:06:19 INFO - 'HOME': '/home/cltbld', 10:06:19 INFO - 'LANG': 'en_US.UTF-8', 10:06:19 INFO - 'LANGUAGE': 'en_US:en', 10:06:19 INFO - 'LOGNAME': 'cltbld', 10:06:19 INFO - 'MAIL': '/var/mail/cltbld', 10:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:19 INFO - 'MOZ_NO_REMOTE': '1', 10:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:19 INFO - 'NO_EM_RESTART': '1', 10:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:19 INFO - 'PWD': '/builds/slave/test', 10:06:19 INFO - 'SHELL': '/bin/bash', 10:06:19 INFO - 'SHLVL': '1', 10:06:19 INFO - 'TERM': 'linux', 10:06:19 INFO - 'TMOUT': '86400', 10:06:19 INFO - 'USER': 'cltbld', 10:06:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:19 INFO - '_': '/tools/buildbot/bin/python'} 10:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:19 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)) 10:06:19 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)) 10:06:19 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)) 10:06:19 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)) 10:06:19 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)) 10:06:19 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)) 10:06:19 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)) 10:06:19 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)) 10:06:19 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)) 10:06:19 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)) 10:06:19 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)) 10:06:19 INFO - Cleaning up... 10:06:19 INFO - Return code: 0 10:06:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:06:19 INFO - Using env: {'DISPLAY': ':0', 10:06:19 INFO - 'HOME': '/home/cltbld', 10:06:19 INFO - 'LANG': 'en_US.UTF-8', 10:06:19 INFO - 'LANGUAGE': 'en_US:en', 10:06:19 INFO - 'LOGNAME': 'cltbld', 10:06:19 INFO - 'MAIL': '/var/mail/cltbld', 10:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:19 INFO - 'MOZ_NO_REMOTE': '1', 10:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:19 INFO - 'NO_EM_RESTART': '1', 10:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:19 INFO - 'PWD': '/builds/slave/test', 10:06:19 INFO - 'SHELL': '/bin/bash', 10:06:19 INFO - 'SHLVL': '1', 10:06:19 INFO - 'TERM': 'linux', 10:06:19 INFO - 'TMOUT': '86400', 10:06:19 INFO - 'USER': 'cltbld', 10:06:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:19 INFO - '_': '/tools/buildbot/bin/python'} 10:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:19 INFO - Cleaning up... 10:06:19 INFO - Return code: 0 10:06:19 INFO - Running post-action listener: _resource_record_post_action 10:06:19 INFO - Running post-action listener: _start_resource_monitoring 10:06:19 INFO - Starting resource monitoring. 10:06:19 INFO - [mozharness: 2017-02-09 18:06:19.823039Z] Finished create-virtualenv step (success) 10:06:19 INFO - [mozharness: 2017-02-09 18:06:19.823535Z] Running install step. 10:06:19 INFO - Running pre-action listener: _resource_record_pre_action 10:06:19 INFO - Running main action method: install 10:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:20 INFO - Reading from file tmpfile_stdout 10:06:20 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:20 INFO - Reading from file tmpfile_stdout 10:06:20 INFO - Output received: 10:06:20 INFO - Usage: mozinstall [options] installer 10:06:20 INFO - Options: 10:06:20 INFO - -h, --help show this help message and exit 10:06:20 INFO - -d DEST, --destination=DEST 10:06:20 INFO - Directory to install application into. [default: 10:06:20 INFO - "/builds/slave/test"] 10:06:20 INFO - --app=APP Application being installed. [default: firefox] 10:06:20 INFO - mkdir: /builds/slave/test/build/application 10:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:06:36 INFO - Reading from file tmpfile_stdout 10:06:36 INFO - Output received: 10:06:36 INFO - /builds/slave/test/build/application/firefox/firefox 10:06:36 INFO - Running post-action listener: _resource_record_post_action 10:06:36 INFO - [mozharness: 2017-02-09 18:06:36.583286Z] Finished install step (success) 10:06:36 INFO - [mozharness: 2017-02-09 18:06:36.583559Z] Running run-tests step. 10:06:36 INFO - Running pre-action listener: _resource_record_pre_action 10:06:36 INFO - Running main action method: run_tests 10:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:36 INFO - Python 2.7.3 10:06:36 INFO - Return code: 0 10:06:36 INFO - grabbing minidump binary from tooltool 10:06:36 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')]} 10:06:36 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/linux64/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 0xf8e850>, '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 0xf036d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:36 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:06:36 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/linux64/releng.manifest -o -c /builds/tooltool_cache 10:06:36 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:06:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:36 INFO - Return code: 0 10:06:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:06:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:06:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:06:36 INFO - Using env: {'DISPLAY': ':0', 10:06:36 INFO - 'HOME': '/home/cltbld', 10:06:36 INFO - 'LANG': 'en_US.UTF-8', 10:06:36 INFO - 'LANGUAGE': 'en_US:en', 10:06:36 INFO - 'LOGNAME': 'cltbld', 10:06:36 INFO - 'MAIL': '/var/mail/cltbld', 10:06:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:36 INFO - 'MOZ_NO_REMOTE': '1', 10:06:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:36 INFO - 'NO_EM_RESTART': '1', 10:06:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:36 INFO - 'PWD': '/builds/slave/test', 10:06:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:36 INFO - 'SHELL': '/bin/bash', 10:06:36 INFO - 'SHLVL': '1', 10:06:36 INFO - 'TERM': 'linux', 10:06:36 INFO - 'TMOUT': '86400', 10:06:36 INFO - 'USER': 'cltbld', 10:06:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228', 10:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:36 INFO - '_': '/tools/buildbot/bin/python'} 10:06:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:06:36 INFO - mozversion application_buildid: 20170209170225 10:06:36 INFO - mozversion application_changeset: c8eeb0d150df26360bb162db3da74ed686c8bca5 10:06:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:06:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:36 INFO - mozversion application_name: Firefox 10:06:36 INFO - mozversion application_remotingname: firefox-dev 10:06:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:06:36 INFO - mozversion application_vendor: Mozilla 10:06:36 INFO - mozversion application_version: 53.0a2 10:06:36 INFO - mozversion platform_buildid: 20170209170225 10:06:36 INFO - mozversion platform_changeset: c8eeb0d150df26360bb162db3da74ed686c8bca5 10:06:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:06:36 INFO - mozversion platform_version: 53.0a2 10:06:36 INFO - using testdate: 1486663596 10:06:36 INFO - actual date: 1486663596 10:06:36 INFO - starting webserver on 'localhost:50653' 10:06:36 INFO - SUITE-START | Running 2 tests 10:06:36 INFO - TEST-START | dromaeo_css 10:06:36 INFO - operating with platform_type : linux_ 10:06:36 INFO - Initialising browser for dromaeo_css test... 10:06:36 INFO - TEST-INFO | started process 14422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcsvPpv/profile http://localhost:50653/getInfo.html) 10:06:40 INFO - PROCESS | 14422 | __metrics Screen width/height:1600/1200 10:06:40 INFO - PROCESS | 14422 | colorDepth:24 10:06:40 INFO - PROCESS | 14422 | Browser inner width/height: 1024/697 10:06:40 INFO - PROCESS | 14422 | __metrics 10:06:41 INFO - PROCESS | 14422 | 1486663601397 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 10:06:41 INFO - PROCESS | 14422 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:06:41 INFO - PROCESS | 14422 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:42 INFO - TEST-INFO | 14422: exit 0 10:06:42 INFO - Browser initialized. 10:06:42 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:42 INFO - TEST-INFO | started process 14513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcsvPpv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:54 INFO - PROCESS | 14513 | RSS: Main: 138174464 10:06:54 INFO - PROCESS | 14513 | 10:09:54 INFO - PROCESS | 14513 | Cycle 1(1): loaded http://localhost:50653/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50653/tests/dromaeo/cssquery-ext.html) 10:09:55 INFO - PROCESS | 14513 | RSS: Main: 242098176 10:09:55 INFO - PROCESS | 14513 | 10:11:44 INFO - PROCESS | 14513 | ************************* 10:11:44 INFO - PROCESS | 14513 | A coding exception was thrown and uncaught in a Task. 10:11:44 INFO - PROCESS | 14513 | 10:11:44 ERROR - PROCESS | 14513 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:11:44 INFO - PROCESS | 14513 | Full stack: 10:11:44 INFO - PROCESS | 14513 | ************************* 10:12:57 INFO - PROCESS | 14513 | Cycle 1(1): loaded http://localhost:50653/tests/dromaeo/cssquery-ext.html (next: http://localhost:50653/tests/dromaeo/cssquery-jquery.html) 10:12:58 INFO - PROCESS | 14513 | RSS: Main: 223948800 10:12:58 INFO - PROCESS | 14513 | 10:16:00 INFO - PROCESS | 14513 | Cycle 1(1): loaded http://localhost:50653/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50653/tests/dromaeo/cssquery-mootools.html) 10:16:00 INFO - PROCESS | 14513 | RSS: Main: 172572672 10:16:00 INFO - PROCESS | 14513 | 10:19:02 INFO - PROCESS | 14513 | Cycle 1(1): loaded http://localhost:50653/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50653/tests/dromaeo/cssquery-prototype.html) 10:19:03 INFO - PROCESS | 14513 | RSS: Main: 218079232 10:19:03 INFO - PROCESS | 14513 | 10:22:06 INFO - PROCESS | 14513 | Cycle 1(1): loaded http://localhost:50653/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50653/tests/dromaeo/cssquery-yui.html) 10:22:06 INFO - PROCESS | 14513 | RSS: Main: 171716608 10:22:06 INFO - PROCESS | 14513 | 10:25:09 INFO - PROCESS | 14513 | Cycle 1(1): loaded http://localhost:50653/tests/dromaeo/cssquery-yui.html (next: http://localhost:50653/tests/dromaeo/cssquery-dojo.html) 10:25:09 INFO - PROCESS | 14513 | RSS: Main: 263323648 10:25:09 INFO - PROCESS | 14513 | 10:25:09 INFO - PROCESS | 14513 | __start_tp_report 10:25:09 INFO - PROCESS | 14513 | _x_x_mozilla_page_load 10:25:09 INFO - PROCESS | 14513 | _x_x_mozilla_page_load_details 10:25:09 INFO - PROCESS | 14513 | |i|pagename|runs| 10:25:09 INFO - PROCESS | 14513 | |0;dojo.html;3163.3831402876435;3175.968240317596;3182.9840850795745;3196.6643502432244;3234.4986527088295;5429.049916264653;5506.394296627373;5507.228987941681;5516.641418307812;5522.751476183581;5519.254900588429;5550.361708403535;5568.248286481324;5569.275994120769;5583.972080139603;4965.5034496550325;4987.451380348159;5026.597872170236;5028.974855125737;5079.6952182869145;4928.876778080558;5016.49835016499;5063.873403164914;5081.872953176163;5083.923741143886;4912.631552633549;4927.975360123194;4943.728094954776;4987.177115775893;5054.342935418391;5034.09386310464;5059.772310246048;5065.949340506603;5068.341115654941;5095.133827249339;4909.320037258231;4966.677165984235;4974.87562810929;5028.974855125737;5032.892763592004;5354.330708661418;5385.192221166817;5412.431694672042;5466.207399927028;5475.863103422406;5926.170336152942;5926.199963004982;5931.08068249422;5933;5954.166416701665;5924.526037916957;5955.225820643332;5983.640981541122;5985.521158307325;5986.640801551877;5409.918851217235;5431.402545720007;5518.117101263779;5541.861453463655;5567.777288908479;6059.36376680451;6061.939380606137;6063.363346848606;6088.117223002729;6102.664353460514;5788.507976822018;5836.620619659709;5850.180974663551;5852.209951656557;5852.94147058524;5703;5760.0783874579865;5800.042992906123;5937.7921772737745;5943.108533719977;5709.628874123168;5726.742296596663;5776.711164441761;5798.565107616945;5811.041178205549;5807.8093990731795;5809.419058094241;5811.651300921958;5812.7674893003805;5813.09896965971;4449.17690227309;4467.508574056851;4500.594946454835;4504.797284122157;4525.864224073283;4018.557958624549;4046.190761847642;4051.068254301468;4077.5922407758985;4107.691923105779;5734.770609175586;5741.483266506035;5742.799002034909;5743.569232307594;5745;5787.045137552341;5801.01382764931;5844.824655260349;6030.969845150747;6053.182820319289;5608.887822243532;5683;5685.260916080883;5713.74288157034;5718.027935251017;5028.396592408862;5046;5053.9241911371355;5056.039352523009;5085;6033.42682445167;6085.939140608537;6214.627122372672;6277.246730392382;6285.402886725754;5862.472377486047;5921.289445266596;5928.110783382527;5999.820005399845;6029.939700602938;6125.142480052886;6169.753209871555;6176.938230617816;6179.783707570214;6181.81454556364;5649.491545760901;5835.883282334415;5889.617174883619;5900.409959004065;5903.321118071477;5788.942110579009;5878.088896221093;5918.260217472816;5921.970390148022;6028.939710602838;5808.970955145197;5855.473007429352;5858.502027327554;5861.9706901465215;5863.17915491823;5855.2973643163095;5860.062390017577;5861.3845546217035;5864.384239654945;5865.618734782225;5578.219049333015;5608.579356548194;5732.3121225453215;5751.5398768099285;5776.451237132465;5890;5892.734826932712;5897.882042359214;5899.4985426239255;5928.9407105928385;5758.769649213985;5760.94239057604;5761.078227483583;5763.6541807491685;5773.3072031356505 10:25:09 INFO - PROCESS | 14513 | |1;ext.html;553.873384743125;588.2000479348087;621.1676353686062;626.6334194496222;652.5986518291252;37432.25135497292;48378;49562.75218623911;49573.25640115401;49731.50268497309;51636;52013.73993130029;52157;52256.477435225635;52303.738481307635;8510.106438823927;8858.512781796999;9383.483908385037;9581.425114493119;9608.375455595398;11114.444277786119;11425.657230283105;11436.142289328334;11817.527298908033;11838.348890811001;11486.483108260107;11543.480543375568;11563.364014979174;11568.248063875862;11571.247868888495;11404.54381824726;11451.770964580663;11466.48400821965;11476.311421314747;11489.368084755377;11252.324860508395;11334.093272538177;11336.093112551058;11339.14956378275;11392.145589080852;48528.75735621299;48843;48871.26693099606;48899;48929.510704892855;4530.116627257686;4577.427821522309;4633.25867861144;4695.835645752382;4732.668713190078;35168.824155879316;35529.82235088834;35860.46209306862;35929.46105808415;36993.26013479715;4673.135469938073;4696.201645720235;4719.740414277213;4742.50203728607;4773.594244489223;380806;381554;381796;382097;383661;69090.65454672795;69817;70135;70220;70351;73537.63231183917;73593;73638.26361736421;73651;73728;17166.22751976164;17182.914085429493;17246.655066898842;17720.025398602942;17725.29098836058;12324.198927069712;12463.937680311541;12472.937635311946;12753.553625623059;12814.487420503076;19136.712949305773;19294.32469863548;19431.708524372145;19464.31874884372;19489.22043118288;6575.671216439159;6620.205575330991;6636.469082473391;6674.833129171712;6744.898826517606;1016.3139880580578;1017.6641708236265;1019.6227395863579;1022.3610243597751;1026.5175367577376;33472.72410097929;34132.317353653285;34436.31127377439;34513.30973380568;34785.478217826756;1113.8496302998992;1115.9944200278946;1153.1812413186565;1153.2792004996877;1155.1278784517635;17349.826501735075;18489;18563.978981156168;18698.532536686693;18723.719144212846;493603;495045;496035;496676;496699;68425;69032;69241;69330.30669693238;69337.30662693409;1528.098421931066;1528.4497580870877;1575.9763603545955;1578.2187817030642;1589.4436947068664;32315.35369292648;33608;33855.322893542485;34012.48981265332;34137.217248173576;58199;59047.40952590419;59048.70475647594;59067.70466147642;59149.70425148019;393493;396140;396708;396923;397489;37522.624773751915;37784.24431511409;42874;44340.11319773651;45330.54669453395;53336.46663533315;53388.64733336098;54142;54214.728926355114;54956.450435495135;44421.11157776891;44455;45263.54736452593;45723;46143.07713845772;43361;43973;44231.53335717438;44957.55042449533;45453.772731137455;44076.33885491656;44793.77603111963;45634;45643.77178114088;45909.77045114753;36542;38753.4186987201;39059.80470097631;39590.208195835345;39635;28375.858120709265;28440.715592843808;28655.880212539403;28947;29150.12549623515 10:25:09 INFO - PROCESS | 14513 | |2;jquery.html;436.84710351377043;440.7884215576523;441.6334442412798;444.4710794154955;456.44541881613856;20584.279550215746;21048.789512104893;22438.439039024033;22562.661560076613;22568.322950311474;22643.433914152156;23467.178648747296;23485.41286467839;23577.292681219547;23767.76232237677;5992.64044157352;6032.065029920358;6211.223597050369;6268.811935641938;6278.4035516625845;5979.970100149493;6031.24609423822;6069.635821850681;6070.725147718962;6075.0887366895095;5863.706814659271;6007.279126504804;6015.308239552463;6023.30731965823;6073.696315184246;6103.511719062464;6143.569950103494;6147.2008638877105;6151.7231724572275;6154.661493617849;5467.988422141877;5486.561075113981;5521.696306703129;5524.309461317335;5526.032944234743;25963.22110336693;26044;26100.738992610022;26207.868960655265;26349.20952371432;3260.10347154532;3353.8826141085187;3369.073504786179;3444.4144495435585;3446.327966046622;13479.797803032963;15385.307661155162;15798.289076991563;16025.839741602551;16513.66972660552;2037;2037.276766747798;2038.4801875521648;2038.6534289170877;2041.4181958141858;91663;93528;93632;94081;94100.05899940981;11385.487653055632;11576.131790115607;11734.295942243321;11833.585824496273;11914.344711040976;16512.431319024912;16539.50381488557;16540.75188872168;16544.6691066178;16545.420910268083;8531.596065791284;8901.777455563662;8995.955020224857;9087.681931132378;9203.079692030877;8653.221210090996;8718.258947989492;8725.607347669244;8954.552272386354;8969.686060987835;7397.704091836374;7648.464607477423;7715.421343399155;7735.845283094307;7757.301842834172;2086.7182930304516;2107.841911856586;2108.978910210909;2129.829613630906;2147.9248226312316;976.5849513956682;979.2361957673027;986.5856340337076;988.0761488008735;991.2317953586029;20611.896940515202;21324.360269191948;21810.563788724136;21957.67063494049;22889.542209156058;1047.2669131607904;1065.824139017069;1076.9246152769388;1083.2525557365393;1089.967300980972;11061.612843550438;11121.944390277997;11224.607138750267;11231.10151187903;11263.60577379804;664593;683679;705088;720556;731743;114375;115740;116014.41992790152;116301;118163.40918295525;1183.1599564309265;1209.2623499665197;1225.993870030662;1229.661842993184;1231.950721971111;17182;17391.608601333122;17560.73658895092;17680.91159544194;17910.104494774947;45622.31566526438;45952.31071533997;46410.07179856316;46520.53479465297;47771;62078.37921620726;62470.687646563296;62491.687541562;63112.684436577525;64233.67883160741;9011.459312441275;9092.818143636958;9165.083491650781;9328.860067099135;9653.806923861343;13149.671258218239;14165.220912849893;14284.57146285613;14367.13797172173;14522.056066355653;6887.931120688729;11582.536698531965;12175.878241217828;12263.632091037283;12588.811167832308;11808.11439142085;12001.393658852361;12065.939670301592;12226.388680566113;12317;12276;12435.564755233523;12535.122541422013;12553.246805191719;12789.296588687712;7693.692252310068;8301.377396695392;8432.957835210786;8568.742937711879;9468.053194680753;9588.424694518351;12101.636950891487;12534.749305014031;12569.434375452944;12893.419796109385 10:25:09 INFO - PROCESS | 14513 | |3;mootools.html;1452.0416525093426;1519.2859356102636;1526.7175572519084;1539.168848821637;1549.9302531386086;7918.841623167533;8350.540720260391;8602.698905538307;8612.655493780248;8798.824023519526;8612.267957223643;8669.696560620363;8678.696245631389;8685.782855428617;8713.041565427813;2137.732783402075;2200.680901269315;2405.338531903723;2446.889889954947;2451.669024681672;2401.795847352977;2499.5375855466796;2499.7125330587032;2512.9120480783176;2523.974760252392;2467.3091534370315;2476.19523654812;2487.2040946897;2494.0397946790436;2494.9126780562683;2475.8638274894874;2477.962830557543;2490.3649569359877;2496.8252222344445;2500.499900020003;2278.4417817634785;2306.5156317173414;2312.4681323295736;2313.4447732544236;2316.200910685811;8992.370534062618;9064.410813297114;9070.909290907073;9096.090390960851;9102.81794364109;5375.354957405098;5499.752511137009;5512.972435137799;5526.419725928759;5528.226048353234;3313.4698448248405;3419.281950790337;3593.6765691087667;3639.0720366306423;3643.890683279506;1466.7359875222455;1491.6643755155003;1505.631120375504;1528.8700460460764;1594.5614955887108;12356.938215308955;12376.319302438362;12389.380530973416;12390.070744694183;12400.56598019074;4467.01725620363;4628.703962890396;4638.327442520883;4642.117997580449;4650.651201159926;10669.893301067044;10673;10686.14510839131;10695.197860160364;10700.625478108384;5379.67721936685;5383.2194331821665;5390.460953904578;5393.056215162409;5396.406395296514;4513.661475389359;4657.068586282757;4987.301777751118;5017.37282839645;5076.13705670037;3911.9022024449046;3947.3289540778137;4036.1120553478186;4041.8383264669083;4042.959570404317;1159.3189874681746;1169.6841852699724;1169.6900321414662;1171.1626187276138;1178.634623266773;908.513945039414;925.6760133953062;927.9211267042242;938.863864739609;946.5456580841235;5939.910901336483;5948.226730525004;6021.217241758631;6145.324014358417;6232.065190221503;1061.686802393296;1090.8527348807968;1091.1543553745753;1095.1786160379716;1107.645553422913;4138.544760076389;4310.7629080400875;4318.654507639381;4322.502912165079;4327.091310824762;10563;10889.128869690407;10926.945365273123;10935.343879367263;10951.178661600252;10647.84028239577;10760.946195268974;10820.67537973862;10843.891561084289;10858.619948301772;7907.446478746548;8015.438919275712;8037.23646253605;8379.622916968628;8383.874241886377;5929.229200203946;6026.186464827192;6034.034554471439;6045.304789949212;6127.693615319127;9640.084192001748;9734.464604446823;9746.220302375652;9749.122578967927;9815.871174814702;9767.072128147815;9769.169620582046;9849.261305402268;9947.104760571583;9985.800283994135;7136.607486588287;7395.408367330493;7771.689132434639;7892.486988345969;7930.643121059451;8039.557824319719;8348.958255208685;8350.62422191015;8553.358498112791;8564.52895090776;7546.735864244725;7693.807654808675;7695.076590809139;7719.4210434218785;7811.2188781123705;7558.962205188939;7589.013428254291;7611.733589324347;7660.463767536219;7669.309762121436;6385.265694445198;6503.219613646393;6507.544471886922;6520.641364724986;6571.737130514726;5212.322398088224;5271.630985831109;5283.603729720363;5343.973280133574;5373.785048598169;5309.522143007148;5323.148296272578;5365.517103460551;5373.462653734595;5398.217258497417 10:25:09 INFO - PROCESS | 14513 | |4;prototype.html;391.4089724515982;409.3041828890886;410.73712823792766;412.41025333772694;413.49553544675496;5363.4904684055045;5368.785248590057;5408.783648654059;5414.675119492833;5424.538914192289;5036.798528058874;5082.136036873731;5152;5157.896842063156;5357.223202635615;4245.787710614472;4267.23189825832;4272.487301523806;4282.443282373287;4287.277578737493;4267.829286828539;4273.807678654468;4282.74303541787;4304.203722311367;4304.483461984566;4035.9798201008953;4076.9184616307657;4242.97878510607;4273.40172375866;4279.529251782302;4236.237477254093;4258.552851950562;4259.91480170398;4286.9999999999845;4311.5472875348105;3862.9227415451815;3873.205992771503;3873.4189871519216;3884.708646851469;3886.689064874803;5202.843914682528;5254.605904557136;5266.131088370415;5269.262303277545;5304.310439642822;4913.869809943697;4954.628402869763;4975.109458405819;4998.850034498971;5009.323741294915;5602.691851948141;5617.887642247173;5652.406497317764;5653.1520271959125;5659.7453114609525;4196.307609244471;4246.617804397588;4306.074194048263;4314.654827613784;4321.632661223768;5791.884162316772;5804.448577385142;5804.546294954495;5806.912896306559;5808.82573522795;4448.332750087448;4475.440569928759;4497.2129877271345;4501.122281155143;4503.437070366204;4439.801253661493;4442.622377097919;4447.466304043471;4453.643708503312;4544.454665440168;4909.140900342426;4914.262860570943;4918.139325618003;4919.171476401084;4943.777530011158;5646.971765141148;5666.235058267163;5672.794870897929;5673.404292549306;5689.231953686282;1467.3763650448516;1497.0867770659888;1510.8262549806693;1511.3954418232574;1525.1306755149458;998.9500524973722;1017.704865588971;1074.8441475985937;1091.1052936591918;1111.155521803419;5306.681599104066;5310.840674779763;5320.281761962163;5369.40936496985;5412.998595259811;5526.47498487643;5583.162525621108;5627.380988091307;5663.178839068312;5677.744501497443;5070.543651071347;5252.684838909678;5257.658252213594;5279.656822306538;5289.153735402394;2950.7721670139335;2953.6012638293987;2959.0235222376564;2963.155500682295;2988.4023195361015;5636.2391077204875;5750.827475175752;5811.506021988178;5812.529674888156;5959.642421454727;5882.735276912549;5883.911741323884;5890.8821823563285;5914.817036592613;5932.970335148297;5939;5939.346671866091;5984.611000284967;5990.251218597676;6007.939920600738;5564.276644036249;5709.628874123168;5716.342620598684;5753.482186603226;5780.30636323627;5717.685527296038;5729.2265544151005;5747.310322761128;5752.539796816328;5764.308283005898;5863.442972917566;5890.793822216202;5936.436038576501;6018.548608854266;6032.155498230163;4232.703710740218;4257.594993652149;4261.680373971903;4266.850660226877;4269.338252570857;5846.6673995821975;5847.8538036547725;5884.529237660891;5886.146508756121;5902.4097590240635;5638.23883775685;5686.374498805211;5711.200431939449;5724.685142317046;5768.08711600639;5657.717114144194;5697.151424287856;5698.544116470755;5704.828855134353;5720.227769251264;5457.918131228114;5484;5575.303087114111;5681;5728.226689396878;5650.502616806467;5652.491275785199;5701.7149142541875;5705.7432415542235;5711.8000869969355;5373.650712703662;5542.418046105101;5543.223948647274;5546.667199968015;5607.775688972395 10:25:09 INFO - PROCESS | 14513 | |5;yui.html;823.9093699693033;842.3892677808585;859.0464584311413;916.7112359606723;939.638239277878;15218;16098.436554720587;17288.049157296344;17482.56293592661;17548.736768948474;14698.559043228694;14729.337179826907;16560.50318490447;17175.312987480487;17252.39616613419;840.3907167303717;857.3869683176528;857.6312185760152;857.7426771968416;858.3090612057291;697.898804673322;712.3731116617396;712.6614857942487;713.8108401273666;848.0332421040019;846.7417437681505;869.7564681889081;878.666106879385;884.0805562215321;884.3455842676406;866.2420382165606;867.2238346679718;868.0278088540844;868.1492137705021;869.0570730757136;546.4999525434223;555.9249501317352;634.9523785716044;635.0188958059808;635.726637545855;15455.30451129702;16050.919745401316;16051.357945682159;16870.746938795804;16892.662146756997;16017.439389621424;16183.786216033726;16224.756628650463;16369.59076023097;16386.426475073433;12980.870191298061;13262.53581124656;13267.203967761869;13328.400221989938;13459.798103028463;4039.7374170678813;4077.2660921034203;4083.530394004698;4144.44050053242;4151.83392664293;82714.21692488722;83261;83436;85367;86764;12455.494778717057;12522.74954500923;12526.248425094524;12554.560590379293;12741.55404560836;23978.52042959131;24028.87985560061;24031.759682402953;24109;24314.87842560776;8442.57787110642;8538.743837684879;8586.87119693205;8635.568221588896;8776.385653004356;4503.954960450354;4540.318952157137;4609.608183304456;4614.100250451197;4637.86086417408;3722.088088418355;3755.455458958436;3817.4655548223272;3835;3837.194189220239;649.2468736265909;650.1353200243759;658.2002866517109;662.7216569041015;667.6061123936901;683.2381894187945;698.6646409723361;708.7129712466459;712.508369225233;718.3606590134784;11109.72225694348;11286.266392684449;11761;11914.16600837933;12094.455749491119;849.3120572336427;857.8541647919868;870.734426000076;872.7861673889938;881.3213825354442;5511.559075273968;5655.80204692842;5729.1119876419225;5758.74085666146;5766.711664416763;77976.22023779803;85212;85982.57008715041;87149;87407;58424;61156.694216529526;66729.6663516689;75482.84844333614;76496;66609.6669516659;67018.66490667516;68259.3174068253;69029.30970690229;69559.65220173867;10610.89389106099;10880.075193608633;10974.286671366335;11007.449627518432;11165.995060444598;46202.76898615486;46942.29586556136;47006.76496617632;47850.5214947846;48523.5147648519;49730.751346243036;51181.7440912793;55624;57385;57993;14445.133292002092;14783.113013219241;14926.626834329229;15024.849751502345;15058.32237549291;15604.765928510855;16270.105144216708;16330.101844398672;16469.505914822574;16579.834201657828;15837.920810395874;16039.198040098181;16150.838491614933;16240;16944.661106778043;14970.40118395252;15122;15210.391584336945;15432.614184645474;16989.660206795546;13841;14674.486392976194;15415.691686166438;15472;15640.374385024472;11997.160198786001;12217.266963982189;12526.37368131608;12705.618831435071;12802.551910683082;12513.124081314585;12592.181508201938;12806;12818.743625127632;12833.230006199658 10:25:09 INFO - PROCESS | 14513 | __end_tp_report 10:25:09 INFO - PROCESS | 14513 | __start_cc_report 10:25:09 INFO - PROCESS | 14513 | _x_x_mozilla_cycle_collect,939 10:25:09 INFO - PROCESS | 14513 | __end_cc_report 10:25:09 INFO - PROCESS | 14513 | __startTimestamp1486664709469__endTimestamp 10:25:09 INFO - PROCESS | 14513 | 10:25:09 INFO - PROCESS | 14513 | ------- Summary: start ------- 10:25:09 INFO - PROCESS | 14513 | Number of tests: 6 10:25:09 INFO - PROCESS | 14513 | 10:25:09 INFO - PROCESS | 14513 | [#0] dojo.html Cycles:165 Average:5499.19 Median:5751.54 stddev:634.30 (11.0%) stddev-sans-first:609.20 10:25:09 INFO - PROCESS | 14513 | Values: 3163.4 3176.0 3183.0 3196.7 3234.5 5429.0 5506.4 5507.2 5516.6 5522.8 5519.3 5550.4 5568.2 5569.3 5584.0 4965.5 4987.5 5026.6 5029.0 5079.7 4928.9 5016.5 5063.9 5081.9 5083.9 4912.6 4928.0 4943.7 4987.2 5054.3 5034.1 5059.8 5065.9 5068.3 5095.1 4909.3 4966.7 4974.9 5029.0 5032.9 5354.3 5385.2 5412.4 5466.2 5475.9 5926.2 5926.2 5931.1 5933.0 5954.2 5924.5 5955.2 5983.6 5985.5 5986.6 5409.9 5431.4 5518.1 5541.9 5567.8 6059.4 6061.9 6063.4 6088.1 6102.7 5788.5 5836.6 5850.2 5852.2 5852.9 5703.0 5760.1 5800.0 5937.8 5943.1 5709.6 5726.7 5776.7 5798.6 5811.0 5807.8 5809.4 5811.7 5812.8 5813.1 4449.2 4467.5 4500.6 4504.8 4525.9 4018.6 4046.2 4051.1 4077.6 4107.7 5734.8 5741.5 5742.8 5743.6 5745.0 5787.0 5801.0 5844.8 6031.0 6053.2 5608.9 5683.0 5685.3 5713.7 5718.0 5028.4 5046.0 5053.9 5056.0 5085.0 6033.4 6085.9 6214.6 6277.2 6285.4 5862.5 5921.3 5928.1 5999.8 6029.9 6125.1 6169.8 6176.9 6179.8 6181.8 5649.5 5835.9 5889.6 5900.4 5903.3 5788.9 5878.1 5918.3 5922.0 6028.9 5809.0 5855.5 5858.5 5862.0 5863.2 5855.3 5860.1 5861.4 5864.4 5865.6 5578.2 5608.6 5732.3 5751.5 5776.5 5890.0 5892.7 5897.9 5899.5 5928.9 5758.8 5760.9 5761.1 5763.7 5773.3 10:25:09 INFO - PROCESS | 14513 | 10:25:09 INFO - PROCESS | 14513 | [#1] ext.html Cycles:180 Average:62159.64 Median:396815.50 stddev:112583.33 (28.4%) stddev-sans-first:112804.13 10:25:09 INFO - PROCESS | 14513 | Values: 553.9 588.2 621.2 626.6 652.6 37432.3 48378.0 49562.8 49573.3 49731.5 51636.0 52013.7 52157.0 52256.5 52303.7 8510.1 8858.5 9383.5 9581.4 9608.4 11114.4 11425.7 11436.1 11817.5 11838.3 11486.5 11543.5 11563.4 11568.2 11571.2 11404.5 11451.8 11466.5 11476.3 11489.4 11252.3 11334.1 11336.1 11339.1 11392.1 48528.8 48843.0 48871.3 48899.0 48929.5 4530.1 4577.4 4633.3 4695.8 4732.7 35168.8 35529.8 35860.5 35929.5 36993.3 4673.1 4696.2 4719.7 4742.5 4773.6 380806.0 381554.0 381796.0 382097.0 383661.0 69090.7 69817.0 70135.0 70220.0 70351.0 73537.6 73593.0 73638.3 73651.0 73728.0 17166.2 17182.9 17246.7 17720.0 17725.3 12324.2 12463.9 12472.9 12753.6 12814.5 19136.7 19294.3 19431.7 19464.3 19489.2 6575.7 6620.2 6636.5 6674.8 6744.9 1016.3 1017.7 1019.6 1022.4 1026.5 33472.7 34132.3 34436.3 34513.3 34785.5 1113.8 1116.0 1153.2 1153.3 1155.1 17349.8 18489.0 18564.0 18698.5 18723.7 493603.0 495045.0 496035.0 496676.0 496699.0 68425.0 69032.0 69241.0 69330.3 69337.3 1528.1 1528.4 1576.0 1578.2 1589.4 32315.4 33608.0 33855.3 34012.5 34137.2 58199.0 59047.4 59048.7 59067.7 59149.7 393493.0 396140.0 396708.0 396923.0 397489.0 37522.6 37784.2 42874.0 44340.1 45330.5 53336.5 53388.6 54142.0 54214.7 54956.5 44421.1 44455.0 45263.5 45723.0 46143.1 43361.0 43973.0 44231.5 44957.6 45453.8 44076.3 44793.8 45634.0 45643.8 45909.8 36542.0 38753.4 39059.8 39590.2 39635.0 28375.9 28440.7 28655.9 28947.0 29150.1 10:25:09 INFO - PROCESS | 14513 | 10:25:09 INFO - PROCESS | 14513 | [#2] jquery.html Cycles:180 Average:36984.06 Median:26154.30 stddev:115293.30 (440.8%) stddev-sans-first:115584.07 10:25:09 INFO - PROCESS | 14513 | Values: 436.8 440.8 441.6 444.5 456.4 20584.3 21048.8 22438.4 22562.7 22568.3 22643.4 23467.2 23485.4 23577.3 23767.8 5992.6 6032.1 6211.2 6268.8 6278.4 5980.0 6031.2 6069.6 6070.7 6075.1 5863.7 6007.3 6015.3 6023.3 6073.7 6103.5 6143.6 6147.2 6151.7 6154.7 5468.0 5486.6 5521.7 5524.3 5526.0 25963.2 26044.0 26100.7 26207.9 26349.2 3260.1 3353.9 3369.1 3444.4 3446.3 13479.8 15385.3 15798.3 16025.8 16513.7 2037.0 2037.3 2038.5 2038.7 2041.4 91663.0 93528.0 93632.0 94081.0 94100.1 11385.5 11576.1 11734.3 11833.6 11914.3 16512.4 16539.5 16540.8 16544.7 16545.4 8531.6 8901.8 8996.0 9087.7 9203.1 8653.2 8718.3 8725.6 8954.6 8969.7 7397.7 7648.5 7715.4 7735.8 7757.3 2086.7 2107.8 2109.0 2129.8 2147.9 976.6 979.2 986.6 988.1 991.2 20611.9 21324.4 21810.6 21957.7 22889.5 1047.3 1065.8 1076.9 1083.3 1090.0 11061.6 11121.9 11224.6 11231.1 11263.6 664593.0 683679.0 705088.0 720556.0 731743.0 114375.0 115740.0 116014.4 116301.0 118163.4 1183.2 1209.3 1226.0 1229.7 1232.0 17182.0 17391.6 17560.7 17680.9 17910.1 45622.3 45952.3 46410.1 46520.5 47771.0 62078.4 62470.7 62491.7 63112.7 64233.7 9011.5 9092.8 9165.1 9328.9 9653.8 13149.7 14165.2 14284.6 14367.1 14522.1 6887.9 11582.5 12175.9 12263.6 12588.8 11808.1 12001.4 12065.9 12226.4 12317.0 12276.0 12435.6 12535.1 12553.2 12789.3 7693.7 8301.4 8433.0 8568.7 9468.1 9588.4 12101.6 12534.7 12569.4 12893.4 10:25:09 INFO - PROCESS | 14513 | 10:25:09 INFO - PROCESS | 14513 | [#3] mootools.html Cycles:180 Average:5823.46 Median:5241.98 stddev:3232.01 (61.7%) stddev-sans-first:3224.38 10:25:09 INFO - PROCESS | 14513 | Values: 1452.0 1519.3 1526.7 1539.2 1549.9 7918.8 8350.5 8602.7 8612.7 8798.8 8612.3 8669.7 8678.7 8685.8 8713.0 2137.7 2200.7 2405.3 2446.9 2451.7 2401.8 2499.5 2499.7 2512.9 2524.0 2467.3 2476.2 2487.2 2494.0 2494.9 2475.9 2478.0 2490.4 2496.8 2500.5 2278.4 2306.5 2312.5 2313.4 2316.2 8992.4 9064.4 9070.9 9096.1 9102.8 5375.4 5499.8 5513.0 5526.4 5528.2 3313.5 3419.3 3593.7 3639.1 3643.9 1466.7 1491.7 1505.6 1528.9 1594.6 12356.9 12376.3 12389.4 12390.1 12400.6 4467.0 4628.7 4638.3 4642.1 4650.7 10669.9 10673.0 10686.1 10695.2 10700.6 5379.7 5383.2 5390.5 5393.1 5396.4 4513.7 4657.1 4987.3 5017.4 5076.1 3911.9 3947.3 4036.1 4041.8 4043.0 1159.3 1169.7 1169.7 1171.2 1178.6 908.5 925.7 927.9 938.9 946.5 5939.9 5948.2 6021.2 6145.3 6232.1 1061.7 1090.9 1091.2 1095.2 1107.6 4138.5 4310.8 4318.7 4322.5 4327.1 10563.0 10889.1 10926.9 10935.3 10951.2 10647.8 10760.9 10820.7 10843.9 10858.6 7907.4 8015.4 8037.2 8379.6 8383.9 5929.2 6026.2 6034.0 6045.3 6127.7 9640.1 9734.5 9746.2 9749.1 9815.9 9767.1 9769.2 9849.3 9947.1 9985.8 7136.6 7395.4 7771.7 7892.5 7930.6 8039.6 8349.0 8350.6 8553.4 8564.5 7546.7 7693.8 7695.1 7719.4 7811.2 7559.0 7589.0 7611.7 7660.5 7669.3 6385.3 6503.2 6507.5 6520.6 6571.7 5212.3 5271.6 5283.6 5344.0 5373.8 5309.5 5323.1 5365.5 5373.5 5398.2 10:25:09 INFO - PROCESS | 14513 | 10:25:09 INFO - PROCESS | 14513 | [#4] prototype.html Cycles:180 Average:4789.92 Median:5338.75 stddev:1358.89 (25.5%) stddev-sans-first:1321.99 10:25:09 INFO - PROCESS | 14513 | Values: 391.4 409.3 410.7 412.4 413.5 5363.5 5368.8 5408.8 5414.7 5424.5 5036.8 5082.1 5152.0 5157.9 5357.2 4245.8 4267.2 4272.5 4282.4 4287.3 4267.8 4273.8 4282.7 4304.2 4304.5 4036.0 4076.9 4243.0 4273.4 4279.5 4236.2 4258.6 4259.9 4287.0 4311.5 3862.9 3873.2 3873.4 3884.7 3886.7 5202.8 5254.6 5266.1 5269.3 5304.3 4913.9 4954.6 4975.1 4998.9 5009.3 5602.7 5617.9 5652.4 5653.2 5659.7 4196.3 4246.6 4306.1 4314.7 4321.6 5791.9 5804.4 5804.5 5806.9 5808.8 4448.3 4475.4 4497.2 4501.1 4503.4 4439.8 4442.6 4447.5 4453.6 4544.5 4909.1 4914.3 4918.1 4919.2 4943.8 5647.0 5666.2 5672.8 5673.4 5689.2 1467.4 1497.1 1510.8 1511.4 1525.1 999.0 1017.7 1074.8 1091.1 1111.2 5306.7 5310.8 5320.3 5369.4 5413.0 5526.5 5583.2 5627.4 5663.2 5677.7 5070.5 5252.7 5257.7 5279.7 5289.2 2950.8 2953.6 2959.0 2963.2 2988.4 5636.2 5750.8 5811.5 5812.5 5959.6 5882.7 5883.9 5890.9 5914.8 5933.0 5939.0 5939.3 5984.6 5990.3 6007.9 5564.3 5709.6 5716.3 5753.5 5780.3 5717.7 5729.2 5747.3 5752.5 5764.3 5863.4 5890.8 5936.4 6018.5 6032.2 4232.7 4257.6 4261.7 4266.9 4269.3 5846.7 5847.9 5884.5 5886.1 5902.4 5638.2 5686.4 5711.2 5724.7 5768.1 5657.7 5697.2 5698.5 5704.8 5720.2 5457.9 5484.0 5575.3 5681.0 5728.2 5650.5 5652.5 5701.7 5705.7 5711.8 5373.7 5542.4 5543.2 5546.7 5607.8 10:25:09 INFO - PROCESS | 14513 | 10:25:09 INFO - PROCESS | 14513 | [#5] yui.html Cycles:180 Average:18920.25 Median:4522.14 stddev:23534.57 (520.4%) stddev-sans-first:23561.36 10:25:09 INFO - PROCESS | 14513 | Values: 823.9 842.4 859.0 916.7 939.6 15218.0 16098.4 17288.0 17482.6 17548.7 14698.6 14729.3 16560.5 17175.3 17252.4 840.4 857.4 857.6 857.7 858.3 697.9 712.4 712.7 713.8 848.0 846.7 869.8 878.7 884.1 884.3 866.2 867.2 868.0 868.1 869.1 546.5 555.9 635.0 635.0 635.7 15455.3 16050.9 16051.4 16870.7 16892.7 16017.4 16183.8 16224.8 16369.6 16386.4 12980.9 13262.5 13267.2 13328.4 13459.8 4039.7 4077.3 4083.5 4144.4 4151.8 82714.2 83261.0 83436.0 85367.0 86764.0 12455.5 12522.7 12526.2 12554.6 12741.6 23978.5 24028.9 24031.8 24109.0 24314.9 8442.6 8538.7 8586.9 8635.6 8776.4 4504.0 4540.3 4609.6 4614.1 4637.9 3722.1 3755.5 3817.5 3835.0 3837.2 649.2 650.1 658.2 662.7 667.6 683.2 698.7 708.7 712.5 718.4 11109.7 11286.3 11761.0 11914.2 12094.5 849.3 857.9 870.7 872.8 881.3 5511.6 5655.8 5729.1 5758.7 5766.7 77976.2 85212.0 85982.6 87149.0 87407.0 58424.0 61156.7 66729.7 75482.8 76496.0 66609.7 67018.7 68259.3 69029.3 69559.7 10610.9 10880.1 10974.3 11007.4 11166.0 46202.8 46942.3 47006.8 47850.5 48523.5 49730.8 51181.7 55624.0 57385.0 57993.0 14445.1 14783.1 14926.6 15024.8 15058.3 15604.8 16270.1 16330.1 16469.5 16579.8 15837.9 16039.2 16150.8 16240.0 16944.7 14970.4 15122.0 15210.4 15432.6 16989.7 13841.0 14674.5 15415.7 15472.0 15640.4 11997.2 12217.3 12526.4 12705.6 12802.6 12513.1 12592.2 12806.0 12818.7 12833.2 10:25:09 INFO - PROCESS | 14513 | -------- Summary: end -------- 10:25:09 INFO - PROCESS | 14513 | 10:25:10 INFO - TEST-INFO | 14513: exit 0 10:25:10 INFO - TEST-OK | dromaeo_css | took 1113399ms 10:25:10 INFO - TEST-START | kraken 10:25:10 INFO - operating with platform_type : linux_ 10:25:10 INFO - Initialising browser for kraken test... 10:25:10 INFO - TEST-INFO | started process 14834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4Xoyy/profile http://localhost:50653/getInfo.html) 10:25:14 INFO - PROCESS | 14834 | __metrics Screen width/height:1600/1200 10:25:14 INFO - PROCESS | 14834 | colorDepth:24 10:25:14 INFO - PROCESS | 14834 | Browser inner width/height: 1024/697 10:25:14 INFO - PROCESS | 14834 | __metrics 10:25:14 INFO - PROCESS | 14834 | 1486664714906 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 10:25:15 INFO - PROCESS | 14834 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:25:15 INFO - PROCESS | 14834 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:15 INFO - TEST-INFO | 14834: exit 0 10:25:15 INFO - Browser initialized. 10:25:15 INFO - Running cycle 1/1 for kraken test... 10:25:15 INFO - TEST-INFO | started process 14924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4Xoyy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:28 INFO - PROCESS | 14924 | RSS: Main: 138248192 10:25:28 INFO - PROCESS | 14924 | 10:25:30 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50653/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:31 INFO - PROCESS | 14924 | RSS: Main: 181981184 10:25:31 INFO - PROCESS | 14924 | 10:25:33 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50653/tests/kraken/driver.html?testName=audio-dft) 10:25:34 INFO - PROCESS | 14924 | RSS: Main: 172716032 10:25:34 INFO - PROCESS | 14924 | 10:25:37 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50653/tests/kraken/driver.html?testName=audio-fft) 10:25:37 INFO - PROCESS | 14924 | RSS: Main: 263434240 10:25:37 INFO - PROCESS | 14924 | 10:25:39 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50653/tests/kraken/driver.html?testName=audio-oscillator) 10:25:40 INFO - PROCESS | 14924 | RSS: Main: 170643456 10:25:40 INFO - PROCESS | 14924 | 10:25:42 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50653/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:43 INFO - PROCESS | 14924 | RSS: Main: 172720128 10:25:43 INFO - PROCESS | 14924 | 10:25:46 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50653/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:46 INFO - PROCESS | 14924 | RSS: Main: 211771392 10:25:46 INFO - PROCESS | 14924 | 10:25:50 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50653/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:50 INFO - PROCESS | 14924 | RSS: Main: 210448384 10:25:50 INFO - PROCESS | 14924 | 10:25:53 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50653/tests/kraken/driver.html?testName=json-parse-financial) 10:25:54 INFO - PROCESS | 14924 | RSS: Main: 208625664 10:25:54 INFO - PROCESS | 14924 | 10:25:55 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50653/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:56 INFO - PROCESS | 14924 | RSS: Main: 170811392 10:25:56 INFO - PROCESS | 14924 | 10:25:57 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50653/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:58 INFO - PROCESS | 14924 | RSS: Main: 177942528 10:25:58 INFO - PROCESS | 14924 | 10:26:00 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50653/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:01 INFO - PROCESS | 14924 | RSS: Main: 186912768 10:26:01 INFO - PROCESS | 14924 | 10:26:03 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:04 INFO - PROCESS | 14924 | RSS: Main: 197046272 10:26:04 INFO - PROCESS | 14924 | 10:26:07 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:07 INFO - PROCESS | 14924 | RSS: Main: 192946176 10:26:07 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | Cycle 1(1): loaded http://localhost:50653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50653/tests/kraken/driver.html?testName=ai-astar) 10:26:09 INFO - PROCESS | 14924 | RSS: Main: 244273152 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | __start_tp_report 10:26:09 INFO - PROCESS | 14924 | _x_x_mozilla_page_load 10:26:09 INFO - PROCESS | 14924 | _x_x_mozilla_page_load_details 10:26:09 INFO - PROCESS | 14924 | |i|pagename|runs| 10:26:09 INFO - PROCESS | 14924 | |0;ai-astar;112;112;113;111;112;111;111;109;112;112 10:26:09 INFO - PROCESS | 14924 | |1;audio-beat-detection;144;116;124;153;118;118;124;122;136;118 10:26:09 INFO - PROCESS | 14924 | |2;audio-dft;160;159;160;160;160;160;160;160;159;160 10:26:09 INFO - PROCESS | 14924 | |3;audio-fft;75;74;76;105;77;76;74;75;98;76 10:26:09 INFO - PROCESS | 14924 | |4;audio-oscillator;83;82;107;83;82;83;94;82;82;109 10:26:09 INFO - PROCESS | 14924 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;116;117;117 10:26:09 INFO - PROCESS | 14924 | |6;imaging-darkroom;147;147;145;146;146;146;145;146;146;147 10:26:09 INFO - PROCESS | 14924 | |7;imaging-desaturate;96;96;96;96;95;95;96;96;96;96 10:26:09 INFO - PROCESS | 14924 | |8;json-parse-financial;56;48;49;48;49;50;50;49;50;50 10:26:09 INFO - PROCESS | 14924 | |9;json-stringify-tinderbox;64;64;64;64;64;63;64;64;65;63 10:26:09 INFO - PROCESS | 14924 | |10;stanford-crypto-aes;76;76;75;77;83;75;76;76;83;83 10:26:09 INFO - PROCESS | 14924 | |11;stanford-crypto-ccm;125;128;120;130;121;124;119;120;157;123 10:26:09 INFO - PROCESS | 14924 | |12;stanford-crypto-pbkdf2;157;156;159;163;162;161;159;156;156;157 10:26:09 INFO - PROCESS | 14924 | |13;stanford-crypto-sha256-iterative;61;60;60;60;60;60;59;60;59;58 10:26:09 INFO - PROCESS | 14924 | __end_tp_report 10:26:09 INFO - PROCESS | 14924 | __start_cc_report 10:26:09 INFO - PROCESS | 14924 | _x_x_mozilla_cycle_collect,1549 10:26:09 INFO - PROCESS | 14924 | __end_cc_report 10:26:09 INFO - PROCESS | 14924 | __startTimestamp1486664769504__endTimestamp 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | ------- Summary: start ------- 10:26:09 INFO - PROCESS | 14924 | Number of tests: 14 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.08 (1.0%) stddev-sans-first:1.13 10:26:09 INFO - PROCESS | 14924 | Values: 112.0 112.0 113.0 111.0 112.0 111.0 111.0 109.0 112.0 112.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:124.00 stddev:12.70 (10.2%) stddev-sans-first:11.95 10:26:09 INFO - PROCESS | 14924 | Values: 144.0 116.0 124.0 153.0 118.0 118.0 124.0 122.0 136.0 118.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 10:26:09 INFO - PROCESS | 14924 | Values: 160.0 159.0 160.0 160.0 160.0 160.0 160.0 160.0 159.0 160.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#3] audio-fft Cycles:10 Average:80.60 Median:76.00 stddev:11.18 (14.7%) stddev-sans-first:11.67 10:26:09 INFO - PROCESS | 14924 | Values: 75.0 74.0 76.0 105.0 77.0 76.0 74.0 75.0 98.0 76.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:82.50 stddev:10.81 (13.1%) stddev-sans-first:11.27 10:26:09 INFO - PROCESS | 14924 | Values: 83.0 82.0 107.0 83.0 82.0 83.0 94.0 82.0 82.0 109.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:26:09 INFO - PROCESS | 14924 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 10:26:09 INFO - PROCESS | 14924 | Values: 147.0 147.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 147.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:26:09 INFO - PROCESS | 14924 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:2.28 (4.6%) stddev-sans-first:0.83 10:26:09 INFO - PROCESS | 14924 | Values: 56.0 48.0 49.0 48.0 49.0 50.0 50.0 49.0 50.0 50.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 10:26:09 INFO - PROCESS | 14924 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 65.0 63.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:76.50 stddev:3.50 (4.6%) stddev-sans-first:3.63 10:26:09 INFO - PROCESS | 14924 | Values: 76.0 76.0 75.0 77.0 83.0 75.0 76.0 76.0 83.0 83.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:124.50 stddev:11.24 (9.0%) stddev-sans-first:11.90 10:26:09 INFO - PROCESS | 14924 | Values: 125.0 128.0 120.0 130.0 121.0 124.0 119.0 120.0 157.0 123.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:159.00 stddev:2.63 (1.7%) stddev-sans-first:2.73 10:26:09 INFO - PROCESS | 14924 | Values: 157.0 156.0 159.0 163.0 162.0 161.0 159.0 156.0 156.0 157.0 10:26:09 INFO - PROCESS | 14924 | 10:26:09 INFO - PROCESS | 14924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.70 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.73 10:26:09 INFO - PROCESS | 14924 | Values: 61.0 60.0 60.0 60.0 60.0 60.0 59.0 60.0 59.0 58.0 10:26:09 INFO - PROCESS | 14924 | -------- Summary: end -------- 10:26:09 INFO - PROCESS | 14924 | 10:26:10 INFO - TEST-INFO | 14924: exit 0 10:26:10 INFO - TEST-OK | kraken | took 60264ms 10:26:10 INFO - SUITE-END | took 1173s 10:26:10 INFO - Completed test suite (00:19:33) 10:26:10 INFO - javascript benchmark 10:26:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3163.3831402876435, 3175.968240317596, 3182.9840850795745, 3196.6643502432244, 3234.4986527088295, 5429.049916264653, 5506.394296627373, 5507.228987941681, 5516.641418307812, 5522.751476183581, 5519.254900588429, 5550.361708403535, 5568.248286481324, 5569.275994120769, 5583.972080139603, 4965.5034496550325, 4987.451380348159, 5026.597872170236, 5028.974855125737, 5079.6952182869145, 4928.876778080558, 5016.49835016499, 5063.873403164914, 5081.872953176163, 5083.923741143886, 4912.631552633549, 4927.975360123194, 4943.728094954776, 4987.177115775893, 5054.342935418391, 5034.09386310464, 5059.772310246048, 5065.949340506603, 5068.341115654941, 5095.133827249339, 4909.320037258231, 4966.677165984235, 4974.87562810929, 5028.974855125737, 5032.892763592004, 5354.330708661418, 5385.192221166817, 5412.431694672042, 5466.207399927028, 5475.863103422406, 5926.170336152942, 5926.199963004982, 5931.08068249422, 5933.0, 5954.166416701665, 5924.526037916957, 5955.225820643332, 5983.640981541122, 5985.521158307325, 5986.640801551877, 5409.918851217235, 5431.402545720007, 5518.117101263779, 5541.861453463655, 5567.777288908479, 6059.36376680451, 6061.939380606137, 6063.363346848606, 6088.117223002729, 6102.664353460514, 5788.507976822018, 5836.620619659709, 5850.180974663551, 5852.209951656557, 5852.94147058524, 5703.0, 5760.0783874579865, 5800.042992906123, 5937.7921772737745, 5943.108533719977, 5709.628874123168, 5726.742296596663, 5776.711164441761, 5798.565107616945, 5811.041178205549, 5807.8093990731795, 5809.419058094241, 5811.651300921958, 5812.7674893003805, 5813.09896965971, 4449.17690227309, 4467.508574056851, 4500.594946454835, 4504.797284122157, 4525.864224073283, 4018.557958624549, 4046.190761847642, 4051.068254301468, 4077.5922407758985, 4107.691923105779, 5734.770609175586, 5741.483266506035, 5742.799002034909, 5743.569232307594, 5745.0, 5787.045137552341, 5801.01382764931, 5844.824655260349, 6030.969845150747, 6053.182820319289, 5608.887822243532, 5683.0, 5685.260916080883, 5713.74288157034, 5718.027935251017, 5028.396592408862, 5046.0, 5053.9241911371355, 5056.039352523009, 5085.0, 6033.42682445167, 6085.939140608537, 6214.627122372672, 6277.246730392382, 6285.402886725754, 5862.472377486047, 5921.289445266596, 5928.110783382527, 5999.820005399845, 6029.939700602938, 6125.142480052886, 6169.753209871555, 6176.938230617816, 6179.783707570214, 6181.81454556364, 5649.491545760901, 5835.883282334415, 5889.617174883619, 5900.409959004065, 5903.321118071477, 5788.942110579009, 5878.088896221093, 5918.260217472816, 5921.970390148022, 6028.939710602838, 5808.970955145197, 5855.473007429352, 5858.502027327554, 5861.9706901465215, 5863.17915491823, 5855.2973643163095, 5860.062390017577, 5861.3845546217035, 5864.384239654945, 5865.618734782225, 5578.219049333015, 5608.579356548194, 5732.3121225453215, 5751.5398768099285, 5776.451237132465, 5890.0, 5892.734826932712, 5897.882042359214, 5899.4985426239255, 5928.9407105928385, 5758.769649213985, 5760.94239057604, 5761.078227483583, 5763.6541807491685, 5773.3072031356505], "value": 5455.773771353824, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.873384743125, 588.2000479348087, 621.1676353686062, 626.6334194496222, 652.5986518291252, 37432.25135497292, 48378.0, 49562.75218623911, 49573.25640115401, 49731.50268497309, 51636.0, 52013.73993130029, 52157.0, 52256.477435225635, 52303.738481307635, 8510.106438823927, 8858.512781796999, 9383.483908385037, 9581.425114493119, 9608.375455595398, 11114.444277786119, 11425.657230283105, 11436.142289328334, 11817.527298908033, 11838.348890811001, 11486.483108260107, 11543.480543375568, 11563.364014979174, 11568.248063875862, 11571.247868888495, 11404.54381824726, 11451.770964580663, 11466.48400821965, 11476.311421314747, 11489.368084755377, 11252.324860508395, 11334.093272538177, 11336.093112551058, 11339.14956378275, 11392.145589080852, 48528.75735621299, 48843.0, 48871.26693099606, 48899.0, 48929.510704892855, 4530.116627257686, 4577.427821522309, 4633.25867861144, 4695.835645752382, 4732.668713190078, 35168.824155879316, 35529.82235088834, 35860.46209306862, 35929.46105808415, 36993.26013479715, 4673.135469938073, 4696.201645720235, 4719.740414277213, 4742.50203728607, 4773.594244489223, 380806.0, 381554.0, 381796.0, 382097.0, 383661.0, 69090.65454672795, 69817.0, 70135.0, 70220.0, 70351.0, 73537.63231183917, 73593.0, 73638.26361736421, 73651.0, 73728.0, 17166.22751976164, 17182.914085429493, 17246.655066898842, 17720.025398602942, 17725.29098836058, 12324.198927069712, 12463.937680311541, 12472.937635311946, 12753.553625623059, 12814.487420503076, 19136.712949305773, 19294.32469863548, 19431.708524372145, 19464.31874884372, 19489.22043118288, 6575.671216439159, 6620.205575330991, 6636.469082473391, 6674.833129171712, 6744.898826517606, 1016.3139880580578, 1017.6641708236265, 1019.6227395863579, 1022.3610243597751, 1026.5175367577376, 33472.72410097929, 34132.317353653285, 34436.31127377439, 34513.30973380568, 34785.478217826756, 1113.8496302998992, 1115.9944200278946, 1153.1812413186565, 1153.2792004996877, 1155.1278784517635, 17349.826501735075, 18489.0, 18563.978981156168, 18698.532536686693, 18723.719144212846, 493603.0, 495045.0, 496035.0, 496676.0, 496699.0, 68425.0, 69032.0, 69241.0, 69330.30669693238, 69337.30662693409, 1528.098421931066, 1528.4497580870877, 1575.9763603545955, 1578.2187817030642, 1589.4436947068664, 32315.35369292648, 33608.0, 33855.322893542485, 34012.48981265332, 34137.217248173576, 58199.0, 59047.40952590419, 59048.70475647594, 59067.70466147642, 59149.70425148019, 393493.0, 396140.0, 396708.0, 396923.0, 397489.0, 37522.624773751915, 37784.24431511409, 42874.0, 44340.11319773651, 45330.54669453395, 53336.46663533315, 53388.64733336098, 54142.0, 54214.728926355114, 54956.450435495135, 44421.11157776891, 44455.0, 45263.54736452593, 45723.0, 46143.07713845772, 43361.0, 43973.0, 44231.53335717438, 44957.55042449533, 45453.772731137455, 44076.33885491656, 44793.77603111963, 45634.0, 45643.77178114088, 45909.77045114753, 36542.0, 38753.4186987201, 39059.80470097631, 39590.208195835345, 39635.0, 28375.858120709265, 28440.715592843808, 28655.880212539403, 28947.0, 29150.12549623515], "value": 22305.22430987736, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.84710351377043, 440.7884215576523, 441.6334442412798, 444.4710794154955, 456.44541881613856, 20584.279550215746, 21048.789512104893, 22438.439039024033, 22562.661560076613, 22568.322950311474, 22643.433914152156, 23467.178648747296, 23485.41286467839, 23577.292681219547, 23767.76232237677, 5992.64044157352, 6032.065029920358, 6211.223597050369, 6268.811935641938, 6278.4035516625845, 5979.970100149493, 6031.24609423822, 6069.635821850681, 6070.725147718962, 6075.0887366895095, 5863.706814659271, 6007.279126504804, 6015.308239552463, 6023.30731965823, 6073.696315184246, 6103.511719062464, 6143.569950103494, 6147.2008638877105, 6151.7231724572275, 6154.661493617849, 5467.988422141877, 5486.561075113981, 5521.696306703129, 5524.309461317335, 5526.032944234743, 25963.22110336693, 26044.0, 26100.738992610022, 26207.868960655265, 26349.20952371432, 3260.10347154532, 3353.8826141085187, 3369.073504786179, 3444.4144495435585, 3446.327966046622, 13479.797803032963, 15385.307661155162, 15798.289076991563, 16025.839741602551, 16513.66972660552, 2037.0, 2037.276766747798, 2038.4801875521648, 2038.6534289170877, 2041.4181958141858, 91663.0, 93528.0, 93632.0, 94081.0, 94100.05899940981, 11385.487653055632, 11576.131790115607, 11734.295942243321, 11833.585824496273, 11914.344711040976, 16512.431319024912, 16539.50381488557, 16540.75188872168, 16544.6691066178, 16545.420910268083, 8531.596065791284, 8901.777455563662, 8995.955020224857, 9087.681931132378, 9203.079692030877, 8653.221210090996, 8718.258947989492, 8725.607347669244, 8954.552272386354, 8969.686060987835, 7397.704091836374, 7648.464607477423, 7715.421343399155, 7735.845283094307, 7757.301842834172, 2086.7182930304516, 2107.841911856586, 2108.978910210909, 2129.829613630906, 2147.9248226312316, 976.5849513956682, 979.2361957673027, 986.5856340337076, 988.0761488008735, 991.2317953586029, 20611.896940515202, 21324.360269191948, 21810.563788724136, 21957.67063494049, 22889.542209156058, 1047.2669131607904, 1065.824139017069, 1076.9246152769388, 1083.2525557365393, 1089.967300980972, 11061.612843550438, 11121.944390277997, 11224.607138750267, 11231.10151187903, 11263.60577379804, 664593.0, 683679.0, 705088.0, 720556.0, 731743.0, 114375.0, 115740.0, 116014.41992790152, 116301.0, 118163.40918295525, 1183.1599564309265, 1209.2623499665197, 1225.993870030662, 1229.661842993184, 1231.950721971111, 17182.0, 17391.608601333122, 17560.73658895092, 17680.91159544194, 17910.104494774947, 45622.31566526438, 45952.31071533997, 46410.07179856316, 46520.53479465297, 47771.0, 62078.37921620726, 62470.687646563296, 62491.687541562, 63112.684436577525, 64233.67883160741, 9011.459312441275, 9092.818143636958, 9165.083491650781, 9328.860067099135, 9653.806923861343, 13149.671258218239, 14165.220912849893, 14284.57146285613, 14367.13797172173, 14522.056066355653, 6887.931120688729, 11582.536698531965, 12175.878241217828, 12263.632091037283, 12588.811167832308, 11808.11439142085, 12001.393658852361, 12065.939670301592, 12226.388680566113, 12317.0, 12276.0, 12435.564755233523, 12535.122541422013, 12553.246805191719, 12789.296588687712, 7693.692252310068, 8301.377396695392, 8432.957835210786, 8568.742937711879, 9468.053194680753, 9588.424694518351, 12101.636950891487, 12534.749305014031, 12569.434375452944, 12893.419796109385], "value": 10326.044493459985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.0416525093426, 1519.2859356102636, 1526.7175572519084, 1539.168848821637, 1549.9302531386086, 7918.841623167533, 8350.540720260391, 8602.698905538307, 8612.655493780248, 8798.824023519526, 8612.267957223643, 8669.696560620363, 8678.696245631389, 8685.782855428617, 8713.041565427813, 2137.732783402075, 2200.680901269315, 2405.338531903723, 2446.889889954947, 2451.669024681672, 2401.795847352977, 2499.5375855466796, 2499.7125330587032, 2512.9120480783176, 2523.974760252392, 2467.3091534370315, 2476.19523654812, 2487.2040946897, 2494.0397946790436, 2494.9126780562683, 2475.8638274894874, 2477.962830557543, 2490.3649569359877, 2496.8252222344445, 2500.499900020003, 2278.4417817634785, 2306.5156317173414, 2312.4681323295736, 2313.4447732544236, 2316.200910685811, 8992.370534062618, 9064.410813297114, 9070.909290907073, 9096.090390960851, 9102.81794364109, 5375.354957405098, 5499.752511137009, 5512.972435137799, 5526.419725928759, 5528.226048353234, 3313.4698448248405, 3419.281950790337, 3593.6765691087667, 3639.0720366306423, 3643.890683279506, 1466.7359875222455, 1491.6643755155003, 1505.631120375504, 1528.8700460460764, 1594.5614955887108, 12356.938215308955, 12376.319302438362, 12389.380530973416, 12390.070744694183, 12400.56598019074, 4467.01725620363, 4628.703962890396, 4638.327442520883, 4642.117997580449, 4650.651201159926, 10669.893301067044, 10673.0, 10686.14510839131, 10695.197860160364, 10700.625478108384, 5379.67721936685, 5383.2194331821665, 5390.460953904578, 5393.056215162409, 5396.406395296514, 4513.661475389359, 4657.068586282757, 4987.301777751118, 5017.37282839645, 5076.13705670037, 3911.9022024449046, 3947.3289540778137, 4036.1120553478186, 4041.8383264669083, 4042.959570404317, 1159.3189874681746, 1169.6841852699724, 1169.6900321414662, 1171.1626187276138, 1178.634623266773, 908.513945039414, 925.6760133953062, 927.9211267042242, 938.863864739609, 946.5456580841235, 5939.910901336483, 5948.226730525004, 6021.217241758631, 6145.324014358417, 6232.065190221503, 1061.686802393296, 1090.8527348807968, 1091.1543553745753, 1095.1786160379716, 1107.645553422913, 4138.544760076389, 4310.7629080400875, 4318.654507639381, 4322.502912165079, 4327.091310824762, 10563.0, 10889.128869690407, 10926.945365273123, 10935.343879367263, 10951.178661600252, 10647.84028239577, 10760.946195268974, 10820.67537973862, 10843.891561084289, 10858.619948301772, 7907.446478746548, 8015.438919275712, 8037.23646253605, 8379.622916968628, 8383.874241886377, 5929.229200203946, 6026.186464827192, 6034.034554471439, 6045.304789949212, 6127.693615319127, 9640.084192001748, 9734.464604446823, 9746.220302375652, 9749.122578967927, 9815.871174814702, 9767.072128147815, 9769.169620582046, 9849.261305402268, 9947.104760571583, 9985.800283994135, 7136.607486588287, 7395.408367330493, 7771.689132434639, 7892.486988345969, 7930.643121059451, 8039.557824319719, 8348.958255208685, 8350.62422191015, 8553.358498112791, 8564.52895090776, 7546.735864244725, 7693.807654808675, 7695.076590809139, 7719.4210434218785, 7811.2188781123705, 7558.962205188939, 7589.013428254291, 7611.733589324347, 7660.463767536219, 7669.309762121436, 6385.265694445198, 6503.219613646393, 6507.544471886922, 6520.641364724986, 6571.737130514726, 5212.322398088224, 5271.630985831109, 5283.603729720363, 5343.973280133574, 5373.785048598169, 5309.522143007148, 5323.148296272578, 5365.517103460551, 5373.462653734595, 5398.217258497417], "value": 4719.708803157998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.4089724515982, 409.3041828890886, 410.73712823792766, 412.41025333772694, 413.49553544675496, 5363.4904684055045, 5368.785248590057, 5408.783648654059, 5414.675119492833, 5424.538914192289, 5036.798528058874, 5082.136036873731, 5152.0, 5157.896842063156, 5357.223202635615, 4245.787710614472, 4267.23189825832, 4272.487301523806, 4282.443282373287, 4287.277578737493, 4267.829286828539, 4273.807678654468, 4282.74303541787, 4304.203722311367, 4304.483461984566, 4035.9798201008953, 4076.9184616307657, 4242.97878510607, 4273.40172375866, 4279.529251782302, 4236.237477254093, 4258.552851950562, 4259.91480170398, 4286.9999999999845, 4311.5472875348105, 3862.9227415451815, 3873.205992771503, 3873.4189871519216, 3884.708646851469, 3886.689064874803, 5202.843914682528, 5254.605904557136, 5266.131088370415, 5269.262303277545, 5304.310439642822, 4913.869809943697, 4954.628402869763, 4975.109458405819, 4998.850034498971, 5009.323741294915, 5602.691851948141, 5617.887642247173, 5652.406497317764, 5653.1520271959125, 5659.7453114609525, 4196.307609244471, 4246.617804397588, 4306.074194048263, 4314.654827613784, 4321.632661223768, 5791.884162316772, 5804.448577385142, 5804.546294954495, 5806.912896306559, 5808.82573522795, 4448.332750087448, 4475.440569928759, 4497.2129877271345, 4501.122281155143, 4503.437070366204, 4439.801253661493, 4442.622377097919, 4447.466304043471, 4453.643708503312, 4544.454665440168, 4909.140900342426, 4914.262860570943, 4918.139325618003, 4919.171476401084, 4943.777530011158, 5646.971765141148, 5666.235058267163, 5672.794870897929, 5673.404292549306, 5689.231953686282, 1467.3763650448516, 1497.0867770659888, 1510.8262549806693, 1511.3954418232574, 1525.1306755149458, 998.9500524973722, 1017.704865588971, 1074.8441475985937, 1091.1052936591918, 1111.155521803419, 5306.681599104066, 5310.840674779763, 5320.281761962163, 5369.40936496985, 5412.998595259811, 5526.47498487643, 5583.162525621108, 5627.380988091307, 5663.178839068312, 5677.744501497443, 5070.543651071347, 5252.684838909678, 5257.658252213594, 5279.656822306538, 5289.153735402394, 2950.7721670139335, 2953.6012638293987, 2959.0235222376564, 2963.155500682295, 2988.4023195361015, 5636.2391077204875, 5750.827475175752, 5811.506021988178, 5812.529674888156, 5959.642421454727, 5882.735276912549, 5883.911741323884, 5890.8821823563285, 5914.817036592613, 5932.970335148297, 5939.0, 5939.346671866091, 5984.611000284967, 5990.251218597676, 6007.939920600738, 5564.276644036249, 5709.628874123168, 5716.342620598684, 5753.482186603226, 5780.30636323627, 5717.685527296038, 5729.2265544151005, 5747.310322761128, 5752.539796816328, 5764.308283005898, 5863.442972917566, 5890.793822216202, 5936.436038576501, 6018.548608854266, 6032.155498230163, 4232.703710740218, 4257.594993652149, 4261.680373971903, 4266.850660226877, 4269.338252570857, 5846.6673995821975, 5847.8538036547725, 5884.529237660891, 5886.146508756121, 5902.4097590240635, 5638.23883775685, 5686.374498805211, 5711.200431939449, 5724.685142317046, 5768.08711600639, 5657.717114144194, 5697.151424287856, 5698.544116470755, 5704.828855134353, 5720.227769251264, 5457.918131228114, 5484.0, 5575.303087114111, 5681.0, 5728.226689396878, 5650.502616806467, 5652.491275785199, 5701.7149142541875, 5705.7432415542235, 5711.8000869969355, 5373.650712703662, 5542.418046105101, 5543.223948647274, 5546.667199968015, 5607.775688972395], "value": 4379.606368117488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.9093699693033, 842.3892677808585, 859.0464584311413, 916.7112359606723, 939.638239277878, 15218.0, 16098.436554720587, 17288.049157296344, 17482.56293592661, 17548.736768948474, 14698.559043228694, 14729.337179826907, 16560.50318490447, 17175.312987480487, 17252.39616613419, 840.3907167303717, 857.3869683176528, 857.6312185760152, 857.7426771968416, 858.3090612057291, 697.898804673322, 712.3731116617396, 712.6614857942487, 713.8108401273666, 848.0332421040019, 846.7417437681505, 869.7564681889081, 878.666106879385, 884.0805562215321, 884.3455842676406, 866.2420382165606, 867.2238346679718, 868.0278088540844, 868.1492137705021, 869.0570730757136, 546.4999525434223, 555.9249501317352, 634.9523785716044, 635.0188958059808, 635.726637545855, 15455.30451129702, 16050.919745401316, 16051.357945682159, 16870.746938795804, 16892.662146756997, 16017.439389621424, 16183.786216033726, 16224.756628650463, 16369.59076023097, 16386.426475073433, 12980.870191298061, 13262.53581124656, 13267.203967761869, 13328.400221989938, 13459.798103028463, 4039.7374170678813, 4077.2660921034203, 4083.530394004698, 4144.44050053242, 4151.83392664293, 82714.21692488722, 83261.0, 83436.0, 85367.0, 86764.0, 12455.494778717057, 12522.74954500923, 12526.248425094524, 12554.560590379293, 12741.55404560836, 23978.52042959131, 24028.87985560061, 24031.759682402953, 24109.0, 24314.87842560776, 8442.57787110642, 8538.743837684879, 8586.87119693205, 8635.568221588896, 8776.385653004356, 4503.954960450354, 4540.318952157137, 4609.608183304456, 4614.100250451197, 4637.86086417408, 3722.088088418355, 3755.455458958436, 3817.4655548223272, 3835.0, 3837.194189220239, 649.2468736265909, 650.1353200243759, 658.2002866517109, 662.7216569041015, 667.6061123936901, 683.2381894187945, 698.6646409723361, 708.7129712466459, 712.508369225233, 718.3606590134784, 11109.72225694348, 11286.266392684449, 11761.0, 11914.16600837933, 12094.455749491119, 849.3120572336427, 857.8541647919868, 870.734426000076, 872.7861673889938, 881.3213825354442, 5511.559075273968, 5655.80204692842, 5729.1119876419225, 5758.74085666146, 5766.711664416763, 77976.22023779803, 85212.0, 85982.57008715041, 87149.0, 87407.0, 58424.0, 61156.694216529526, 66729.6663516689, 75482.84844333614, 76496.0, 66609.6669516659, 67018.66490667516, 68259.3174068253, 69029.30970690229, 69559.65220173867, 10610.89389106099, 10880.075193608633, 10974.286671366335, 11007.449627518432, 11165.995060444598, 46202.76898615486, 46942.29586556136, 47006.76496617632, 47850.5214947846, 48523.5147648519, 49730.751346243036, 51181.7440912793, 55624.0, 57385.0, 57993.0, 14445.133292002092, 14783.113013219241, 14926.626834329229, 15024.849751502345, 15058.32237549291, 15604.765928510855, 16270.105144216708, 16330.101844398672, 16469.505914822574, 16579.834201657828, 15837.920810395874, 16039.198040098181, 16150.838491614933, 16240.0, 16944.661106778043, 14970.40118395252, 15122.0, 15210.391584336945, 15432.614184645474, 16989.660206795546, 13841.0, 14674.486392976194, 15415.691686166438, 15472.0, 15640.374385024472, 11997.160198786001, 12217.266963982189, 12526.37368131608, 12705.618831435071, 12802.551910683082, 12513.124081314585, 12592.181508201938, 12806.0, 12818.743625127632, 12833.230006199658], "value": 7840.7960527959785, "unit": "score"}], "name": "dromaeo_css", "value": 7670.5391886997, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 113.0, 111.0, 112.0, 111.0, 111.0, 109.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 124.0, 153.0, 118.0, 118.0, 124.0, 122.0, 136.0, 118.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 160.0, 160.0, 160.0, 160.0, 160.0, 159.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 105.0, 77.0, 76.0, 74.0, 75.0, 98.0, 76.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 107.0, 83.0, 82.0, 83.0, 94.0, 82.0, 82.0, 109.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 48.0, 49.0, 48.0, 49.0, 50.0, 50.0, 49.0, 50.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 77.0, 83.0, 75.0, 76.0, 76.0, 83.0, 83.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 128.0, 120.0, 130.0, 121.0, 124.0, 119.0, 120.0, 157.0, 123.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 159.0, 163.0, 162.0, 161.0, 159.0, 156.0, 156.0, 157.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 58.0], "value": 59.7, "unit": "score"}], "name": "kraken", "value": 1463.3000000000002, "alertThreshold": 2.0}]} 10:26:10 INFO - Return code: 0 10:26:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:26:10 ERROR - # TBPL SUCCESS # 10:26:10 INFO - Running post-action listener: _resource_record_post_action 10:26:10 INFO - [mozharness: 2017-02-09 18:26:10.816840Z] Finished run-tests step (success) 10:26:10 INFO - Running post-run listener: _resource_record_post_run 10:26:10 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364163072; Read time: 12; Write time: 257704 10:26:10 INFO - TinderboxPrint: CPU usage
13.0% 10:26:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:26:10 INFO - TinderboxPrint: I/O write bytes / time
364,163,072 / 257,704 10:26:10 INFO - TinderboxPrint: CPU idle
8,262.9 (87.0%) 10:26:10 INFO - TinderboxPrint: CPU user
1,190.3 (12.5%) 10:26:10 INFO - TinderboxPrint: Swap in / out
0 / 0 10:26:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109359104; Read time: 0; Write time: 99528 10:26:10 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254472192; Read time: 12; Write time: 158152 10:26:11 INFO - Running post-run listener: _upload_blobber_files 10:26:11 INFO - Blob upload gear active. 10:26:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:11 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 10:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:26:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:26:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:12 INFO - (blobuploader) - INFO - Done attempting. 10:26:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:26:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:13 INFO - (blobuploader) - INFO - Done attempting. 10:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:17 INFO - (blobuploader) - INFO - Done attempting. 10:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:26:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:18 INFO - (blobuploader) - INFO - Done attempting. 10:26:18 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:18 INFO - Return code: 0 10:26:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8565c8b507e39ef4dfb86dded8c10ab69a560ac8f4a7691c4c77da8462de18c8c73f34128eea521053653ffe9fe27ef0e6915c60e019ed95ff246dd1cdfd0fe8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3eb533163bbe68427572f7bcd0dbf69607de3a669a24e1784d503b0ed21d92e4f046663bb3189dbf0c87d4955fc9884c493f5929f01092f498e6d520127abc64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa27053ed9840ba9f1ee7f1a67f2cf9d912a68ab65424477023460b17d1cb83cce6b61b2e0036832c1ddb4f661ec129b77ae3437869e462a6699072580b6b0f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/652fb3e0e38084b15a9162667a1e78f5cc670df881a532704191161fb801c2e9e20e66197d63424ae7a3ade47ddb5d1184d3c21897cd809c5a25496a5c9e8736"} 10:26:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:18 INFO - Contents: 10:26:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8565c8b507e39ef4dfb86dded8c10ab69a560ac8f4a7691c4c77da8462de18c8c73f34128eea521053653ffe9fe27ef0e6915c60e019ed95ff246dd1cdfd0fe8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3eb533163bbe68427572f7bcd0dbf69607de3a669a24e1784d503b0ed21d92e4f046663bb3189dbf0c87d4955fc9884c493f5929f01092f498e6d520127abc64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa27053ed9840ba9f1ee7f1a67f2cf9d912a68ab65424477023460b17d1cb83cce6b61b2e0036832c1ddb4f661ec129b77ae3437869e462a6699072580b6b0f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/652fb3e0e38084b15a9162667a1e78f5cc670df881a532704191161fb801c2e9e20e66197d63424ae7a3ade47ddb5d1184d3c21897cd809c5a25496a5c9e8736"} 10:26:18 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:18 INFO - Copying logs to upload dir... 10:26:18 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.152748 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 10:26:18.246817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 10:26:18.250055) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8565c8b507e39ef4dfb86dded8c10ab69a560ac8f4a7691c4c77da8462de18c8c73f34128eea521053653ffe9fe27ef0e6915c60e019ed95ff246dd1cdfd0fe8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3eb533163bbe68427572f7bcd0dbf69607de3a669a24e1784d503b0ed21d92e4f046663bb3189dbf0c87d4955fc9884c493f5929f01092f498e6d520127abc64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa27053ed9840ba9f1ee7f1a67f2cf9d912a68ab65424477023460b17d1cb83cce6b61b2e0036832c1ddb4f661ec129b77ae3437869e462a6699072580b6b0f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/652fb3e0e38084b15a9162667a1e78f5cc670df881a532704191161fb801c2e9e20e66197d63424ae7a3ade47ddb5d1184d3c21897cd809c5a25496a5c9e8736"} build_url:https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/NqU0E1HiSEW19SH7wT7Y-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8565c8b507e39ef4dfb86dded8c10ab69a560ac8f4a7691c4c77da8462de18c8c73f34128eea521053653ffe9fe27ef0e6915c60e019ed95ff246dd1cdfd0fe8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3eb533163bbe68427572f7bcd0dbf69607de3a669a24e1784d503b0ed21d92e4f046663bb3189dbf0c87d4955fc9884c493f5929f01092f498e6d520127abc64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa27053ed9840ba9f1ee7f1a67f2cf9d912a68ab65424477023460b17d1cb83cce6b61b2e0036832c1ddb4f661ec129b77ae3437869e462a6699072580b6b0f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/652fb3e0e38084b15a9162667a1e78f5cc670df881a532704191161fb801c2e9e20e66197d63424ae7a3ade47ddb5d1184d3c21897cd809c5a25496a5c9e8736"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 10:26:18.275561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 10:26:18.275947) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1486663539.804454-2085029228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 10:26:18.371551) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 10:26:18.371889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 10:26:18.372207) ========= ========= Total master_lag: 0.18 =========