builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1493892175.61 results: success (0) revision: a8d597ee6dd58306e62e55a07c4ab20958726d6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:55.606420) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:55.606853) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:55.607760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:55.621794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:55.622064) ========= 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=52faae308a556c440401f8e5000001e8-1493892175.163750-969890786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 03:02:56-- 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% 46.2M=0s 2017-05-04 03:02:56 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.326751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:55.963636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:55.963961) ========= 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=52faae308a556c440401f8e5000001e8-1493892175.163750-969890786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014404 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:56.013014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 03:02:56.016352) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8d597ee6dd58306e62e55a07c4ab20958726d6a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev a8d597ee6dd58306e62e55a07c4ab20958726d6a --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=52faae308a556c440401f8e5000001e8-1493892175.163750-969890786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 03:02:56,581 truncating revision to first 12 chars 2017-05-04 03:02:56,581 Setting DEBUG logging. 2017-05-04 03:02:56,581 attempt 1/10 2017-05-04 03:02:56,581 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8d597ee6dd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 03:02:57,414 unpacking tar archive at: mozilla-central-a8d597ee6dd5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.151434 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 03:02:57.181056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:57.184386) ========= script_repo_revision: a8d597ee6dd58306e62e55a07c4ab20958726d6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:57.184754) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:57.185014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:57.195318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-05-04 03:02:57.195598) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=52faae308a556c440401f8e5000001e8-1493892175.163750-969890786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:02:57 INFO - MultiFileLogger online at 20170504 03:02:57 in /builds/slave/test 03:02:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:02:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:02:57 INFO - {'append_to_log': False, 03:02:57 INFO - 'base_work_dir': '/builds/slave/test', 03:02:57 INFO - 'blob_upload_branch': 'Firefox', 03:02:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:02:57 INFO - 'branch': 'Firefox', 03:02:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:02:57 INFO - 'config_files': ('talos/linux_config.py',), 03:02:57 INFO - 'default_actions': ('clobber', 03:02:57 INFO - 'read-buildbot-config', 03:02:57 INFO - 'download-and-extract', 03:02:57 INFO - 'populate-webroot', 03:02:57 INFO - 'create-virtualenv', 03:02:57 INFO - 'install', 03:02:57 INFO - 'run-tests'), 03:02:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:02:57 INFO - 'download_minidump_stackwalk': True, 03:02:57 INFO - 'download_symbols': 'ondemand', 03:02:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:02:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:02:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:02:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:02:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:02:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:02:57 INFO - 'gecko_profile': False, 03:02:57 INFO - 'gecko_profile_interval': 0, 03:02:57 INFO - 'installer_path': 'installer.exe', 03:02:57 INFO - 'log_level': 'info', 03:02:57 INFO - 'log_name': 'talos', 03:02:57 INFO - 'log_to_console': True, 03:02:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:02:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:02:57 INFO - 'opt_config_files': (), 03:02:57 INFO - 'pip_index': False, 03:02:57 INFO - 'suite': 'dromaeojs', 03:02:57 INFO - 'system_bits': '32', 03:02:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:02:57 INFO - 'title': 'talos-linux64-ix-056', 03:02:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:02:57 INFO - 'use_talos_json': True, 03:02:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:02:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:02:57 INFO - 'work_dir': 'build'} 03:02:57 INFO - [mozharness: 2017-05-04 10:02:57.859131Z] Running clobber step. 03:02:57 INFO - Running pre-action listener: _resource_record_pre_action 03:02:57 INFO - Running main action method: clobber 03:02:57 INFO - rmtree: /builds/slave/test/build 03:02:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:02:58 INFO - Running post-action listener: _resource_record_post_action 03:02:58 INFO - [mozharness: 2017-05-04 10:02:58.829450Z] Finished clobber step (success) 03:02:58 INFO - [mozharness: 2017-05-04 10:02:58.829551Z] Running read-buildbot-config step. 03:02:58 INFO - Running pre-action listener: _resource_record_pre_action 03:02:58 INFO - Running main action method: read_buildbot_config 03:02:58 INFO - Using buildbot properties: 03:02:58 INFO - { 03:02:58 INFO - "project": "", 03:02:58 INFO - "product": "firefox", 03:02:58 INFO - "who": "cbook@mozilla.com", 03:02:58 INFO - "installer_path": "public/build/target.tar.bz2", 03:02:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:02:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:02:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 03:02:58 INFO - "stage_platform": "linux64-pgo", 03:02:58 INFO - "basedir": "/builds/slave/test", 03:02:58 INFO - "buildnumber": 178, 03:02:58 INFO - "platform": "ubuntu64_hw", 03:02:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:02:58 INFO - "slavebuilddir": "test", 03:02:58 INFO - "taskId": "IcO0DA-5Tp6V7VNCo3eCcw", 03:02:58 INFO - "branch": "mozilla-central", 03:02:58 INFO - "script_repo_revision": "production", 03:02:58 INFO - "revision": "a8d597ee6dd58306e62e55a07c4ab20958726d6a", 03:02:58 INFO - "slavename": "talos-linux64-ix-056", 03:02:58 INFO - "repo_path": "mozilla-central" 03:02:58 INFO - } 03:02:58 INFO - Finding installer, test and symbols from parent task. 03:02:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IcO0DA-5Tp6V7VNCo3eCcw'}, attempt #1 03:02:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IcO0DA-5Tp6V7VNCo3eCcw'}, attempt #1 03:02:59 INFO - Task dependencies: XHIlcrlvQPaCXuPNET_RCg 03:02:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg'}, attempt #1 03:03:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.tar.bz2 03:03:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/test_packages.json 03:03:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.crashreporter-symbols.zip 03:03:00 INFO - Running post-action listener: _resource_record_post_action 03:03:00 INFO - [mozharness: 2017-05-04 10:03:00.188416Z] Finished read-buildbot-config step (success) 03:03:00 INFO - [mozharness: 2017-05-04 10:03:00.188630Z] Running download-and-extract step. 03:03:00 INFO - Running pre-action listener: _resource_record_pre_action 03:03:00 INFO - Running main action method: download_and_extract 03:03:00 INFO - mkdir: /builds/slave/test/build/tests 03:03: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')]} 03:03:00 INFO - trying https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.test_packages.json 03:03:00 INFO - Downloading https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:03:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:03:00 INFO - Downloaded 986 bytes. 03:03:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:03:00 INFO - Using the following test package requirements: 03:03:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:03:00 INFO - u'common': [u'target.common.tests.zip'], 03:03:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:03:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:03:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:03:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:03:00 INFO - u'mozbase': [u'target.common.tests.zip'], 03:03:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:03:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:03:00 INFO - u'web-platform': [u'target.common.tests.zip', 03:03:00 INFO - u'target.web-platform.tests.zip'], 03:03:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:03:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:03:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.common.tests.zip 03:03:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:03:00 INFO - Fetch https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.common.tests.zip into memory 03:03:01 INFO - Content-Length response header: 60560399 03:03:01 INFO - Bytes received: 60560399 03:03:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:03:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.common.tests.zip 03:03:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:03:11 INFO - Fetch https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.common.tests.zip into memory 03:03:13 INFO - Content-Length response header: 60560399 03:03:13 INFO - Bytes received: 60560399 03:03:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.talos.tests.zip 03:03:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:03:23 INFO - Fetch https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.talos.tests.zip into memory 03:03:24 INFO - Content-Length response header: 14408809 03:03:24 INFO - Bytes received: 14408809 03:03:24 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')]} 03:03:24 INFO - trying https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.tar.bz2 03:03:24 INFO - Downloading https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:03:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:03:26 INFO - Downloaded 64040710 bytes. 03:03:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.tar.bz2 03:03:26 INFO - mkdir: /builds/slave/test/properties 03:03:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:03:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:03:26 INFO - Contents: 03:03:26 INFO - build_url:https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.tar.bz2 03:03:26 INFO - Running post-action listener: _resource_record_post_action 03:03:26 INFO - Running post-action listener: set_extra_try_arguments 03:03:26 INFO - [mozharness: 2017-05-04 10:03:26.054748Z] Finished download-and-extract step (success) 03:03:26 INFO - [mozharness: 2017-05-04 10:03:26.054844Z] Running populate-webroot step. 03:03:26 INFO - Running pre-action listener: _resource_record_pre_action 03:03:26 INFO - Running main action method: populate_webroot 03:03:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:03:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:03:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:03:26 INFO - '--tppagecycles', 03:03:26 INFO - '7'], 03:03:26 INFO - 'tests': ['tsvgm']}}, 03:03:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:03:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:03:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:03:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:03:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['damp', 'tps']}, 03:03:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'tests': ['damp', 'tps']}, 03:03:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['dromaeo_dom']}, 03:03:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:03:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:03:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:03:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:03:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:03:26 INFO - 'bloom_basic_ref']}, 03:03:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['tsvgx', 03:03:26 INFO - 'tsvgr_opacity', 03:03:26 INFO - 'tart', 03:03:26 INFO - 'tscrollx', 03:03:26 INFO - 'cart', 03:03:26 INFO - 'tsvg_static']}, 03:03:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:03:26 INFO - 'tsvgr_opacity', 03:03:26 INFO - 'tart', 03:03:26 INFO - 'tscrollx', 03:03:26 INFO - 'cart', 03:03:26 INFO - 'tsvg_static']}, 03:03:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['tp5o']}, 03:03:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:03:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'talos_options': ['--disable-e10s', 03:03:26 INFO - '--xperf_path', 03:03:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:26 INFO - 'tests': ['tp5n']}, 03:03:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'talos_options': ['--xperf_path', 03:03:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:26 INFO - 'tests': ['tp5n']}}, 03:03:26 INFO - 'talos.zip': {'path': '', 03:03:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:03:26 INFO - Running post-action listener: _resource_record_post_action 03:03:26 INFO - [mozharness: 2017-05-04 10:03:26.068536Z] Finished populate-webroot step (success) 03:03:26 INFO - [mozharness: 2017-05-04 10:03:26.068625Z] Running create-virtualenv step. 03:03:26 INFO - Running pre-action listener: _resource_record_pre_action 03:03:26 INFO - Running main action method: create_virtualenv 03:03:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:03:26 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 03:03:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:03:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:03:26 INFO - Using real prefix '/usr' 03:03:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:03:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:03:28 INFO - Installing pip.................done. 03:03:28 INFO - Return code: 0 03:03:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:03:28 INFO - Reading from file tmpfile_stdout 03:03:28 INFO - Output received: 03:03:28 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) 03:03:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, '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': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', '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 03:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:03:28 INFO - Using env: {'DISPLAY': ':0', 03:03:28 INFO - 'HOME': '/home/cltbld', 03:03:28 INFO - 'LANG': 'en_US.UTF-8', 03:03:28 INFO - 'LANGUAGE': 'en_US:en', 03:03:28 INFO - 'LOGNAME': 'cltbld', 03:03:28 INFO - 'MAIL': '/var/mail/cltbld', 03:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:28 INFO - 'MOZ_NO_REMOTE': '1', 03:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:28 INFO - 'NO_EM_RESTART': '1', 03:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:28 INFO - 'PWD': '/builds/slave/test', 03:03:28 INFO - 'SHELL': '/bin/bash', 03:03:28 INFO - 'SHLVL': '1', 03:03:28 INFO - 'TERM': 'linux', 03:03:28 INFO - 'TMOUT': '86400', 03:03:28 INFO - 'USER': 'cltbld', 03:03:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:28 INFO - '_': '/tools/buildbot/bin/python'} 03:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:29 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 03:03:29 INFO - Cleaning up... 03:03:29 INFO - Return code: 0 03:03:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, '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': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', '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 03:03:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:03:29 INFO - Using env: {'DISPLAY': ':0', 03:03:29 INFO - 'HOME': '/home/cltbld', 03:03:29 INFO - 'LANG': 'en_US.UTF-8', 03:03:29 INFO - 'LANGUAGE': 'en_US:en', 03:03:29 INFO - 'LOGNAME': 'cltbld', 03:03:29 INFO - 'MAIL': '/var/mail/cltbld', 03:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:29 INFO - 'MOZ_NO_REMOTE': '1', 03:03:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:29 INFO - 'NO_EM_RESTART': '1', 03:03:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:29 INFO - 'PWD': '/builds/slave/test', 03:03:29 INFO - 'SHELL': '/bin/bash', 03:03:29 INFO - 'SHLVL': '1', 03:03:29 INFO - 'TERM': 'linux', 03:03:29 INFO - 'TMOUT': '86400', 03:03:29 INFO - 'USER': 'cltbld', 03:03:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:29 INFO - '_': '/tools/buildbot/bin/python'} 03:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:29 INFO - Downloading/unpacking psutil>=3.1.1 03:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:03:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:30 INFO - Installing collected packages: psutil 03:03:30 INFO - Running setup.py install for psutil 03:03:30 INFO - building 'psutil._psutil_linux' extension 03:03:30 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 03:03:30 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 03:03:30 INFO - building 'psutil._psutil_posix' extension 03:03:30 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 03:03:30 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 03:03:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:30 INFO - Successfully installed psutil 03:03:30 INFO - Cleaning up... 03:03:31 INFO - Return code: 0 03:03:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:03:31 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')]} 03:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:31 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')]} 03:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:31 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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, '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': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', '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 03:03:31 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 03:03:31 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 03:03:31 INFO - Using env: {'DISPLAY': ':0', 03:03:31 INFO - 'HOME': '/home/cltbld', 03:03:31 INFO - 'LANG': 'en_US.UTF-8', 03:03:31 INFO - 'LANGUAGE': 'en_US:en', 03:03:31 INFO - 'LOGNAME': 'cltbld', 03:03:31 INFO - 'MAIL': '/var/mail/cltbld', 03:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:31 INFO - 'MOZ_NO_REMOTE': '1', 03:03:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:31 INFO - 'NO_EM_RESTART': '1', 03:03:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:31 INFO - 'PWD': '/builds/slave/test', 03:03:31 INFO - 'SHELL': '/bin/bash', 03:03:31 INFO - 'SHLVL': '1', 03:03:31 INFO - 'TERM': 'linux', 03:03:31 INFO - 'TMOUT': '86400', 03:03:31 INFO - 'USER': 'cltbld', 03:03:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:31 INFO - '_': '/tools/buildbot/bin/python'} 03:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:03:31 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 03:03:31 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 03:03:31 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 03:03:31 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 03:03:31 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 03:03:31 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 03:03:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:03:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:03:32 INFO - Installing collected packages: mozsystemmonitor 03:03:32 INFO - Running setup.py install for mozsystemmonitor 03:03:32 INFO - Successfully installed mozsystemmonitor 03:03:32 INFO - Cleaning up... 03:03:32 INFO - Return code: 0 03:03:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:32 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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, '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': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', '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 03:03:32 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 03:03:32 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 03:03:32 INFO - Using env: {'DISPLAY': ':0', 03:03:32 INFO - 'HOME': '/home/cltbld', 03:03:32 INFO - 'LANG': 'en_US.UTF-8', 03:03:32 INFO - 'LANGUAGE': 'en_US:en', 03:03:32 INFO - 'LOGNAME': 'cltbld', 03:03:32 INFO - 'MAIL': '/var/mail/cltbld', 03:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:32 INFO - 'MOZ_NO_REMOTE': '1', 03:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:32 INFO - 'NO_EM_RESTART': '1', 03:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:32 INFO - 'PWD': '/builds/slave/test', 03:03:32 INFO - 'SHELL': '/bin/bash', 03:03:32 INFO - 'SHLVL': '1', 03:03:32 INFO - 'TERM': 'linux', 03:03:32 INFO - 'TMOUT': '86400', 03:03:32 INFO - 'USER': 'cltbld', 03:03:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:32 INFO - '_': '/tools/buildbot/bin/python'} 03:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:32 INFO - Downloading/unpacking jsonschema==2.5.1 03:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:03:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:33 INFO - Downloading functools32-3.2.3-2.tar.gz 03:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:03:33 INFO - warning: no files found matching '*.txt' 03:03:33 INFO - no previously-included directories found matching 'build' 03:03:33 INFO - no previously-included directories found matching 'dist' 03:03:33 INFO - no previously-included directories found matching '.git*' 03:03:33 INFO - Installing collected packages: jsonschema, functools32 03:03:34 INFO - Running setup.py install for functools32 03:03:34 INFO - warning: no files found matching '*.txt' 03:03:34 INFO - no previously-included directories found matching 'build' 03:03:34 INFO - no previously-included directories found matching 'dist' 03:03:34 INFO - no previously-included directories found matching '.git*' 03:03:34 INFO - Successfully installed jsonschema functools32 03:03:34 INFO - Cleaning up... 03:03:34 INFO - Return code: 0 03:03:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:34 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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, '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': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', '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 03:03:34 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 03:03:34 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 03:03:34 INFO - Using env: {'DISPLAY': ':0', 03:03:34 INFO - 'HOME': '/home/cltbld', 03:03:34 INFO - 'LANG': 'en_US.UTF-8', 03:03:34 INFO - 'LANGUAGE': 'en_US:en', 03:03:34 INFO - 'LOGNAME': 'cltbld', 03:03:34 INFO - 'MAIL': '/var/mail/cltbld', 03:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:34 INFO - 'MOZ_NO_REMOTE': '1', 03:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:34 INFO - 'NO_EM_RESTART': '1', 03:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:34 INFO - 'PWD': '/builds/slave/test', 03:03:34 INFO - 'SHELL': '/bin/bash', 03:03:34 INFO - 'SHLVL': '1', 03:03:34 INFO - 'TERM': 'linux', 03:03:34 INFO - 'TMOUT': '86400', 03:03:34 INFO - 'USER': 'cltbld', 03:03:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:34 INFO - '_': '/tools/buildbot/bin/python'} 03:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:03:34 INFO - Cleaning up... 03:03:34 INFO - Return code: 0 03:03:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:34 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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, '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': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', '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 03:03:34 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 03:03:34 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 03:03:34 INFO - Using env: {'DISPLAY': ':0', 03:03:34 INFO - 'HOME': '/home/cltbld', 03:03:34 INFO - 'LANG': 'en_US.UTF-8', 03:03:34 INFO - 'LANGUAGE': 'en_US:en', 03:03:34 INFO - 'LOGNAME': 'cltbld', 03:03:34 INFO - 'MAIL': '/var/mail/cltbld', 03:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:34 INFO - 'MOZ_NO_REMOTE': '1', 03:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:34 INFO - 'NO_EM_RESTART': '1', 03:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:34 INFO - 'PWD': '/builds/slave/test', 03:03:34 INFO - 'SHELL': '/bin/bash', 03:03:34 INFO - 'SHLVL': '1', 03:03:34 INFO - 'TERM': 'linux', 03:03:34 INFO - 'TMOUT': '86400', 03:03:34 INFO - 'USER': 'cltbld', 03:03:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:34 INFO - '_': '/tools/buildbot/bin/python'} 03:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:35 INFO - Downloading blobuploader-1.2.4.tar.gz 03:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:03:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:03:35 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 03:03:35 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 03:03:35 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 03:03:35 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 03:03:35 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 03:03:35 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 03:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:03:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:03:36 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 03:03:36 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 03:03:36 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 03:03:36 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 03:03:36 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 03:03:36 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 03:03:36 INFO - Downloading docopt-0.6.1.tar.gz 03:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:03:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:03:36 INFO - Running setup.py install for blobuploader 03:03:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:03:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:03:36 INFO - Running setup.py install for requests 03:03:36 INFO - Running setup.py install for docopt 03:03:36 INFO - Successfully installed blobuploader requests docopt 03:03:36 INFO - Cleaning up... 03:03:36 INFO - Return code: 0 03:03:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:36 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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, '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': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', '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 03:03:36 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 03:03:36 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 03:03:36 INFO - Using env: {'DISPLAY': ':0', 03:03:36 INFO - 'HOME': '/home/cltbld', 03:03:36 INFO - 'LANG': 'en_US.UTF-8', 03:03:36 INFO - 'LANGUAGE': 'en_US:en', 03:03:36 INFO - 'LOGNAME': 'cltbld', 03:03:36 INFO - 'MAIL': '/var/mail/cltbld', 03:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:36 INFO - 'MOZ_NO_REMOTE': '1', 03:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:36 INFO - 'NO_EM_RESTART': '1', 03:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:36 INFO - 'PWD': '/builds/slave/test', 03:03:36 INFO - 'SHELL': '/bin/bash', 03:03:36 INFO - 'SHLVL': '1', 03:03:36 INFO - 'TERM': 'linux', 03:03:36 INFO - 'TMOUT': '86400', 03:03:36 INFO - 'USER': 'cltbld', 03:03:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:36 INFO - '_': '/tools/buildbot/bin/python'} 03:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:03:37 INFO - Running setup.py (path:/tmp/pip-N5_jNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:03:37 INFO - Running setup.py (path:/tmp/pip-mZWZgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:03:37 INFO - Running setup.py (path:/tmp/pip-M_k5jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:03:37 INFO - Running setup.py (path:/tmp/pip-hXWyNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:03:37 INFO - Running setup.py (path:/tmp/pip-As_BuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:03:37 INFO - Running setup.py (path:/tmp/pip-Ncstok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:03:37 INFO - Running setup.py (path:/tmp/pip-6v1QiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:03:37 INFO - Running setup.py (path:/tmp/pip-WWa82M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:03:37 INFO - Running setup.py (path:/tmp/pip-uAppvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:03:37 INFO - Running setup.py (path:/tmp/pip-qMeg0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:03:37 INFO - Running setup.py (path:/tmp/pip-qI1api-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:03:37 INFO - Running setup.py (path:/tmp/pip-R_bmCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:03:37 INFO - Running setup.py (path:/tmp/pip-7iux54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:03:38 INFO - Running setup.py (path:/tmp/pip-vU8o1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:38 INFO - Running setup.py (path:/tmp/pip-wAcxdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:03:38 INFO - Running setup.py (path:/tmp/pip-mpfpMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:03:38 INFO - Running setup.py (path:/tmp/pip-3iw1bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:03:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:03:38 INFO - Running setup.py install for manifestparser 03:03:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:03:38 INFO - Running setup.py install for mozcrash 03:03:38 INFO - Running setup.py install for mozdebug 03:03:38 INFO - Running setup.py install for mozdevice 03:03:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:03:38 INFO - Running setup.py install for mozfile 03:03:38 INFO - Running setup.py install for mozhttpd 03:03:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:03:38 INFO - Running setup.py install for mozinfo 03:03:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Running setup.py install for mozInstall 03:03:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Running setup.py install for mozleak 03:03:39 INFO - Running setup.py install for mozlog 03:03:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Running setup.py install for moznetwork 03:03:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Running setup.py install for mozprocess 03:03:39 INFO - Running setup.py install for mozprofile 03:03:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Running setup.py install for mozrunner 03:03:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:03:39 INFO - Running setup.py install for mozscreenshot 03:03:39 INFO - Running setup.py install for moztest 03:03:40 INFO - Running setup.py install for mozversion 03:03:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:03:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:03:40 INFO - Cleaning up... 03:03:40 INFO - Return code: 0 03:03:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, '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': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', '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 03:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:03:40 INFO - Using env: {'DISPLAY': ':0', 03:03:40 INFO - 'HOME': '/home/cltbld', 03:03:40 INFO - 'LANG': 'en_US.UTF-8', 03:03:40 INFO - 'LANGUAGE': 'en_US:en', 03:03:40 INFO - 'LOGNAME': 'cltbld', 03:03:40 INFO - 'MAIL': '/var/mail/cltbld', 03:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:40 INFO - 'MOZ_NO_REMOTE': '1', 03:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:40 INFO - 'NO_EM_RESTART': '1', 03:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:40 INFO - 'PWD': '/builds/slave/test', 03:03:40 INFO - 'SHELL': '/bin/bash', 03:03:40 INFO - 'SHLVL': '1', 03:03:40 INFO - 'TERM': 'linux', 03:03:40 INFO - 'TMOUT': '86400', 03:03:40 INFO - 'USER': 'cltbld', 03:03:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:40 INFO - '_': '/tools/buildbot/bin/python'} 03:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:03:40 INFO - Running setup.py (path:/tmp/pip-VSt_Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:03:40 INFO - Running setup.py (path:/tmp/pip-EDOxGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:03:40 INFO - Running setup.py (path:/tmp/pip-A1DHEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:03:40 INFO - Running setup.py (path:/tmp/pip-WXB8Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 03:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:03:40 INFO - Running setup.py (path:/tmp/pip-1OqwEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:03:40 INFO - Running setup.py (path:/tmp/pip-uGlwxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:03:40 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)) 03:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:03:40 INFO - Running setup.py (path:/tmp/pip-pBAgSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:03:40 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)) 03:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:03:40 INFO - Running setup.py (path:/tmp/pip-aNlwZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:03:40 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)) 03:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:03:40 INFO - Running setup.py (path:/tmp/pip-EniHwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:03:40 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)) 03:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:03:41 INFO - Running setup.py (path:/tmp/pip-NbKkje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:03:41 INFO - Running setup.py (path:/tmp/pip-C_MF0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:03:41 INFO - Running setup.py (path:/tmp/pip-DfgtNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 03:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:03:41 INFO - Running setup.py (path:/tmp/pip-6llAJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:03:41 INFO - Running setup.py (path:/tmp/pip-P9ANtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:41 INFO - Running setup.py (path:/tmp/pip-9sCYyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:41 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)) 03:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:03:41 INFO - Running setup.py (path:/tmp/pip-8mAp4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:03:41 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)) 03:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:03:41 INFO - Running setup.py (path:/tmp/pip-PtZ41D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:03:41 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)) 03:03:41 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)) 03:03:41 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)) 03:03:41 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)) 03:03:41 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:03:41 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:03:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:03:41 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 03:03:41 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 03:03:41 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 03:03:41 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 03:03:41 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 03:03:41 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 03:03:42 INFO - Downloading blessings-1.6.tar.gz 03:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:03:42 INFO - Installing collected packages: blessings 03:03:42 INFO - Running setup.py install for blessings 03:03:42 INFO - Successfully installed blessings 03:03:42 INFO - Cleaning up... 03:03:42 INFO - Return code: 0 03:03:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:03:43 INFO - Reading from file tmpfile_stdout 03:03:43 INFO - Current package versions: 03:03:43 INFO - argparse == 1.2.1 03:03:43 INFO - blessings == 1.6 03:03:43 INFO - blobuploader == 1.2.4 03:03:43 INFO - docopt == 0.6.1 03:03:43 INFO - functools32 == 3.2.3-2 03:03:43 INFO - jsonschema == 2.5.1 03:03:43 INFO - manifestparser == 1.1 03:03:43 INFO - mozInstall == 1.12 03:03:43 INFO - mozcrash == 1.0 03:03:43 INFO - mozdebug == 0.1 03:03:43 INFO - mozdevice == 0.50 03:03:43 INFO - mozfile == 1.2 03:03:43 INFO - mozhttpd == 0.7 03:03:43 INFO - mozinfo == 0.9 03:03:43 INFO - mozleak == 0.1 03:03:43 INFO - mozlog == 3.4 03:03:43 INFO - moznetwork == 0.27 03:03:43 INFO - mozprocess == 0.25 03:03:43 INFO - mozprofile == 0.28 03:03:43 INFO - mozrunner == 6.13 03:03:43 INFO - mozscreenshot == 0.1 03:03:43 INFO - mozsystemmonitor == 0.3 03:03:43 INFO - moztest == 0.8 03:03:43 INFO - mozversion == 1.4 03:03:43 INFO - psutil == 3.1.1 03:03:43 INFO - requests == 1.2.3 03:03:43 INFO - wsgiref == 0.1.2 03:03:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03:43 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')]} 03:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:43 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')]} 03:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:43 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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, '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': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', '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 03:03:43 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 03:03:43 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 03:03:43 INFO - Using env: {'DISPLAY': ':0', 03:03:43 INFO - 'HOME': '/home/cltbld', 03:03:43 INFO - 'LANG': 'en_US.UTF-8', 03:03:43 INFO - 'LANGUAGE': 'en_US:en', 03:03:43 INFO - 'LOGNAME': 'cltbld', 03:03:43 INFO - 'MAIL': '/var/mail/cltbld', 03:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:43 INFO - 'MOZ_NO_REMOTE': '1', 03:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:43 INFO - 'NO_EM_RESTART': '1', 03:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:43 INFO - 'PWD': '/builds/slave/test', 03:03:43 INFO - 'SHELL': '/bin/bash', 03:03:43 INFO - 'SHLVL': '1', 03:03:43 INFO - 'TERM': 'linux', 03:03:43 INFO - 'TMOUT': '86400', 03:03:43 INFO - 'USER': 'cltbld', 03:03:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:43 INFO - '_': '/tools/buildbot/bin/python'} 03:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:43 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)) 03:03:43 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)) 03:03:43 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)) 03:03:43 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)) 03:03:43 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)) 03:03:43 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)) 03:03:43 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)) 03:03:43 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)) 03:03:43 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)) 03:03:43 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)) 03:03:43 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)) 03:03:43 INFO - Cleaning up... 03:03:43 INFO - Return code: 0 03:03:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:03:43 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')]} 03:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:43 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')]} 03:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:43 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 0x1fc01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, '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': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', '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 03:03:43 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 03:03:43 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 03:03:43 INFO - Using env: {'DISPLAY': ':0', 03:03:43 INFO - 'HOME': '/home/cltbld', 03:03:43 INFO - 'LANG': 'en_US.UTF-8', 03:03:43 INFO - 'LANGUAGE': 'en_US:en', 03:03:43 INFO - 'LOGNAME': 'cltbld', 03:03:43 INFO - 'MAIL': '/var/mail/cltbld', 03:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:43 INFO - 'MOZ_NO_REMOTE': '1', 03:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:43 INFO - 'NO_EM_RESTART': '1', 03:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:43 INFO - 'PWD': '/builds/slave/test', 03:03:43 INFO - 'SHELL': '/bin/bash', 03:03:43 INFO - 'SHLVL': '1', 03:03:43 INFO - 'TERM': 'linux', 03:03:43 INFO - 'TMOUT': '86400', 03:03:43 INFO - 'USER': 'cltbld', 03:03:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:43 INFO - '_': '/tools/buildbot/bin/python'} 03:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:03:43 INFO - Cleaning up... 03:03:43 INFO - Return code: 0 03:03:43 INFO - Running post-action listener: _resource_record_post_action 03:03:43 INFO - Running post-action listener: _start_resource_monitoring 03:03:43 INFO - Starting resource monitoring. 03:03:43 INFO - [mozharness: 2017-05-04 10:03:43.615242Z] Finished create-virtualenv step (success) 03:03:43 INFO - [mozharness: 2017-05-04 10:03:43.615810Z] Running install step. 03:03:43 INFO - Running pre-action listener: _resource_record_pre_action 03:03:43 INFO - Running main action method: install 03:03:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:03:43 INFO - Reading from file tmpfile_stdout 03:03:43 INFO - Detecting whether we're running mozinstall >=1.0... 03:03:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:03:43 INFO - Reading from file tmpfile_stdout 03:03:43 INFO - Output received: 03:03:43 INFO - Usage: mozinstall [options] installer 03:03:43 INFO - Options: 03:03:43 INFO - -h, --help show this help message and exit 03:03:43 INFO - -d DEST, --destination=DEST 03:03:43 INFO - Directory to install application into. [default: 03:03:43 INFO - "/builds/slave/test"] 03:03:43 INFO - --app=APP Application being installed. [default: firefox] 03:03:43 INFO - mkdir: /builds/slave/test/build/application 03:03:43 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'] 03:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:04:00 INFO - Reading from file tmpfile_stdout 03:04:00 INFO - Output received: 03:04:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:04:00 INFO - Running post-action listener: _resource_record_post_action 03:04:00 INFO - [mozharness: 2017-05-04 10:04:00.087457Z] Finished install step (success) 03:04:00 INFO - [mozharness: 2017-05-04 10:04:00.087629Z] Running run-tests step. 03:04:00 INFO - Running pre-action listener: _resource_record_pre_action 03:04:00 INFO - Running main action method: run_tests 03:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:04:00 INFO - Python 2.7.3 03:04:00 INFO - Return code: 0 03:04:00 INFO - grabbing minidump binary from tooltool 03:04: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')]} 03:04:00 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 0x225b400>, '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 0x225c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:04:00 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 03:04:00 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 03:04:00 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 03:04:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:04:00 INFO - Return code: 0 03:04:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:04:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:04:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:04:00 INFO - ENV: RUST_BACKTRACE is now 1 03:04:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:04:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 03:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 03:04:00 INFO - Using env: {'DISPLAY': ':0', 03:04:00 INFO - 'HOME': '/home/cltbld', 03:04:00 INFO - 'LANG': 'en_US.UTF-8', 03:04:00 INFO - 'LANGUAGE': 'en_US:en', 03:04:00 INFO - 'LOGNAME': 'cltbld', 03:04:00 INFO - 'MAIL': '/var/mail/cltbld', 03:04:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:04:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:00 INFO - 'MOZ_NO_REMOTE': '1', 03:04:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:00 INFO - 'NO_EM_RESTART': '1', 03:04:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:00 INFO - 'PWD': '/builds/slave/test', 03:04:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:04:00 INFO - 'RUST_BACKTRACE': '1', 03:04:00 INFO - 'SHELL': '/bin/bash', 03:04:00 INFO - 'SHLVL': '1', 03:04:00 INFO - 'TERM': 'linux', 03:04:00 INFO - 'TMOUT': '86400', 03:04:00 INFO - 'USER': 'cltbld', 03:04:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1493892175.163750-969890786', 03:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:00 INFO - '_': '/tools/buildbot/bin/python'} 03:04:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 03:04:00 INFO - mozversion application_buildid: 20170504091416 03:04:00 INFO - mozversion application_changeset: a8d597ee6dd58306e62e55a07c4ab20958726d6a 03:04:00 INFO - mozversion application_display_name: Nightly 03:04:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:04:00 INFO - mozversion application_name: Firefox 03:04:00 INFO - mozversion application_remotingname: firefox 03:04:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:04:00 INFO - mozversion application_vendor: Mozilla 03:04:00 INFO - mozversion application_version: 55.0a1 03:04:00 INFO - mozversion platform_buildid: 20170504091416 03:04:00 INFO - mozversion platform_changeset: a8d597ee6dd58306e62e55a07c4ab20958726d6a 03:04:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:04:00 INFO - mozversion platform_version: 55.0a1 03:04:00 INFO - using testdate: 1493892240 03:04:00 INFO - actual date: 1493892240 03:04:00 INFO - starting webserver on 'localhost:40065' 03:04:00 INFO - SUITE-START | Running 2 tests 03:04:00 INFO - TEST-START | dromaeo_css 03:04:00 INFO - operating with platform_type : linux_ 03:04:00 INFO - Initialising browser for dromaeo_css test... 03:04:00 INFO - TEST-INFO | started process 15092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUXMyfM/profile http://localhost:40065/getInfo.html) 03:04:04 INFO - PID 15092 | __metrics Screen width/height:1600/1200 03:04:04 INFO - PID 15092 | colorDepth:24 03:04:04 INFO - PID 15092 | Browser inner width/height: 1024/695 03:04:04 INFO - PID 15092 | __metrics 03:04:05 INFO - PID 15092 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:04:05 INFO - PID 15092 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:04:06 INFO - TEST-INFO | 15092: exit 0 03:04:06 INFO - Browser initialized. 03:04:06 INFO - Running cycle 1/1 for dromaeo_css test... 03:04:06 INFO - TEST-INFO | started process 15189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUXMyfM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:18 INFO - PID 15189 | RSS: Main: 149901312 03:04:18 INFO - PID 15189 | 03:07:21 INFO - PID 15189 | Cycle 1(1): loaded http://localhost:40065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40065/tests/dromaeo/cssquery-ext.html) 03:07:23 INFO - PID 15189 | RSS: Main: 310235136 03:07:23 INFO - PID 15189 | 03:10:25 INFO - PID 15189 | Cycle 1(1): loaded http://localhost:40065/tests/dromaeo/cssquery-ext.html (next: http://localhost:40065/tests/dromaeo/cssquery-jquery.html) 03:10:26 INFO - PID 15189 | RSS: Main: 228536320 03:10:26 INFO - PID 15189 | 03:13:27 INFO - PID 15189 | Cycle 1(1): loaded http://localhost:40065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40065/tests/dromaeo/cssquery-mootools.html) 03:13:28 INFO - PID 15189 | RSS: Main: 217759744 03:13:28 INFO - PID 15189 | 03:16:29 INFO - PID 15189 | Cycle 1(1): loaded http://localhost:40065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40065/tests/dromaeo/cssquery-prototype.html) 03:16:30 INFO - PID 15189 | RSS: Main: 191176704 03:16:30 INFO - PID 15189 | 03:19:33 INFO - PID 15189 | Cycle 1(1): loaded http://localhost:40065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40065/tests/dromaeo/cssquery-yui.html) 03:19:34 INFO - PID 15189 | RSS: Main: 174862336 03:19:34 INFO - PID 15189 | 03:22:35 INFO - PID 15189 | Cycle 1(1): loaded http://localhost:40065/tests/dromaeo/cssquery-yui.html (next: http://localhost:40065/tests/dromaeo/cssquery-dojo.html) 03:22:35 INFO - PID 15189 | RSS: Main: 270098432 03:22:35 INFO - PID 15189 | 03:22:35 INFO - PID 15189 | __start_tp_report 03:22:35 INFO - PID 15189 | _x_x_mozilla_page_load 03:22:35 INFO - PID 15189 | _x_x_mozilla_page_load_details 03:22:35 INFO - PID 15189 | |i|pagename|runs| 03:22:35 INFO - PID 15189 | |0;dojo.html;3308.5698859148306;3309.387763263795;3331.383694016607;3332.100332910116;3373.915652108697;5697.1169468732305;5806.187133801272;5810.389909059551;5819.534437245021;5860.179574859523;5762.740676669549;5800.216970708953;5845.766169353232;5876.4123587641325;5951.58338916276;4794.304825800257;5037.370328708911;5134.563562097226;5146.253793199984;5232.7383630818495;5190.766415511311;5196;5259.500347466985;5265.4997775211295;5265.631405801595;5090.236464530313;5119.180931051014;5133.897322053575;5149.407818100929;5228.92156617651;5102.69383836971;5104.974475127638;5119.488051194888;5119.795208191668;5176.922346164811;5090.060671927903;5127.307813445212;5128.589712823003;5137.0496458154985;5137.48625137487;5649;5704.258446401983;5750.223719797816;5760.366359700472;5862.824115276549;6321.336259692712;6321.715522801485;6323.494120470351;6331.461825744817;6342.778002769927;6344;6382.042693595998;6383.106365108889;6387.584806987531;6392.9451640479265;5755.424457554211;5757.280339957505;5890.67601281925;5910.083936989773;5915.438033386821;6369.108324834527;6402.711877965503;6434.839129021719;6437.645929473924;6440;6087.026075827846;6116.944513560587;6118.3755344619085;6139.785107521216;6194.628322300677;6269.529785266032;6309.526785491014;6331.620102793847;6337.7781777637565;6346.524010699124;6128.3565225651555;6149.692515374213;6193.163922870355;6309.495240380758;6310.684465776692;6220.595661282002;6268.49852011838;6279;6289.0880822280515;6325.873482530324;4849.2968519564465;4849.636277279147;4854.635902307341;4883.267509873476;4895.192293271571;4250.192463431938;4267.487901451846;4285.7000009999;4286.614204721528;4312.827486900552;5822.3304320003745;5896.204012458349;5900.822975310747;5911.615744976562;5913.201717768132;6139.584134579286;6197.81406557804;6219.098230756515;6220.066989951453;6220.7511699532415;5931.347551769302;5960.254968128984;6017.819465416044;6024.608400453956;6026.849328766816;5531.032069387841;5531.3915469298345;5532.723363831792;5537.501624853782;5540.2243685884005;6601.570897891622;6608.933910660928;6611.438027767597;6621.602703837785;6622.4702023838945;6275;6281.152044473937;6323.557350985387;6332.3034466207755;6335.65153916539;6350.428461438492;6571.868562628816;6581.605103693793;6601.075849381186;6614.305497922841;6115.179495343419;6140.631562106288;6216.658083805253;6222.875542489215;6225.252969643671;6315.463185629273;6328.430441260309;6333.556651034568;6334.081558173947;6337;5930.466258036798;6011.849703757441;6015.368386319548;6028;6110.877782444238;6163.506919446523;6195.287541932736;6199.070139479114;6204.751809927552;6206.937930620636;6149.723262453111;6170.228721409824;6172.4136207060255;6173.907391389043;6189.845253868509;5970.880582388241;6019.337872833898;6119.510439164767;6121.84695382619;6141.6007959482495;5765.077587585966;5804.941950580609;5869.501092407193;5869.706514674334;5885.058390657474 03:22:35 INFO - PID 15189 | |1;ext.html;749.2245525880714;804.9919500804992;824.678375433581;1124.8537690100286;1142.0463912632952;28592;29106.563401548967;34921.30157396851;35860;35864.282714345696;37708.81145594275;38073.23853522928;38100.23799524008;38126;38232.61767382325;5441.59188060895;7085.964570177168;7221.602811845346;7244.239354867742;7246.021787058732;5497.422770609089;7006.264342244068;7188.173360063581;7196.568205907663;7200.207977122513;7268.127824661048;7278.599677017762;7300.780976570712;7301.707931682727;7312.5246858954;5553.72231388433;7222.855542889139;7270.127584689818;7275.599842008687;7282.380997615209;3983.382575700771;6959.860802783966;7062.187848397449;7123.7506687265695;7130.536515126552;34491;34670.306593868234;34722.30555388878;34856;34910.301793963976;3430.9142271443166;3441.5181874537584;3456.1532424555894;3462.290230502741;3464.930701385958;27847;28189.85905070482;28211.57682634762;28236.152915412364;28257.858710706314;3757.1546402059316;3766.7174961877695;3792.60177681345;3803.3724435468116;3840.7503512271614;183638;184315;184362;184470;184692.0765396178;45107;45308.3203751944;45354.77322613366;45377.31934020992;45465.545344546794;47320;47376.7631161842;47447.288290675664;47576;47608.285875711896;14484.420623174956;14566.781498277534;14585.562433127023;14600.707985840436;14604.926975365268;10111.544980475895;10310.32982856112;11911.880881191077;11940.104492163122;11953.641390758292;12338.876611233953;12414.689632759073;12436.689082773004;12589.307588082744;12638.304893230777;5088.974555127201;5152.929185943063;5156.561692256125;5229.294045303835;5259.500347466985;1033.5710680067687;1068.4497483795851;1071.4803320389606;1074.3500182389698;1121.7363919478917;24624;25286.87356563242;25361.112361067273;25401;25473.49053018966;1166.311875993168;1179.9528018879148;1181.4388165621433;1185.3895243949373;1206.5656363709058;12894.29081400532;13123.212607243597;13210.801837972438;13299.867001330056;13338.399772010283;235732;237733;238043;238051;239094;49460;50024.49975500198;50110.49889501058;50188.49811501838;50249;1467.3910327214087;1481.2445652716976;1483.44370860925;1501.9173945433106;1517.0821652900058;23604.409889752893;24763.50472990494;24799;24909.377265568506;24918.626220607068;45954;46887;46896.29655555238;46953.530464694915;47118.29322560233;194003;194214;194703;196261.2056336915;196450;27717.168484945483;28044.158675239774;30738;30932.69067309298;30994.380112397175;37726.245475090895;37985.620143799315;39596.802015989735;39692.83225261306;40002.39996399998;29442.11673649794;29851;30059.09822705235;30361.392772144874;30458.54312185275;29514;29747.553786692784;30002.84998574993;30604.387912242077;30680.539791902695;34888.65111348854;35038.64961350354;35042.29915401729;35200.471992919614;35339.823300883334;28013;28585.571216431355;28620.713792861803;29501.557476638296;29767;22811.31566053021;23803;24030.39924001844;24067.759322406553;24140.39649008789 03:22:35 INFO - PID 15189 | |2;jquery.html;439.55165730954445;440.9977950110251;447.79625270501936;452.60623257765747;461.08934853664005;18538.81461185388;19813.801861981377;20453.590928181427;20621.896890515527;20674.6898796518;20057.799422005814;20845.895770521165;21190.788092119074;21417.57164856706;21437.67843482349;5463.726813659321;5582.413846546115;5607.803726869561;5648.887022259552;5668.348139963916;5483.945160548404;5572.693501857396;5603.887922241553;5616.85957851055;5621.578381621374;5579.13523403873;5591.3569939456875;5599.916001259984;5602.971985140089;5604.346717718283;5413.485718856702;5543.307086614193;5564.805231816867;5578.386377498472;5584.636998595099;5071.264666623319;5088.516590923893;5096.847094587169;5097.260897169889;5098.847034588968;24505.632415513603;24774.25677229686;25062.749372506405;25327;25536.872315638488;2206.702095217141;2222.844400891938;2228.888555572215;2243.741969673492;2243.7756224377595;16561.917190414093;17399.391021314193;17419.5645108872;17446.127693615395;17566.82433175665;2190.7042549255966;2231.2190733243397;2277.760835112306;2284.8971796269207;2290.0954123121273;96670.51664741701;97343;97661;97831.51084244534;98541;11838.171328007129;12335.074869384653;12378.44297006637;12424.75150496985;12616.684582885502;17449.38927137544;17476.213570389362;17488.5627859302;17505.824941750674;17539.649207015787;8601.5699215039;8699.608062709936;8900.332475064266;8936.151065648754;8936.46381217129;7929.422937545321;7957.204279572113;8184.427090103635;8210.220029097227;8229.094799572042;7541.547507149478;7659.502132361378;8056.758297251092;8057.717979870677;8088.272055515032;2176.5211653436218;2183.1813070098715;2203.5042115524197;2260.694806201142;2296.127471560796;1042.99478502607;1077.3051381858656;1081.378207530673;1092.8306112552566;1093.9890601094046;20645;20761.896190519252;20811.1675532977;20881.68677469839;20887.58224835495;1090.5201711247025;1091.1761619976867;1092.7432053467428;1101.2731597145846;1112.2214449885112;10883.23817332779;11139.824550981253;11145.74515759588;11319.320840749582;11348.319100853974;481402;485986;507829;516859;518550;98372;99407;99767;100975.49512252392;103183;1180.6340034589305;1188.2157775867886;1216.0757824053605;1217.8112392579164;1228.4287806170173;16867;17155.313787448362;17439.30242790274;17822;18022.279108836025;44759.77620111879;44818;45720.31419528776;45978.770106149255;46021.309680355494;56526.43473565212;57180.71409642925;58650.70674646599;59162.40837591741;59529.40470595239;9299.488528130747;9372.828396450444;9464.810703785748;9503.336916039803;9528.094830991045;14639.780403293746;14813.851861481678;14945.252737363306;15065.774013390028;15088.471903483325;12392.876071239172;12500.624981250578;12730.809037864254;13449.260290684106;13488.5279015234;11451.198416111125;11462.312261264351;11700.88299117032;12039.518419263482;12123.333216672814;12790.104692671424;12958;13203.537876174289;13365;13410.463581456632;9179.495127768037;9418.57616407277;9480.407422467666;9649.758756031155;9948.751281218027;12378.442970066188;12419.19275247106;12547.874521254671;12590.307533085403;12761.61715148547 03:22:35 INFO - PID 15189 | |3;mootools.html;1199.9520019199233;1327.541998010686;1363.5115913457935;1383.4604504243343;1384.515419603139;9423.952880235598;10367.274290799647;10810.891891081097;10880.564777408894;10903.618373356934;10633.627823026196;10660.78678426431;10678.145748340134;10724.410157441338;10734.194935379859;1863.49685584892;1933.7389452423884;2323.163661082005;2375.6555299481565;2379.274321331993;2305.250793492113;2445.7554244575576;2448.681671382718;2449.5713250181234;2451.4361696809747;2370.146747171017;2381.0832829360647;2388.36708272308;2392.473655795722;2392.9162479313227;2238.7761223877483;2242.5963326601204;2254.7632498587577;2255.391044417998;2257.762934891829;2125.787421257877;2156.9568608627737;2159.84881058326;2284.565932472825;2330.498942727305;11175.050120739746;11292.491837867316;11302.434878256054;11311.943440282828;11321.943390283079;6332.366763323631;6541.869162616768;6565.24499682533;6573.737050517973;6576.80269591913;3764.5670747863796;3806.638369354907;3914.354131568288;3935.193285376491;3945.7237993340477;1290.1742884553894;1300.1354099523805;1329.1028555724943;1356.071091302461;1361.4282001559368;17407;17466.563335916704;17501.649967000587;17516.21177047036;17532.649347013117;5536.390996990328;5743.736377996834;5749.13762935563;5761.337446193657;5917.31950825652;14034.508792192224;14290.285485725672;14295.499657512146;14335.27629750344;14378.784318235235;6614.8346291343105;6637.502187335969;6640.568363056386;6669;6747.662616869137;6140.815775526741;6155.384461553809;6165.660888651168;6214.036824292242;6289.842753931097;4586.3579098926175;4597.356370108188;4616.76916154191;4644.86065418038;4684.929726054112;1415.815943927283;1439.5321520505877;1441.4810668159455;1471.2570152073135;1479.4599971010505;847.326375531454;864.4726716702806;879.4811061473761;888.1562515610067;909.5361365703407;6645.966770166118;6662.83342916431;6685.866282674417;6752.358525940028;6805.319468053155;646.4602057282128;652.5040968863698;653.4902775834856;658;667.0627767985891;4061.5735347788645;4070.816813243411;4085.9387109193385;4088.448059511987;4112.1439399984065;14505.927470362582;15215.31531081104;15305.158216297988;15326.23368831554;15345.386184552715;15044.323005464781;15068.773968390484;15135.924320378328;15137.545873623809;15147.091174529563;9224.723258302261;9412.294077944181;9555.61777528891;9594.184494317922;9648.228141748783;6853;6854.485913556404;6858.759943401957;6894.517383783288;6918;13491.730165396833;13553;13976.021678482408;13987.790183147057;13989.860101398855;13795;14376.137431754129;14386.35261413218;14396.568102956928;14484.710305793615;8918.955405223192;9473;9587.808243834945;9609.51952402391;9620.75948101303;11113.944430277797;11235.943820280847;11284.661460156209;11310.660680179608;11320.547178113113;8831.955840221015;8890;9077.546122693706;9202.493862837608;9228.815423691354;9081.818363632823;9092.363534552518;9208.447493150432;9234.399764015317;9279.67521136757;8198.180181981992;8227.917720822716;8247.175282471704;8320.667173313243;8330.250277475056;6125.571210015434;6198.2252218472695;6210.658413787285;6242.375762423721;6455.4512866406885;6204.72078756448;6211.16149319836;6247.9062814056915;6279.905801413074;6382.393672601095 03:22:35 INFO - PID 15189 | |4;prototype.html;385.73769836511195;402.1855742122202;420.5311078147865;425.1433361776022;438.98683039508825;5574.526165275951;5637.154426835971;5770.336411312695;5831.825045248639;5844.211031510745;5493.642913210639;5681.375048744635;5696.25948626679;5711.144427786107;5723.799667011655;4344.91310173798;4367.541408152146;4384.842913102561;4391.099824535962;4400.251957167281;4188.518320393148;4273.337632666941;4284.957150428502;4307.289297265947;4406.36107764374;4013.739106958053;4232.555581663927;4321.308590625501;4328;4365.573025175238;4316.935245971313;4328.480582330125;4335.6965012449145;4363.301871700544;4368.956310436887;3817.9427308590393;3834.2523207974455;3835.6383483863106;3840.0783811885226;3841.9231615367817;5469.015577196104;5554.1391084381985;5584.636998595079;5585.944140558624;5606.495415412592;5132.332796736438;5138.229265610151;5151;5153.252778347119;5157.53582177602;5909.320428150775;6048.667323297217;6061.151438798572;6084.908726369108;6112.174856394418;4281.336392859112;4300.935485967713;4300.935485967713;4303.419038429804;4313.97843010783;6317.4946004319545;6369.5222858285815;6374.58565193261;6396.432873945867;6403.263624683174;4296.806643701041;4385;4391.494978077498;4394.143142087326;4398.208322501981;4190;4279.529251782302;4424.60178583929;4438.578335058164;4454.510003899569;4963.280324352949;5053.090443720165;5077.746112694351;5090.160123579642;5115.820946266863;6087.421694938974;6103.816885493442;6106.084087386927;6133.570650054453;6171.876562468726;1467.3103641288578;1499.572621802781;1521.3838395449861;1522.7335216337096;1523.0937592132664;1001.6594357918343;1020.6631811502186;1033.4729288062993;1037.2531777120462;1037.5123691864812;5838.5329173666005;5858.56060795442;5869.765209391577;5922.3485416604135;5946.226990491208;6252.218472690914;6253.6560489173535;6263.217097862767;6265.8746825063245;6294.059163556678;5754.482096611241;5907.172995780594;5914.615549989237;5925.318588362394;5934.554908381889;3289.3914625794305;3317.3365326934227;3330.6003279606603;3331.0346895331872;3358;6304.527160462983;6553.541252112402;6586.308437614078;6651.16860392451;6667.86664266712;6454.741810327534;6456.677166141674;6478.967605162038;6495.382938620824;6498.415142637185;6345.809625711236;6561.179852518435;6613.404793568602;6620.768273110418;6637.701303441357;6306.558540902276;6321.336259692666;6346.111544383698;6352.714127864165;6359.5866268694235;5999.90003498772;6265.310815810166;6274.937250627618;6283.151774510383;6305.180326557518;6572.474202063728;6627.304133065959;6629.171353580802;6630;6636;4224.408582798349;4296.699231053796;4378.408914796461;4403.8018289176425;4408.470983482002;6100.6949652516305;6264.5301602379095;6271.937280627135;6273.964795808641;6296.433321000949;6028.5177185825905;6030.668313242813;6039.698015099315;6047.576669633084;6082.908756368746;5917.556183286185;6082.60463069899;6094.299155597163;6114.57197996136;6128.8774224516155;6070.332263451105;6083.239595050619;6085.361037091042;6086.261182467995;6092.969535152296;5989.580729348903;6105.603135796337;6131.724072416841;6169.660668663087;6210;5935.317438494629;6010.759569617167;6022.307434645072;6030.7889223876955;6039.486643635164 03:22:35 INFO - PID 15189 | |5;yui.html;858.2790456016944;867.1675191815856;869.8825658536098;885.7519894429562;896.9327300452468;16722;16747.16264186792;17547.2103755331;17559.47321580353;17566.209520571574;16575;17168.656626867454;17175.312987480516;17300.740488892647;17334.219960101793;901.5717534171282;910.940788848726;912.2063804490103;913.2967614936495;913.3606475467167;959.3476436023501;992.8262554053048;1003.0721582536162;1003.3027046202892;1003.8193125237455;1062.2511129653576;1064.5103252503857;1065.1851333729703;1066.003286926726;1068.3750006246355;1044.7127040063967;1053.857729206555;1059.3802625464075;1061.1192710050677;1061.2465149743691;771.9845603087963;772.212343409719;773.0337078651686;773.0761739721036;773.3928865840345;15816.841831581653;15899.761503577456;15943.681126377523;17466.214020369112;17680.469585912444;18958.715619265586;19097.949612771292;19288.614227715367;19378.1279842406;19707.507312317164;14580.854191458056;14666.120032798066;14682.853171468256;14829.18439485828;14900.329485173193;3441.0537102296817;3462.0306314232057;3465.6707612776745;3468.9653103469145;3469.930601387983;95216;95934.52032739791;96035.51982240114;97042.51478742632;98974.50512747391;14170.787438188436;14263.42946282158;14284.57146285613;14395.208263545395;14522;27422.177334679993;27480.58779118315;27670.446591068066;28122.85938570294;28190.71809281922;7690.577018264049;7693.6537855795505;7713.884291735629;7740.148583655793;7773.18381569927;4004.6796256299426;4103.97948010258;4110.034141976633;4113.321301985139;4136.420901073852;4577.702449340783;4616.584507394351;4666.976665116721;4673.322368256584;4688.789004494806;855.6235256487125;877.455977294069;886.4636894678627;887.8268737596236;888.8488956877346;721.5201890742702;739.9704011839574;745.4781652843031;759.2028370211256;775.1628241499168;11433.656990290137;12562.120651554304;12650.873491265154;12877.484900604059;13100.410481528354;732.6263605561202;736.9226231245749;737.7417903733758;743.7173873927873;753.1376573822942;5633.492985631231;5641.774329026793;5782.826515204551;5821.18503409523;5828.504577110993;81962.59018704988;82121.58939205385;82254;82568.58715706383;83112.58443707864;68861.31138688649;69174.65412672904;73117;73816.63091684507;74299.62850185715;58030;60349.69825150846;61238.69380653157;62876;64435.355646442935;10836.458177091272;10905.672829815117;11518.769624607294;11717.88282117168;11738.765224695288;32939.50590741189;33884.152896176805;34576;34704.30591388208;37106.44340334951;41334.37998429966;41967.16065678608;42977.3553396693;43175.136497270505;43334.56665433432;14898.98863653393;15188.240587970336;15197.17633883941;15345.156016419203;15701.842981570495;17878.28486860511;18701.719474207624;19083.045847707835;19334;19635.11641976143;17194.398196063077;17276.74084888753;17772.91113544424;18965.146568404733;19363.709544356563;16329.755053673967;16847.663046739242;16912.661746765243;18353;18419.81580184181;17108.315667373165;17712.025838579;17872.55318617045;18017;18257.634847303245;11019;11184.328940263611;11186.216964812385;11310.434478276218;11680.415979201176;12481.563145290234;13850.930745346208;13872.306384680523;14116.717665646835;14904.478343257933 03:22:35 INFO - PID 15189 | __end_tp_report 03:22:35 INFO - PID 15189 | __start_cc_report 03:22:35 INFO - PID 15189 | _x_x_mozilla_cycle_collect,1704 03:22:35 INFO - PID 15189 | __end_cc_report 03:22:35 INFO - PID 15189 | __startTimestamp1493893355953__endTimestamp 03:22:35 INFO - PID 15189 | 03:22:35 INFO - PID 15189 | ------- Summary: start ------- 03:22:35 INFO - PID 15189 | Number of tests: 6 03:22:35 INFO - PID 15189 | 03:22:35 INFO - PID 15189 | [#0] dojo.html Cycles:165 Average:5799.23 Median:6019.34 stddev:696.94 (11.6%) stddev-sans-first:671.13 03:22:35 INFO - PID 15189 | Values: 3308.6 3309.4 3331.4 3332.1 3373.9 5697.1 5806.2 5810.4 5819.5 5860.2 5762.7 5800.2 5845.8 5876.4 5951.6 4794.3 5037.4 5134.6 5146.3 5232.7 5190.8 5196.0 5259.5 5265.5 5265.6 5090.2 5119.2 5133.9 5149.4 5228.9 5102.7 5105.0 5119.5 5119.8 5176.9 5090.1 5127.3 5128.6 5137.0 5137.5 5649.0 5704.3 5750.2 5760.4 5862.8 6321.3 6321.7 6323.5 6331.5 6342.8 6344.0 6382.0 6383.1 6387.6 6392.9 5755.4 5757.3 5890.7 5910.1 5915.4 6369.1 6402.7 6434.8 6437.6 6440.0 6087.0 6116.9 6118.4 6139.8 6194.6 6269.5 6309.5 6331.6 6337.8 6346.5 6128.4 6149.7 6193.2 6309.5 6310.7 6220.6 6268.5 6279.0 6289.1 6325.9 4849.3 4849.6 4854.6 4883.3 4895.2 4250.2 4267.5 4285.7 4286.6 4312.8 5822.3 5896.2 5900.8 5911.6 5913.2 6139.6 6197.8 6219.1 6220.1 6220.8 5931.3 5960.3 6017.8 6024.6 6026.8 5531.0 5531.4 5532.7 5537.5 5540.2 6601.6 6608.9 6611.4 6621.6 6622.5 6275.0 6281.2 6323.6 6332.3 6335.7 6350.4 6571.9 6581.6 6601.1 6614.3 6115.2 6140.6 6216.7 6222.9 6225.3 6315.5 6328.4 6333.6 6334.1 6337.0 5930.5 6011.8 6015.4 6028.0 6110.9 6163.5 6195.3 6199.1 6204.8 6206.9 6149.7 6170.2 6172.4 6173.9 6189.8 5970.9 6019.3 6119.5 6121.8 6141.6 5765.1 5804.9 5869.5 5869.7 5885.1 03:22:35 INFO - PID 15189 | 03:22:35 INFO - PID 15189 | [#1] ext.html Cycles:180 Average:36384.24 Median:30709.27 stddev:53765.52 (175.1%) stddev-sans-first:53849.77 03:22:35 INFO - PID 15189 | Values: 749.2 805.0 824.7 1124.9 1142.0 28592.0 29106.6 34921.3 35860.0 35864.3 37708.8 38073.2 38100.2 38126.0 38232.6 5441.6 7086.0 7221.6 7244.2 7246.0 5497.4 7006.3 7188.2 7196.6 7200.2 7268.1 7278.6 7300.8 7301.7 7312.5 5553.7 7222.9 7270.1 7275.6 7282.4 3983.4 6959.9 7062.2 7123.8 7130.5 34491.0 34670.3 34722.3 34856.0 34910.3 3430.9 3441.5 3456.2 3462.3 3464.9 27847.0 28189.9 28211.6 28236.2 28257.9 3757.2 3766.7 3792.6 3803.4 3840.8 183638.0 184315.0 184362.0 184470.0 184692.1 45107.0 45308.3 45354.8 45377.3 45465.5 47320.0 47376.8 47447.3 47576.0 47608.3 14484.4 14566.8 14585.6 14600.7 14604.9 10111.5 10310.3 11911.9 11940.1 11953.6 12338.9 12414.7 12436.7 12589.3 12638.3 5089.0 5152.9 5156.6 5229.3 5259.5 1033.6 1068.4 1071.5 1074.4 1121.7 24624.0 25286.9 25361.1 25401.0 25473.5 1166.3 1180.0 1181.4 1185.4 1206.6 12894.3 13123.2 13210.8 13299.9 13338.4 235732.0 237733.0 238043.0 238051.0 239094.0 49460.0 50024.5 50110.5 50188.5 50249.0 1467.4 1481.2 1483.4 1501.9 1517.1 23604.4 24763.5 24799.0 24909.4 24918.6 45954.0 46887.0 46896.3 46953.5 47118.3 194003.0 194214.0 194703.0 196261.2 196450.0 27717.2 28044.2 30738.0 30932.7 30994.4 37726.2 37985.6 39596.8 39692.8 40002.4 29442.1 29851.0 30059.1 30361.4 30458.5 29514.0 29747.6 30002.8 30604.4 30680.5 34888.7 35038.6 35042.3 35200.5 35339.8 28013.0 28585.6 28620.7 29501.6 29767.0 22811.3 23803.0 24030.4 24067.8 24140.4 03:22:35 INFO - PID 15189 | 03:22:35 INFO - PID 15189 | [#2] jquery.html Cycles:180 Average:30924.37 Median:2243.76 stddev:83147.02 (3705.7%) stddev-sans-first:83348.76 03:22:35 INFO - PID 15189 | Values: 439.6 441.0 447.8 452.6 461.1 18538.8 19813.8 20453.6 20621.9 20674.7 20057.8 20845.9 21190.8 21417.6 21437.7 5463.7 5582.4 5607.8 5648.9 5668.3 5483.9 5572.7 5603.9 5616.9 5621.6 5579.1 5591.4 5599.9 5603.0 5604.3 5413.5 5543.3 5564.8 5578.4 5584.6 5071.3 5088.5 5096.8 5097.3 5098.8 24505.6 24774.3 25062.7 25327.0 25536.9 2206.7 2222.8 2228.9 2243.7 2243.8 16561.9 17399.4 17419.6 17446.1 17566.8 2190.7 2231.2 2277.8 2284.9 2290.1 96670.5 97343.0 97661.0 97831.5 98541.0 11838.2 12335.1 12378.4 12424.8 12616.7 17449.4 17476.2 17488.6 17505.8 17539.6 8601.6 8699.6 8900.3 8936.2 8936.5 7929.4 7957.2 8184.4 8210.2 8229.1 7541.5 7659.5 8056.8 8057.7 8088.3 2176.5 2183.2 2203.5 2260.7 2296.1 1043.0 1077.3 1081.4 1092.8 1094.0 20645.0 20761.9 20811.2 20881.7 20887.6 1090.5 1091.2 1092.7 1101.3 1112.2 10883.2 11139.8 11145.7 11319.3 11348.3 481402.0 485986.0 507829.0 516859.0 518550.0 98372.0 99407.0 99767.0 100975.5 103183.0 1180.6 1188.2 1216.1 1217.8 1228.4 16867.0 17155.3 17439.3 17822.0 18022.3 44759.8 44818.0 45720.3 45978.8 46021.3 56526.4 57180.7 58650.7 59162.4 59529.4 9299.5 9372.8 9464.8 9503.3 9528.1 14639.8 14813.9 14945.3 15065.8 15088.5 12392.9 12500.6 12730.8 13449.3 13488.5 11451.2 11462.3 11700.9 12039.5 12123.3 12790.1 12958.0 13203.5 13365.0 13410.5 9179.5 9418.6 9480.4 9649.8 9948.8 12378.4 12419.2 12547.9 12590.3 12761.6 03:22:35 INFO - PID 15189 | 03:22:35 INFO - PID 15189 | [#3] mootools.html Cycles:180 Average:7224.49 Median:3860.50 stddev:4695.88 (121.6%) stddev-sans-first:4687.23 03:22:35 INFO - PID 15189 | Values: 1200.0 1327.5 1363.5 1383.5 1384.5 9424.0 10367.3 10810.9 10880.6 10903.6 10633.6 10660.8 10678.1 10724.4 10734.2 1863.5 1933.7 2323.2 2375.7 2379.3 2305.3 2445.8 2448.7 2449.6 2451.4 2370.1 2381.1 2388.4 2392.5 2392.9 2238.8 2242.6 2254.8 2255.4 2257.8 2125.8 2157.0 2159.8 2284.6 2330.5 11175.1 11292.5 11302.4 11311.9 11321.9 6332.4 6541.9 6565.2 6573.7 6576.8 3764.6 3806.6 3914.4 3935.2 3945.7 1290.2 1300.1 1329.1 1356.1 1361.4 17407.0 17466.6 17501.6 17516.2 17532.6 5536.4 5743.7 5749.1 5761.3 5917.3 14034.5 14290.3 14295.5 14335.3 14378.8 6614.8 6637.5 6640.6 6669.0 6747.7 6140.8 6155.4 6165.7 6214.0 6289.8 4586.4 4597.4 4616.8 4644.9 4684.9 1415.8 1439.5 1441.5 1471.3 1479.5 847.3 864.5 879.5 888.2 909.5 6646.0 6662.8 6685.9 6752.4 6805.3 646.5 652.5 653.5 658.0 667.1 4061.6 4070.8 4085.9 4088.4 4112.1 14505.9 15215.3 15305.2 15326.2 15345.4 15044.3 15068.8 15135.9 15137.5 15147.1 9224.7 9412.3 9555.6 9594.2 9648.2 6853.0 6854.5 6858.8 6894.5 6918.0 13491.7 13553.0 13976.0 13987.8 13989.9 13795.0 14376.1 14386.4 14396.6 14484.7 8919.0 9473.0 9587.8 9609.5 9620.8 11113.9 11235.9 11284.7 11310.7 11320.5 8832.0 8890.0 9077.5 9202.5 9228.8 9081.8 9092.4 9208.4 9234.4 9279.7 8198.2 8227.9 8247.2 8320.7 8330.3 6125.6 6198.2 6210.7 6242.4 6455.5 6204.7 6211.2 6247.9 6279.9 6382.4 03:22:35 INFO - PID 15189 | 03:22:35 INFO - PID 15189 | [#4] prototype.html Cycles:180 Average:5105.97 Median:5841.37 stddev:1544.40 (26.4%) stddev-sans-first:1507.54 03:22:35 INFO - PID 15189 | Values: 385.7 402.2 420.5 425.1 439.0 5574.5 5637.2 5770.3 5831.8 5844.2 5493.6 5681.4 5696.3 5711.1 5723.8 4344.9 4367.5 4384.8 4391.1 4400.3 4188.5 4273.3 4285.0 4307.3 4406.4 4013.7 4232.6 4321.3 4328.0 4365.6 4316.9 4328.5 4335.7 4363.3 4369.0 3817.9 3834.3 3835.6 3840.1 3841.9 5469.0 5554.1 5584.6 5585.9 5606.5 5132.3 5138.2 5151.0 5153.3 5157.5 5909.3 6048.7 6061.2 6084.9 6112.2 4281.3 4300.9 4300.9 4303.4 4314.0 6317.5 6369.5 6374.6 6396.4 6403.3 4296.8 4385.0 4391.5 4394.1 4398.2 4190.0 4279.5 4424.6 4438.6 4454.5 4963.3 5053.1 5077.7 5090.2 5115.8 6087.4 6103.8 6106.1 6133.6 6171.9 1467.3 1499.6 1521.4 1522.7 1523.1 1001.7 1020.7 1033.5 1037.3 1037.5 5838.5 5858.6 5869.8 5922.3 5946.2 6252.2 6253.7 6263.2 6265.9 6294.1 5754.5 5907.2 5914.6 5925.3 5934.6 3289.4 3317.3 3330.6 3331.0 3358.0 6304.5 6553.5 6586.3 6651.2 6667.9 6454.7 6456.7 6479.0 6495.4 6498.4 6345.8 6561.2 6613.4 6620.8 6637.7 6306.6 6321.3 6346.1 6352.7 6359.6 5999.9 6265.3 6274.9 6283.2 6305.2 6572.5 6627.3 6629.2 6630.0 6636.0 4224.4 4296.7 4378.4 4403.8 4408.5 6100.7 6264.5 6271.9 6274.0 6296.4 6028.5 6030.7 6039.7 6047.6 6082.9 5917.6 6082.6 6094.3 6114.6 6128.9 6070.3 6083.2 6085.4 6086.3 6093.0 5989.6 6105.6 6131.7 6169.7 6210.0 5935.3 6010.8 6022.3 6030.8 6039.5 03:22:35 INFO - PID 15189 | 03:22:35 INFO - PID 15189 | [#5] yui.html Cycles:180 Average:19074.30 Median:27896.65 stddev:23467.32 (84.1%) stddev-sans-first:23493.29 03:22:35 INFO - PID 15189 | Values: 858.3 867.2 869.9 885.8 896.9 16722.0 16747.2 17547.2 17559.5 17566.2 16575.0 17168.7 17175.3 17300.7 17334.2 901.6 910.9 912.2 913.3 913.4 959.3 992.8 1003.1 1003.3 1003.8 1062.3 1064.5 1065.2 1066.0 1068.4 1044.7 1053.9 1059.4 1061.1 1061.2 772.0 772.2 773.0 773.1 773.4 15816.8 15899.8 15943.7 17466.2 17680.5 18958.7 19097.9 19288.6 19378.1 19707.5 14580.9 14666.1 14682.9 14829.2 14900.3 3441.1 3462.0 3465.7 3469.0 3469.9 95216.0 95934.5 96035.5 97042.5 98974.5 14170.8 14263.4 14284.6 14395.2 14522.0 27422.2 27480.6 27670.4 28122.9 28190.7 7690.6 7693.7 7713.9 7740.1 7773.2 4004.7 4104.0 4110.0 4113.3 4136.4 4577.7 4616.6 4667.0 4673.3 4688.8 855.6 877.5 886.5 887.8 888.8 721.5 740.0 745.5 759.2 775.2 11433.7 12562.1 12650.9 12877.5 13100.4 732.6 736.9 737.7 743.7 753.1 5633.5 5641.8 5782.8 5821.2 5828.5 81962.6 82121.6 82254.0 82568.6 83112.6 68861.3 69174.7 73117.0 73816.6 74299.6 58030.0 60349.7 61238.7 62876.0 64435.4 10836.5 10905.7 11518.8 11717.9 11738.8 32939.5 33884.2 34576.0 34704.3 37106.4 41334.4 41967.2 42977.4 43175.1 43334.6 14899.0 15188.2 15197.2 15345.2 15701.8 17878.3 18701.7 19083.0 19334.0 19635.1 17194.4 17276.7 17772.9 18965.1 19363.7 16329.8 16847.7 16912.7 18353.0 18419.8 17108.3 17712.0 17872.6 18017.0 18257.6 11019.0 11184.3 11186.2 11310.4 11680.4 12481.6 13850.9 13872.3 14116.7 14904.5 03:22:35 INFO - PID 15189 | -------- Summary: end -------- 03:22:35 INFO - PID 15189 | 03:22:36 INFO - TEST-INFO | 15189: exit 0 03:22:36 INFO - TEST-OK | dromaeo_css | took 1116427ms 03:22:36 INFO - TEST-START | kraken 03:22:36 INFO - operating with platform_type : linux_ 03:22:36 INFO - Initialising browser for kraken test... 03:22:36 INFO - TEST-INFO | started process 15522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfkQfLQ/profile http://localhost:40065/getInfo.html) 03:22:40 INFO - PID 15522 | __metrics Screen width/height:1600/1200 03:22:40 INFO - PID 15522 | colorDepth:24 03:22:40 INFO - PID 15522 | Browser inner width/height: 1024/695 03:22:40 INFO - PID 15522 | __metrics 03:22:41 INFO - PID 15522 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:22:41 INFO - PID 15522 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:22:42 INFO - TEST-INFO | 15522: exit 0 03:22:42 INFO - Browser initialized. 03:22:42 INFO - Running cycle 1/1 for kraken test... 03:22:42 INFO - TEST-INFO | started process 15621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfkQfLQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:54 INFO - PID 15621 | RSS: Main: 149770240 03:22:54 INFO - PID 15621 | 03:22:57 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40065/tests/kraken/driver.html?testName=audio-beat-detection) 03:22:58 INFO - PID 15621 | RSS: Main: 222871552 03:22:58 INFO - PID 15621 | 03:23:00 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40065/tests/kraken/driver.html?testName=audio-dft) 03:23:01 INFO - PID 15621 | RSS: Main: 183840768 03:23:01 INFO - PID 15621 | 03:23:04 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40065/tests/kraken/driver.html?testName=audio-fft) 03:23:04 INFO - PID 15621 | RSS: Main: 264105984 03:23:04 INFO - PID 15621 | 03:23:06 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40065/tests/kraken/driver.html?testName=audio-oscillator) 03:23:07 INFO - PID 15621 | RSS: Main: 175976448 03:23:07 INFO - PID 15621 | 03:23:09 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:23:09 INFO - PID 15621 | RSS: Main: 178667520 03:23:09 INFO - PID 15621 | 03:23:12 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40065/tests/kraken/driver.html?testName=imaging-darkroom) 03:23:13 INFO - PID 15621 | RSS: Main: 240091136 03:23:13 INFO - PID 15621 | 03:23:16 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40065/tests/kraken/driver.html?testName=imaging-desaturate) 03:23:17 INFO - PID 15621 | RSS: Main: 256065536 03:23:17 INFO - PID 15621 | 03:23:20 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40065/tests/kraken/driver.html?testName=json-parse-financial) 03:23:20 INFO - PID 15621 | RSS: Main: 269135872 03:23:20 INFO - PID 15621 | 03:23:22 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:23:22 INFO - PID 15621 | RSS: Main: 202473472 03:23:22 INFO - PID 15621 | 03:23:24 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40065/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:23:25 INFO - PID 15621 | RSS: Main: 208453632 03:23:25 INFO - PID 15621 | 03:23:27 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:23:27 INFO - PID 15621 | RSS: Main: 217415680 03:23:27 INFO - PID 15621 | 03:23:30 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:23:30 INFO - PID 15621 | RSS: Main: 226197504 03:23:30 INFO - PID 15621 | 03:23:33 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:23:34 INFO - PID 15621 | RSS: Main: 221929472 03:23:34 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | Cycle 1(1): loaded http://localhost:40065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40065/tests/kraken/driver.html?testName=ai-astar) 03:23:36 INFO - PID 15621 | RSS: Main: 272531456 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | __start_tp_report 03:23:36 INFO - PID 15621 | _x_x_mozilla_page_load 03:23:36 INFO - PID 15621 | _x_x_mozilla_page_load_details 03:23:36 INFO - PID 15621 | |i|pagename|runs| 03:23:36 INFO - PID 15621 | |0;ai-astar;108;110;110;110;111;111;109;108;110;110 03:23:36 INFO - PID 15621 | |1;audio-beat-detection;144;119;119;157;118;119;121;117;137;118 03:23:36 INFO - PID 15621 | |2;audio-dft;162;163;162;164;162;163;165;164;163;162 03:23:36 INFO - PID 15621 | |3;audio-fft;73;75;75;110;75;74;75;74;94;74 03:23:36 INFO - PID 15621 | |4;audio-oscillator;82;83;105;82;82;83;100;82;82;110 03:23:36 INFO - PID 15621 | |5;imaging-gaussian-blur;114;113;114;114;115;115;115;113;113;113 03:23:36 INFO - PID 15621 | |6;imaging-darkroom;148;147;147;149;148;147;147;148;147;148 03:23:36 INFO - PID 15621 | |7;imaging-desaturate;95;94;94;95;94;94;94;94;94;94 03:23:36 INFO - PID 15621 | |8;json-parse-financial;46;45;45;45;46;49;46;46;47;45 03:23:36 INFO - PID 15621 | |9;json-stringify-tinderbox;55;55;55;55;56;55;55;56;56;55 03:23:36 INFO - PID 15621 | |10;stanford-crypto-aes;81;82;82;81;83;83;82;97;82;81 03:23:36 INFO - PID 15621 | |11;stanford-crypto-ccm;127;133;133;133;131;126;124;127;171;123 03:23:36 INFO - PID 15621 | |12;stanford-crypto-pbkdf2;196;173;185;180;186;184;184;181;175;174 03:23:36 INFO - PID 15621 | |13;stanford-crypto-sha256-iterative;69;65;65;65;66;65;63;63;65;65 03:23:36 INFO - PID 15621 | __end_tp_report 03:23:36 INFO - PID 15621 | __start_cc_report 03:23:36 INFO - PID 15621 | _x_x_mozilla_cycle_collect,1664 03:23:36 INFO - PID 15621 | __end_cc_report 03:23:36 INFO - PID 15621 | __startTimestamp1493893416420__endTimestamp 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | ------- Summary: start ------- 03:23:36 INFO - PID 15621 | Number of tests: 14 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.06 (1.0%) stddev-sans-first:0.93 03:23:36 INFO - PID 15621 | Values: 108.0 110.0 110.0 110.0 111.0 111.0 109.0 108.0 110.0 110.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:120.00 stddev:14.06 (11.7%) stddev-sans-first:13.48 03:23:36 INFO - PID 15621 | Values: 144.0 119.0 119.0 157.0 118.0 119.0 121.0 117.0 137.0 118.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.05 (0.6%) stddev-sans-first:1.05 03:23:36 INFO - PID 15621 | Values: 162.0 163.0 162.0 164.0 162.0 163.0 165.0 164.0 163.0 162.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#3] audio-fft Cycles:10 Average:79.90 Median:75.00 stddev:12.26 (16.3%) stddev-sans-first:12.75 03:23:36 INFO - PID 15621 | Values: 73.0 75.0 75.0 110.0 75.0 74.0 75.0 74.0 94.0 74.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:82.00 stddev:11.23 (13.7%) stddev-sans-first:11.61 03:23:36 INFO - PID 15621 | Values: 82.0 83.0 105.0 82.0 82.0 83.0 100.0 82.0 82.0 110.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 03:23:36 INFO - PID 15621 | Values: 114.0 113.0 114.0 114.0 115.0 115.0 115.0 113.0 113.0 113.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:23:36 INFO - PID 15621 | Values: 148.0 147.0 147.0 149.0 148.0 147.0 147.0 148.0 147.0 148.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:23:36 INFO - PID 15621 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#8] json-parse-financial Cycles:10 Average:46.00 Median:46.00 stddev:1.25 (2.7%) stddev-sans-first:1.32 03:23:36 INFO - PID 15621 | Values: 46.0 45.0 45.0 45.0 46.0 49.0 46.0 46.0 47.0 45.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 03:23:36 INFO - PID 15621 | Values: 55.0 55.0 55.0 55.0 56.0 55.0 55.0 56.0 56.0 55.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.00 stddev:4.84 (5.9%) stddev-sans-first:5.05 03:23:36 INFO - PID 15621 | Values: 81.0 82.0 82.0 81.0 83.0 83.0 82.0 97.0 82.0 81.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:132.00 stddev:13.94 (10.6%) stddev-sans-first:14.63 03:23:36 INFO - PID 15621 | Values: 127.0 133.0 133.0 133.0 131.0 126.0 124.0 127.0 171.0 123.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.80 Median:184.00 stddev:6.89 (3.7%) stddev-sans-first:5.04 03:23:36 INFO - PID 15621 | Values: 196.0 173.0 185.0 180.0 186.0 184.0 184.0 181.0 175.0 174.0 03:23:36 INFO - PID 15621 | 03:23:36 INFO - PID 15621 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.66 (2.6%) stddev-sans-first:1.00 03:23:36 INFO - PID 15621 | Values: 69.0 65.0 65.0 65.0 66.0 65.0 63.0 63.0 65.0 65.0 03:23:36 INFO - PID 15621 | -------- Summary: end -------- 03:23:36 INFO - PID 15621 | 03:23:37 INFO - TEST-INFO | 15621: exit 0 03:23:37 INFO - TEST-OK | kraken | took 60838ms 03:23:37 INFO - SUITE-END | took 1177s 03:23:38 INFO - Completed test suite (00:19:37) 03:23:38 INFO - javascript benchmark 03:23:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7605.658447727014, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.5698859148306, 3309.387763263795, 3331.383694016607, 3332.100332910116, 3373.915652108697, 5697.1169468732305, 5806.187133801272, 5810.389909059551, 5819.534437245021, 5860.179574859523, 5762.740676669549, 5800.216970708953, 5845.766169353232, 5876.4123587641325, 5951.58338916276, 4794.304825800257, 5037.370328708911, 5134.563562097226, 5146.253793199984, 5232.7383630818495, 5190.766415511311, 5196.0, 5259.500347466985, 5265.4997775211295, 5265.631405801595, 5090.236464530313, 5119.180931051014, 5133.897322053575, 5149.407818100929, 5228.92156617651, 5102.69383836971, 5104.974475127638, 5119.488051194888, 5119.795208191668, 5176.922346164811, 5090.060671927903, 5127.307813445212, 5128.589712823003, 5137.0496458154985, 5137.48625137487, 5649.0, 5704.258446401983, 5750.223719797816, 5760.366359700472, 5862.824115276549, 6321.336259692712, 6321.715522801485, 6323.494120470351, 6331.461825744817, 6342.778002769927, 6344.0, 6382.042693595998, 6383.106365108889, 6387.584806987531, 6392.9451640479265, 5755.424457554211, 5757.280339957505, 5890.67601281925, 5910.083936989773, 5915.438033386821, 6369.108324834527, 6402.711877965503, 6434.839129021719, 6437.645929473924, 6440.0, 6087.026075827846, 6116.944513560587, 6118.3755344619085, 6139.785107521216, 6194.628322300677, 6269.529785266032, 6309.526785491014, 6331.620102793847, 6337.7781777637565, 6346.524010699124, 6128.3565225651555, 6149.692515374213, 6193.163922870355, 6309.495240380758, 6310.684465776692, 6220.595661282002, 6268.49852011838, 6279.0, 6289.0880822280515, 6325.873482530324, 4849.2968519564465, 4849.636277279147, 4854.635902307341, 4883.267509873476, 4895.192293271571, 4250.192463431938, 4267.487901451846, 4285.7000009999, 4286.614204721528, 4312.827486900552, 5822.3304320003745, 5896.204012458349, 5900.822975310747, 5911.615744976562, 5913.201717768132, 6139.584134579286, 6197.81406557804, 6219.098230756515, 6220.066989951453, 6220.7511699532415, 5931.347551769302, 5960.254968128984, 6017.819465416044, 6024.608400453956, 6026.849328766816, 5531.032069387841, 5531.3915469298345, 5532.723363831792, 5537.501624853782, 5540.2243685884005, 6601.570897891622, 6608.933910660928, 6611.438027767597, 6621.602703837785, 6622.4702023838945, 6275.0, 6281.152044473937, 6323.557350985387, 6332.3034466207755, 6335.65153916539, 6350.428461438492, 6571.868562628816, 6581.605103693793, 6601.075849381186, 6614.305497922841, 6115.179495343419, 6140.631562106288, 6216.658083805253, 6222.875542489215, 6225.252969643671, 6315.463185629273, 6328.430441260309, 6333.556651034568, 6334.081558173947, 6337.0, 5930.466258036798, 6011.849703757441, 6015.368386319548, 6028.0, 6110.877782444238, 6163.506919446523, 6195.287541932736, 6199.070139479114, 6204.751809927552, 6206.937930620636, 6149.723262453111, 6170.228721409824, 6172.4136207060255, 6173.907391389043, 6189.845253868509, 5970.880582388241, 6019.337872833898, 6119.510439164767, 6121.84695382619, 6141.6007959482495, 5765.077587585966, 5804.941950580609, 5869.501092407193, 5869.706514674334, 5885.058390657474], "value": 5749.918743390631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.2245525880714, 804.9919500804992, 824.678375433581, 1124.8537690100286, 1142.0463912632952, 28592.0, 29106.563401548967, 34921.30157396851, 35860.0, 35864.282714345696, 37708.81145594275, 38073.23853522928, 38100.23799524008, 38126.0, 38232.61767382325, 5441.59188060895, 7085.964570177168, 7221.602811845346, 7244.239354867742, 7246.021787058732, 5497.422770609089, 7006.264342244068, 7188.173360063581, 7196.568205907663, 7200.207977122513, 7268.127824661048, 7278.599677017762, 7300.780976570712, 7301.707931682727, 7312.5246858954, 5553.72231388433, 7222.855542889139, 7270.127584689818, 7275.599842008687, 7282.380997615209, 3983.382575700771, 6959.860802783966, 7062.187848397449, 7123.7506687265695, 7130.536515126552, 34491.0, 34670.306593868234, 34722.30555388878, 34856.0, 34910.301793963976, 3430.9142271443166, 3441.5181874537584, 3456.1532424555894, 3462.290230502741, 3464.930701385958, 27847.0, 28189.85905070482, 28211.57682634762, 28236.152915412364, 28257.858710706314, 3757.1546402059316, 3766.7174961877695, 3792.60177681345, 3803.3724435468116, 3840.7503512271614, 183638.0, 184315.0, 184362.0, 184470.0, 184692.0765396178, 45107.0, 45308.3203751944, 45354.77322613366, 45377.31934020992, 45465.545344546794, 47320.0, 47376.7631161842, 47447.288290675664, 47576.0, 47608.285875711896, 14484.420623174956, 14566.781498277534, 14585.562433127023, 14600.707985840436, 14604.926975365268, 10111.544980475895, 10310.32982856112, 11911.880881191077, 11940.104492163122, 11953.641390758292, 12338.876611233953, 12414.689632759073, 12436.689082773004, 12589.307588082744, 12638.304893230777, 5088.974555127201, 5152.929185943063, 5156.561692256125, 5229.294045303835, 5259.500347466985, 1033.5710680067687, 1068.4497483795851, 1071.4803320389606, 1074.3500182389698, 1121.7363919478917, 24624.0, 25286.87356563242, 25361.112361067273, 25401.0, 25473.49053018966, 1166.311875993168, 1179.9528018879148, 1181.4388165621433, 1185.3895243949373, 1206.5656363709058, 12894.29081400532, 13123.212607243597, 13210.801837972438, 13299.867001330056, 13338.399772010283, 235732.0, 237733.0, 238043.0, 238051.0, 239094.0, 49460.0, 50024.49975500198, 50110.49889501058, 50188.49811501838, 50249.0, 1467.3910327214087, 1481.2445652716976, 1483.44370860925, 1501.9173945433106, 1517.0821652900058, 23604.409889752893, 24763.50472990494, 24799.0, 24909.377265568506, 24918.626220607068, 45954.0, 46887.0, 46896.29655555238, 46953.530464694915, 47118.29322560233, 194003.0, 194214.0, 194703.0, 196261.2056336915, 196450.0, 27717.168484945483, 28044.158675239774, 30738.0, 30932.69067309298, 30994.380112397175, 37726.245475090895, 37985.620143799315, 39596.802015989735, 39692.83225261306, 40002.39996399998, 29442.11673649794, 29851.0, 30059.09822705235, 30361.392772144874, 30458.54312185275, 29514.0, 29747.553786692784, 30002.84998574993, 30604.387912242077, 30680.539791902695, 34888.65111348854, 35038.64961350354, 35042.29915401729, 35200.471992919614, 35339.823300883334, 28013.0, 28585.571216431355, 28620.713792861803, 29501.557476638296, 29767.0, 22811.31566053021, 23803.0, 24030.39924001844, 24067.759322406553, 24140.39649008789], "value": 16266.226198358445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.55165730954445, 440.9977950110251, 447.79625270501936, 452.60623257765747, 461.08934853664005, 18538.81461185388, 19813.801861981377, 20453.590928181427, 20621.896890515527, 20674.6898796518, 20057.799422005814, 20845.895770521165, 21190.788092119074, 21417.57164856706, 21437.67843482349, 5463.726813659321, 5582.413846546115, 5607.803726869561, 5648.887022259552, 5668.348139963916, 5483.945160548404, 5572.693501857396, 5603.887922241553, 5616.85957851055, 5621.578381621374, 5579.13523403873, 5591.3569939456875, 5599.916001259984, 5602.971985140089, 5604.346717718283, 5413.485718856702, 5543.307086614193, 5564.805231816867, 5578.386377498472, 5584.636998595099, 5071.264666623319, 5088.516590923893, 5096.847094587169, 5097.260897169889, 5098.847034588968, 24505.632415513603, 24774.25677229686, 25062.749372506405, 25327.0, 25536.872315638488, 2206.702095217141, 2222.844400891938, 2228.888555572215, 2243.741969673492, 2243.7756224377595, 16561.917190414093, 17399.391021314193, 17419.5645108872, 17446.127693615395, 17566.82433175665, 2190.7042549255966, 2231.2190733243397, 2277.760835112306, 2284.8971796269207, 2290.0954123121273, 96670.51664741701, 97343.0, 97661.0, 97831.51084244534, 98541.0, 11838.171328007129, 12335.074869384653, 12378.44297006637, 12424.75150496985, 12616.684582885502, 17449.38927137544, 17476.213570389362, 17488.5627859302, 17505.824941750674, 17539.649207015787, 8601.5699215039, 8699.608062709936, 8900.332475064266, 8936.151065648754, 8936.46381217129, 7929.422937545321, 7957.204279572113, 8184.427090103635, 8210.220029097227, 8229.094799572042, 7541.547507149478, 7659.502132361378, 8056.758297251092, 8057.717979870677, 8088.272055515032, 2176.5211653436218, 2183.1813070098715, 2203.5042115524197, 2260.694806201142, 2296.127471560796, 1042.99478502607, 1077.3051381858656, 1081.378207530673, 1092.8306112552566, 1093.9890601094046, 20645.0, 20761.896190519252, 20811.1675532977, 20881.68677469839, 20887.58224835495, 1090.5201711247025, 1091.1761619976867, 1092.7432053467428, 1101.2731597145846, 1112.2214449885112, 10883.23817332779, 11139.824550981253, 11145.74515759588, 11319.320840749582, 11348.319100853974, 481402.0, 485986.0, 507829.0, 516859.0, 518550.0, 98372.0, 99407.0, 99767.0, 100975.49512252392, 103183.0, 1180.6340034589305, 1188.2157775867886, 1216.0757824053605, 1217.8112392579164, 1228.4287806170173, 16867.0, 17155.313787448362, 17439.30242790274, 17822.0, 18022.279108836025, 44759.77620111879, 44818.0, 45720.31419528776, 45978.770106149255, 46021.309680355494, 56526.43473565212, 57180.71409642925, 58650.70674646599, 59162.40837591741, 59529.40470595239, 9299.488528130747, 9372.828396450444, 9464.810703785748, 9503.336916039803, 9528.094830991045, 14639.780403293746, 14813.851861481678, 14945.252737363306, 15065.774013390028, 15088.471903483325, 12392.876071239172, 12500.624981250578, 12730.809037864254, 13449.260290684106, 13488.5279015234, 11451.198416111125, 11462.312261264351, 11700.88299117032, 12039.518419263482, 12123.333216672814, 12790.104692671424, 12958.0, 13203.537876174289, 13365.0, 13410.463581456632, 9179.495127768037, 9418.57616407277, 9480.407422467666, 9649.758756031155, 9948.751281218027, 12378.442970066188, 12419.19275247106, 12547.874521254671, 12590.307533085403, 12761.61715148547], "value": 10090.341862173438, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1199.9520019199233, 1327.541998010686, 1363.5115913457935, 1383.4604504243343, 1384.515419603139, 9423.952880235598, 10367.274290799647, 10810.891891081097, 10880.564777408894, 10903.618373356934, 10633.627823026196, 10660.78678426431, 10678.145748340134, 10724.410157441338, 10734.194935379859, 1863.49685584892, 1933.7389452423884, 2323.163661082005, 2375.6555299481565, 2379.274321331993, 2305.250793492113, 2445.7554244575576, 2448.681671382718, 2449.5713250181234, 2451.4361696809747, 2370.146747171017, 2381.0832829360647, 2388.36708272308, 2392.473655795722, 2392.9162479313227, 2238.7761223877483, 2242.5963326601204, 2254.7632498587577, 2255.391044417998, 2257.762934891829, 2125.787421257877, 2156.9568608627737, 2159.84881058326, 2284.565932472825, 2330.498942727305, 11175.050120739746, 11292.491837867316, 11302.434878256054, 11311.943440282828, 11321.943390283079, 6332.366763323631, 6541.869162616768, 6565.24499682533, 6573.737050517973, 6576.80269591913, 3764.5670747863796, 3806.638369354907, 3914.354131568288, 3935.193285376491, 3945.7237993340477, 1290.1742884553894, 1300.1354099523805, 1329.1028555724943, 1356.071091302461, 1361.4282001559368, 17407.0, 17466.563335916704, 17501.649967000587, 17516.21177047036, 17532.649347013117, 5536.390996990328, 5743.736377996834, 5749.13762935563, 5761.337446193657, 5917.31950825652, 14034.508792192224, 14290.285485725672, 14295.499657512146, 14335.27629750344, 14378.784318235235, 6614.8346291343105, 6637.502187335969, 6640.568363056386, 6669.0, 6747.662616869137, 6140.815775526741, 6155.384461553809, 6165.660888651168, 6214.036824292242, 6289.842753931097, 4586.3579098926175, 4597.356370108188, 4616.76916154191, 4644.86065418038, 4684.929726054112, 1415.815943927283, 1439.5321520505877, 1441.4810668159455, 1471.2570152073135, 1479.4599971010505, 847.326375531454, 864.4726716702806, 879.4811061473761, 888.1562515610067, 909.5361365703407, 6645.966770166118, 6662.83342916431, 6685.866282674417, 6752.358525940028, 6805.319468053155, 646.4602057282128, 652.5040968863698, 653.4902775834856, 658.0, 667.0627767985891, 4061.5735347788645, 4070.816813243411, 4085.9387109193385, 4088.448059511987, 4112.1439399984065, 14505.927470362582, 15215.31531081104, 15305.158216297988, 15326.23368831554, 15345.386184552715, 15044.323005464781, 15068.773968390484, 15135.924320378328, 15137.545873623809, 15147.091174529563, 9224.723258302261, 9412.294077944181, 9555.61777528891, 9594.184494317922, 9648.228141748783, 6853.0, 6854.485913556404, 6858.759943401957, 6894.517383783288, 6918.0, 13491.730165396833, 13553.0, 13976.021678482408, 13987.790183147057, 13989.860101398855, 13795.0, 14376.137431754129, 14386.35261413218, 14396.568102956928, 14484.710305793615, 8918.955405223192, 9473.0, 9587.808243834945, 9609.51952402391, 9620.75948101303, 11113.944430277797, 11235.943820280847, 11284.661460156209, 11310.660680179608, 11320.547178113113, 8831.955840221015, 8890.0, 9077.546122693706, 9202.493862837608, 9228.815423691354, 9081.818363632823, 9092.363534552518, 9208.447493150432, 9234.399764015317, 9279.67521136757, 8198.180181981992, 8227.917720822716, 8247.175282471704, 8320.667173313243, 8330.250277475056, 6125.571210015434, 6198.2252218472695, 6210.658413787285, 6242.375762423721, 6455.4512866406885, 6204.72078756448, 6211.16149319836, 6247.9062814056915, 6279.905801413074, 6382.393672601095], "value": 5366.197289358792, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.73769836511195, 402.1855742122202, 420.5311078147865, 425.1433361776022, 438.98683039508825, 5574.526165275951, 5637.154426835971, 5770.336411312695, 5831.825045248639, 5844.211031510745, 5493.642913210639, 5681.375048744635, 5696.25948626679, 5711.144427786107, 5723.799667011655, 4344.91310173798, 4367.541408152146, 4384.842913102561, 4391.099824535962, 4400.251957167281, 4188.518320393148, 4273.337632666941, 4284.957150428502, 4307.289297265947, 4406.36107764374, 4013.739106958053, 4232.555581663927, 4321.308590625501, 4328.0, 4365.573025175238, 4316.935245971313, 4328.480582330125, 4335.6965012449145, 4363.301871700544, 4368.956310436887, 3817.9427308590393, 3834.2523207974455, 3835.6383483863106, 3840.0783811885226, 3841.9231615367817, 5469.015577196104, 5554.1391084381985, 5584.636998595079, 5585.944140558624, 5606.495415412592, 5132.332796736438, 5138.229265610151, 5151.0, 5153.252778347119, 5157.53582177602, 5909.320428150775, 6048.667323297217, 6061.151438798572, 6084.908726369108, 6112.174856394418, 4281.336392859112, 4300.935485967713, 4300.935485967713, 4303.419038429804, 4313.97843010783, 6317.4946004319545, 6369.5222858285815, 6374.58565193261, 6396.432873945867, 6403.263624683174, 4296.806643701041, 4385.0, 4391.494978077498, 4394.143142087326, 4398.208322501981, 4190.0, 4279.529251782302, 4424.60178583929, 4438.578335058164, 4454.510003899569, 4963.280324352949, 5053.090443720165, 5077.746112694351, 5090.160123579642, 5115.820946266863, 6087.421694938974, 6103.816885493442, 6106.084087386927, 6133.570650054453, 6171.876562468726, 1467.3103641288578, 1499.572621802781, 1521.3838395449861, 1522.7335216337096, 1523.0937592132664, 1001.6594357918343, 1020.6631811502186, 1033.4729288062993, 1037.2531777120462, 1037.5123691864812, 5838.5329173666005, 5858.56060795442, 5869.765209391577, 5922.3485416604135, 5946.226990491208, 6252.218472690914, 6253.6560489173535, 6263.217097862767, 6265.8746825063245, 6294.059163556678, 5754.482096611241, 5907.172995780594, 5914.615549989237, 5925.318588362394, 5934.554908381889, 3289.3914625794305, 3317.3365326934227, 3330.6003279606603, 3331.0346895331872, 3358.0, 6304.527160462983, 6553.541252112402, 6586.308437614078, 6651.16860392451, 6667.86664266712, 6454.741810327534, 6456.677166141674, 6478.967605162038, 6495.382938620824, 6498.415142637185, 6345.809625711236, 6561.179852518435, 6613.404793568602, 6620.768273110418, 6637.701303441357, 6306.558540902276, 6321.336259692666, 6346.111544383698, 6352.714127864165, 6359.5866268694235, 5999.90003498772, 6265.310815810166, 6274.937250627618, 6283.151774510383, 6305.180326557518, 6572.474202063728, 6627.304133065959, 6629.171353580802, 6630.0, 6636.0, 4224.408582798349, 4296.699231053796, 4378.408914796461, 4403.8018289176425, 4408.470983482002, 6100.6949652516305, 6264.5301602379095, 6271.937280627135, 6273.964795808641, 6296.433321000949, 6028.5177185825905, 6030.668313242813, 6039.698015099315, 6047.576669633084, 6082.908756368746, 5917.556183286185, 6082.60463069899, 6094.299155597163, 6114.57197996136, 6128.8774224516155, 6070.332263451105, 6083.239595050619, 6085.361037091042, 6086.261182467995, 6092.969535152296, 5989.580729348903, 6105.603135796337, 6131.724072416841, 6169.660668663087, 6210.0, 5935.317438494629, 6010.759569617167, 6022.307434645072, 6030.7889223876955, 6039.486643635164], "value": 4628.758916064882, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [858.2790456016944, 867.1675191815856, 869.8825658536098, 885.7519894429562, 896.9327300452468, 16722.0, 16747.16264186792, 17547.2103755331, 17559.47321580353, 17566.209520571574, 16575.0, 17168.656626867454, 17175.312987480516, 17300.740488892647, 17334.219960101793, 901.5717534171282, 910.940788848726, 912.2063804490103, 913.2967614936495, 913.3606475467167, 959.3476436023501, 992.8262554053048, 1003.0721582536162, 1003.3027046202892, 1003.8193125237455, 1062.2511129653576, 1064.5103252503857, 1065.1851333729703, 1066.003286926726, 1068.3750006246355, 1044.7127040063967, 1053.857729206555, 1059.3802625464075, 1061.1192710050677, 1061.2465149743691, 771.9845603087963, 772.212343409719, 773.0337078651686, 773.0761739721036, 773.3928865840345, 15816.841831581653, 15899.761503577456, 15943.681126377523, 17466.214020369112, 17680.469585912444, 18958.715619265586, 19097.949612771292, 19288.614227715367, 19378.1279842406, 19707.507312317164, 14580.854191458056, 14666.120032798066, 14682.853171468256, 14829.18439485828, 14900.329485173193, 3441.0537102296817, 3462.0306314232057, 3465.6707612776745, 3468.9653103469145, 3469.930601387983, 95216.0, 95934.52032739791, 96035.51982240114, 97042.51478742632, 98974.50512747391, 14170.787438188436, 14263.42946282158, 14284.57146285613, 14395.208263545395, 14522.0, 27422.177334679993, 27480.58779118315, 27670.446591068066, 28122.85938570294, 28190.71809281922, 7690.577018264049, 7693.6537855795505, 7713.884291735629, 7740.148583655793, 7773.18381569927, 4004.6796256299426, 4103.97948010258, 4110.034141976633, 4113.321301985139, 4136.420901073852, 4577.702449340783, 4616.584507394351, 4666.976665116721, 4673.322368256584, 4688.789004494806, 855.6235256487125, 877.455977294069, 886.4636894678627, 887.8268737596236, 888.8488956877346, 721.5201890742702, 739.9704011839574, 745.4781652843031, 759.2028370211256, 775.1628241499168, 11433.656990290137, 12562.120651554304, 12650.873491265154, 12877.484900604059, 13100.410481528354, 732.6263605561202, 736.9226231245749, 737.7417903733758, 743.7173873927873, 753.1376573822942, 5633.492985631231, 5641.774329026793, 5782.826515204551, 5821.18503409523, 5828.504577110993, 81962.59018704988, 82121.58939205385, 82254.0, 82568.58715706383, 83112.58443707864, 68861.31138688649, 69174.65412672904, 73117.0, 73816.63091684507, 74299.62850185715, 58030.0, 60349.69825150846, 61238.69380653157, 62876.0, 64435.355646442935, 10836.458177091272, 10905.672829815117, 11518.769624607294, 11717.88282117168, 11738.765224695288, 32939.50590741189, 33884.152896176805, 34576.0, 34704.30591388208, 37106.44340334951, 41334.37998429966, 41967.16065678608, 42977.3553396693, 43175.136497270505, 43334.56665433432, 14898.98863653393, 15188.240587970336, 15197.17633883941, 15345.156016419203, 15701.842981570495, 17878.28486860511, 18701.719474207624, 19083.045847707835, 19334.0, 19635.11641976143, 17194.398196063077, 17276.74084888753, 17772.91113544424, 18965.146568404733, 19363.709544356563, 16329.755053673967, 16847.663046739242, 16912.661746765243, 18353.0, 18419.81580184181, 17108.315667373165, 17712.025838579, 17872.55318617045, 18017.0, 18257.634847303245, 11019.0, 11184.328940263611, 11186.216964812385, 11310.434478276218, 11680.415979201176, 12481.563145290234, 13850.930745346208, 13872.306384680523, 14116.717665646835, 14904.478343257933], "value": 8256.67724890504, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 110.0, 110.0, 111.0, 111.0, 109.0, 108.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 119.0, 157.0, 118.0, 119.0, 121.0, 117.0, 137.0, 118.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 164.0, 162.0, 163.0, 165.0, 164.0, 163.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 110.0, 75.0, 74.0, 75.0, 74.0, 94.0, 74.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 105.0, 82.0, 82.0, 83.0, 100.0, 82.0, 82.0, 110.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 115.0, 115.0, 115.0, 113.0, 113.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 149.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 45.0, 45.0, 46.0, 49.0, 46.0, 46.0, 47.0, 45.0], "value": 46.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 81.0, 83.0, 83.0, 82.0, 97.0, 82.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 133.0, 133.0, 133.0, 131.0, 126.0, 124.0, 127.0, 171.0, 123.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 173.0, 185.0, 180.0, 186.0, 184.0, 184.0, 181.0, 175.0, 174.0], "value": 181.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 65.0, 65.0, 66.0, 65.0, 63.0, 63.0, 65.0, 65.0], "value": 65.1, "unit": "score"}]}]} 03:23:38 INFO - Return code: 0 03:23:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:23:38 INFO - # TBPL SUCCESS # 03:23:38 INFO - Running post-action listener: _resource_record_post_action 03:23:38 INFO - [mozharness: 2017-05-04 10:23:38.252320Z] Finished run-tests step (success) 03:23:38 INFO - Running post-run listener: _resource_record_post_run 03:23:38 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 363253760; Read time: 40; Write time: 499344 03:23:38 INFO - TinderboxPrint: CPU usage
12.9% 03:23:38 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 40 03:23:38 INFO - TinderboxPrint: I/O write bytes / time
363,253,760 / 499,344 03:23:38 INFO - TinderboxPrint: CPU idle
8,297.0 (87.1%) 03:23:38 INFO - TinderboxPrint: CPU user
1,183.6 (12.4%) 03:23:38 INFO - TinderboxPrint: Swap in / out
0 / 0 03:23:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 88555520; Read time: 0; Write time: 108220 03:23:38 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248651776; Read time: 12; Write time: 252976 03:23:38 INFO - Running post-run listener: _upload_blobber_files 03:23:38 INFO - Blob upload gear active. 03:23:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:23:38 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 03:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:23:39 INFO - (blobuploader) - INFO - Open directory for files ... 03:23:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:23:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:23:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:42 INFO - (blobuploader) - INFO - Done attempting. 03:23:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:23:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:23:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:43 INFO - (blobuploader) - INFO - Done attempting. 03:23:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:23:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:23:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:43 INFO - (blobuploader) - INFO - Done attempting. 03:23:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:23:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:23:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:44 INFO - (blobuploader) - INFO - Done attempting. 03:23:44 INFO - (blobuploader) - INFO - Iteration through files over. 03:23:44 INFO - Return code: 0 03:23:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:23:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:23:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69a4697b152d4725c478d9c2bbaf9da9448a6a41b18f8e1672cbbbd2a167256077cf2101cedd4c3bbe8717a59e356da940b685bd37376e98ba4934c39762bd99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ea3f565e7ec8a544135cbead670e3ef3694846d040750419973f09c3bfcffff7cb623439644fcc0824efc4b1aa2fb41e883ac3335883ab3714861a09fe22443", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512394b597e0036f9bb123c74984f319dde4e556c07e2c198f23285c8b5cb885b1bba89c0408bf62e93ee9eabb856021ca4d2740371f28067887b22d65956696", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daedcba42ba7d460c2ae512e91727b6a185aa18b513cef196f08f08c7a94884444aa4780fa067652a04ff88fc4d464187faf7b09a1427abf3175e387367ccf22"} 03:23:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:23:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:23:44 INFO - Contents: 03:23:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69a4697b152d4725c478d9c2bbaf9da9448a6a41b18f8e1672cbbbd2a167256077cf2101cedd4c3bbe8717a59e356da940b685bd37376e98ba4934c39762bd99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ea3f565e7ec8a544135cbead670e3ef3694846d040750419973f09c3bfcffff7cb623439644fcc0824efc4b1aa2fb41e883ac3335883ab3714861a09fe22443", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512394b597e0036f9bb123c74984f319dde4e556c07e2c198f23285c8b5cb885b1bba89c0408bf62e93ee9eabb856021ca4d2740371f28067887b22d65956696", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daedcba42ba7d460c2ae512e91727b6a185aa18b513cef196f08f08c7a94884444aa4780fa067652a04ff88fc4d464187faf7b09a1427abf3175e387367ccf22"} 03:23:44 INFO - Running post-run listener: copy_logs_to_upload_dir 03:23:44 INFO - Copying logs to upload dir... 03:23:44 INFO - mkdir: /builds/slave/test/build/upload/logs 03:23:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.037979 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-05-04 03:23:44.247381) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 03:23:44.251717) ========= 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=52faae308a556c440401f8e5000001e8-1493892175.163750-969890786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69a4697b152d4725c478d9c2bbaf9da9448a6a41b18f8e1672cbbbd2a167256077cf2101cedd4c3bbe8717a59e356da940b685bd37376e98ba4934c39762bd99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ea3f565e7ec8a544135cbead670e3ef3694846d040750419973f09c3bfcffff7cb623439644fcc0824efc4b1aa2fb41e883ac3335883ab3714861a09fe22443", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512394b597e0036f9bb123c74984f319dde4e556c07e2c198f23285c8b5cb885b1bba89c0408bf62e93ee9eabb856021ca4d2740371f28067887b22d65956696", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daedcba42ba7d460c2ae512e91727b6a185aa18b513cef196f08f08c7a94884444aa4780fa067652a04ff88fc4d464187faf7b09a1427abf3175e387367ccf22"} build_url:https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/XHIlcrlvQPaCXuPNET_RCg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69a4697b152d4725c478d9c2bbaf9da9448a6a41b18f8e1672cbbbd2a167256077cf2101cedd4c3bbe8717a59e356da940b685bd37376e98ba4934c39762bd99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ea3f565e7ec8a544135cbead670e3ef3694846d040750419973f09c3bfcffff7cb623439644fcc0824efc4b1aa2fb41e883ac3335883ab3714861a09fe22443", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512394b597e0036f9bb123c74984f319dde4e556c07e2c198f23285c8b5cb885b1bba89c0408bf62e93ee9eabb856021ca4d2740371f28067887b22d65956696", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daedcba42ba7d460c2ae512e91727b6a185aa18b513cef196f08f08c7a94884444aa4780fa067652a04ff88fc4d464187faf7b09a1427abf3175e387367ccf22"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 03:23:44.277282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:23:44.280621) ========= 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=52faae308a556c440401f8e5000001e8-1493892175.163750-969890786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:23:44.361438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 03:23:44.361765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 03:23:44.362072) ========= ========= Total master_lag: 0.17 =========