builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1486128595.95 results: success (0) revision: 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:55.951867) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:55.952371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:55.952686) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:55.967374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:55.967789) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-03 05:29: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 100M=0s 2017-02-03 05:29:56 (100 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107109 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:56.088899) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:56.089254) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019966 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:56.139626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 05:29:56.139998) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 --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 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 --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=88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-03 05:29:56,246 truncating revision to first 12 chars 2017-02-03 05:29:56,246 Setting DEBUG logging. 2017-02-03 05:29:56,246 attempt 1/10 2017-02-03 05:29:56,246 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9f17a6fc04f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 05:29:57,128 unpacking tar archive at: mozilla-central-9f17a6fc04f9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.195591 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 05:29:57.348539) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:57.348924) ========= script_repo_revision: 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:57.349368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:57.349692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 05:29:57.358442) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-02-03 05:29:57.358882) ========= /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=88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:29:57 INFO - MultiFileLogger online at 20170203 05:29:57 in /builds/slave/test 05:29: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 05:29:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:57 INFO - {'append_to_log': False, 05:29:57 INFO - 'base_work_dir': '/builds/slave/test', 05:29:57 INFO - 'blob_upload_branch': 'Firefox', 05:29:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:57 INFO - 'branch': 'Firefox', 05:29:57 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:57 INFO - 'config_files': ('talos/linux_config.py',), 05:29:57 INFO - 'default_actions': ('clobber', 05:29:57 INFO - 'read-buildbot-config', 05:29:57 INFO - 'download-and-extract', 05:29:57 INFO - 'populate-webroot', 05:29:57 INFO - 'create-virtualenv', 05:29:57 INFO - 'install', 05:29:57 INFO - 'run-tests'), 05:29:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:57 INFO - 'download_minidump_stackwalk': True, 05:29:57 INFO - 'download_symbols': 'ondemand', 05:29:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:57 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:57 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:57 INFO - 'installer_path': 'installer.exe', 05:29:57 INFO - 'log_level': 'info', 05:29:57 INFO - 'log_name': 'talos', 05:29:57 INFO - 'log_to_console': True, 05:29:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:29:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:29:57 INFO - 'opt_config_files': (), 05:29:57 INFO - 'pip_index': False, 05:29:57 INFO - 'sps_profile': False, 05:29:57 INFO - 'sps_profile_interval': 0, 05:29:57 INFO - 'suite': 'dromaeojs', 05:29:57 INFO - 'system_bits': '32', 05:29:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:57 INFO - 'title': 'talos-linux64-ix-044', 05:29:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:57 INFO - 'use_talos_json': True, 05:29:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:57 INFO - 'work_dir': 'build'} 05:29:57 INFO - [mozharness: 2017-02-03 13:29:57.553541Z] Running clobber step. 05:29:57 INFO - Running pre-action listener: _resource_record_pre_action 05:29:57 INFO - Running main action method: clobber 05:29:57 INFO - rmtree: /builds/slave/test/build 05:29:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:58 INFO - Running post-action listener: _resource_record_post_action 05:29:58 INFO - [mozharness: 2017-02-03 13:29:58.669694Z] Finished clobber step (success) 05:29:58 INFO - [mozharness: 2017-02-03 13:29:58.669793Z] Running read-buildbot-config step. 05:29:58 INFO - Running pre-action listener: _resource_record_pre_action 05:29:58 INFO - Running main action method: read_buildbot_config 05:29:58 INFO - Using buildbot properties: 05:29:58 INFO - { 05:29:58 INFO - "project": "", 05:29:58 INFO - "product": "firefox", 05:29:58 INFO - "who": "cbook@mozilla.com", 05:29:58 INFO - "installer_path": "public/build/target.tar.bz2", 05:29:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:29:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:29:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:29:58 INFO - "stage_platform": "linux64-pgo", 05:29:58 INFO - "basedir": "/builds/slave/test", 05:29:58 INFO - "buildnumber": 20, 05:29:58 INFO - "platform": "ubuntu64_hw", 05:29:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:29:58 INFO - "slavebuilddir": "test", 05:29:58 INFO - "taskId": "P7hZ2PrDT3ynLvpCAeFajg", 05:29:58 INFO - "branch": "mozilla-central", 05:29:58 INFO - "script_repo_revision": "production", 05:29:58 INFO - "revision": "9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23", 05:29:58 INFO - "slavename": "talos-linux64-ix-044", 05:29:58 INFO - "repo_path": "mozilla-central" 05:29:58 INFO - } 05:29:58 INFO - Finding installer, test and symbols from parent task. 05:29:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P7hZ2PrDT3ynLvpCAeFajg'}, attempt #1 05:29:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P7hZ2PrDT3ynLvpCAeFajg'}, attempt #1 05:29:59 INFO - Task dependencies: RP9BjumASLuaDHUNzlFvlQ 05:29:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ'}, attempt #1 05:30:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.tar.bz2 05:30:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/test_packages.json 05:30:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.crashreporter-symbols.zip 05:30:00 INFO - Running post-action listener: _resource_record_post_action 05:30:00 INFO - [mozharness: 2017-02-03 13:30:00.080685Z] Finished read-buildbot-config step (success) 05:30:00 INFO - [mozharness: 2017-02-03 13:30:00.080901Z] Running download-and-extract step. 05:30:00 INFO - Running pre-action listener: _resource_record_pre_action 05:30:00 INFO - Running main action method: download_and_extract 05:30:00 INFO - mkdir: /builds/slave/test/build/tests 05:30: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')]} 05:30:00 INFO - trying https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.test_packages.json 05:30:00 INFO - Downloading https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:30:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:30:00 INFO - Downloaded 896 bytes. 05:30:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:30:00 INFO - Using the following test package requirements: 05:30:00 INFO - {u'common': [u'target.common.tests.zip'], 05:30:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:30:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:30:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:30:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:30:00 INFO - u'mozbase': [u'target.common.tests.zip'], 05:30:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:30:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:30:00 INFO - u'web-platform': [u'target.common.tests.zip', 05:30:00 INFO - u'target.web-platform.tests.zip'], 05:30:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:30:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:30:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.common.tests.zip 05:30:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:30:00 INFO - Fetch https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.common.tests.zip into memory 05:30:01 INFO - Expected file size: 41754448 05:30:01 INFO - Obtained file size: 41754448 05:30:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:30:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.common.tests.zip 05:30:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:30:06 INFO - Fetch https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.common.tests.zip into memory 05:30:07 INFO - Expected file size: 41754448 05:30:07 INFO - Obtained file size: 41754448 05:30:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.talos.tests.zip 05:30:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:30:11 INFO - Fetch https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.talos.tests.zip into memory 05:30:12 INFO - Expected file size: 14403454 05:30:12 INFO - Obtained file size: 14403454 05:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:12 INFO - trying https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.tar.bz2 05:30:12 INFO - Downloading https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:30:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:30:13 INFO - Downloaded 61675164 bytes. 05:30:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.tar.bz2 05:30:13 INFO - mkdir: /builds/slave/test/properties 05:30:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:30:13 INFO - Writing to file /builds/slave/test/properties/build_url 05:30:13 INFO - Contents: 05:30:13 INFO - build_url:https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.tar.bz2 05:30:13 INFO - Running post-action listener: _resource_record_post_action 05:30:13 INFO - Running post-action listener: set_extra_try_arguments 05:30:13 INFO - [mozharness: 2017-02-03 13:30:13.932066Z] Finished download-and-extract step (success) 05:30:13 INFO - [mozharness: 2017-02-03 13:30:13.932164Z] Running populate-webroot step. 05:30:13 INFO - Running pre-action listener: _resource_record_pre_action 05:30:13 INFO - Running main action method: populate_webroot 05:30:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:13 INFO - '--tppagecycles', 05:30:13 INFO - '7'], 05:30:13 INFO - 'tests': ['tsvgm']}}, 05:30:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:30:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:30:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:30:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:30:13 INFO - 'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:30:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:30:13 INFO - 'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['damp', 'tps']}, 05:30:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:30:13 INFO - 'tests': ['damp', 'tps']}, 05:30:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['dromaeo_dom']}, 05:30:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['basic_compositor_video']}, 05:30:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:30:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['a11yr', 05:30:13 INFO - 'ts_paint', 05:30:13 INFO - 'tpaint', 05:30:13 INFO - 'sessionrestore', 05:30:13 INFO - 'sessionrestore_no_auto_restore', 05:30:13 INFO - 'tabpaint']}, 05:30:13 INFO - 'other-e10s': {'tests': ['a11yr', 05:30:13 INFO - 'ts_paint', 05:30:13 INFO - 'tpaint', 05:30:13 INFO - 'sessionrestore', 05:30:13 INFO - 'sessionrestore_no_auto_restore', 05:30:13 INFO - 'tabpaint']}, 05:30:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:30:13 INFO - 'ts_paint', 05:30:13 INFO - 'tpaint', 05:30:13 INFO - 'sessionrestore', 05:30:13 INFO - 'sessionrestore_no_auto_restore', 05:30:13 INFO - 'tabpaint']}, 05:30:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:30:13 INFO - 'ts_paint', 05:30:13 INFO - 'tpaint', 05:30:13 INFO - 'sessionrestore', 05:30:13 INFO - 'sessionrestore_no_auto_restore', 05:30:13 INFO - 'tabpaint']}, 05:30:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['a11yr', 05:30:13 INFO - 'ts_paint', 05:30:13 INFO - 'tpaint', 05:30:13 INFO - 'sessionrestore', 05:30:13 INFO - 'sessionrestore_no_auto_restore', 05:30:13 INFO - 'tabpaint']}, 05:30:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['a11yr', 05:30:13 INFO - 'ts_paint', 05:30:13 INFO - 'tpaint', 05:30:13 INFO - 'sessionrestore', 05:30:13 INFO - 'sessionrestore_no_auto_restore', 05:30:13 INFO - 'tabpaint']}, 05:30:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['tsvgx', 05:30:13 INFO - 'tsvgr_opacity', 05:30:13 INFO - 'tart', 05:30:13 INFO - 'tscrollx', 05:30:13 INFO - 'cart', 05:30:13 INFO - 'tsvg_static']}, 05:30:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:30:13 INFO - 'tsvgr_opacity', 05:30:13 INFO - 'tart', 05:30:13 INFO - 'tscrollx', 05:30:13 INFO - 'cart', 05:30:13 INFO - 'tsvg_static']}, 05:30:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:30:13 INFO - 'talos_options': ['--disable-e10s'], 05:30:13 INFO - 'tests': ['tp5o']}, 05:30:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:30:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:30:13 INFO - 'talos_options': ['--disable-e10s', 05:30:13 INFO - '--xperf_path', 05:30:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:13 INFO - 'tests': ['tp5n']}, 05:30:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:30:13 INFO - 'talos_options': ['--xperf_path', 05:30:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:13 INFO - 'tests': ['tp5n']}}, 05:30:13 INFO - 'talos.zip': {'path': '', 05:30:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:13 INFO - Running post-action listener: _resource_record_post_action 05:30:13 INFO - [mozharness: 2017-02-03 13:30:13.945306Z] Finished populate-webroot step (success) 05:30:13 INFO - [mozharness: 2017-02-03 13:30:13.945401Z] Running create-virtualenv step. 05:30:13 INFO - Running pre-action listener: _resource_record_pre_action 05:30:13 INFO - Running main action method: create_virtualenv 05:30:13 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:13 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 05:30:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:30:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:14 INFO - Using real prefix '/usr' 05:30:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:14 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:16 INFO - Installing pip.................done. 05:30:16 INFO - Return code: 0 05:30:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:30:16 INFO - Reading from file tmpfile_stdout 05:30:16 INFO - Output received: 05:30:16 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) 05:30:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', '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 05:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:30:16 INFO - Using env: {'DISPLAY': ':0', 05:30:16 INFO - 'HOME': '/home/cltbld', 05:30:16 INFO - 'LANG': 'en_US.UTF-8', 05:30:16 INFO - 'LANGUAGE': 'en_US:en', 05:30:16 INFO - 'LOGNAME': 'cltbld', 05:30:16 INFO - 'MAIL': '/var/mail/cltbld', 05:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:16 INFO - 'MOZ_NO_REMOTE': '1', 05:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:16 INFO - 'NO_EM_RESTART': '1', 05:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:16 INFO - 'PWD': '/builds/slave/test', 05:30:16 INFO - 'SHELL': '/bin/bash', 05:30:16 INFO - 'SHLVL': '1', 05:30:16 INFO - 'TERM': 'linux', 05:30:16 INFO - 'TMOUT': '86400', 05:30:16 INFO - 'USER': 'cltbld', 05:30:16 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:16 INFO - '_': '/tools/buildbot/bin/python'} 05:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:30:16 INFO - Cleaning up... 05:30:16 INFO - Return code: 0 05:30:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', '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 05:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:30:16 INFO - Using env: {'DISPLAY': ':0', 05:30:16 INFO - 'HOME': '/home/cltbld', 05:30:16 INFO - 'LANG': 'en_US.UTF-8', 05:30:16 INFO - 'LANGUAGE': 'en_US:en', 05:30:16 INFO - 'LOGNAME': 'cltbld', 05:30:16 INFO - 'MAIL': '/var/mail/cltbld', 05:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:16 INFO - 'MOZ_NO_REMOTE': '1', 05:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:16 INFO - 'NO_EM_RESTART': '1', 05:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:16 INFO - 'PWD': '/builds/slave/test', 05:30:16 INFO - 'SHELL': '/bin/bash', 05:30:16 INFO - 'SHLVL': '1', 05:30:16 INFO - 'TERM': 'linux', 05:30:16 INFO - 'TMOUT': '86400', 05:30:16 INFO - 'USER': 'cltbld', 05:30:16 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:16 INFO - '_': '/tools/buildbot/bin/python'} 05:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:17 INFO - Downloading/unpacking psutil>=3.1.1 05:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:19 INFO - Installing collected packages: psutil 05:30:19 INFO - Running setup.py install for psutil 05:30:19 INFO - building 'psutil._psutil_linux' extension 05:30:19 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 05:30:19 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 05:30:19 INFO - building 'psutil._psutil_posix' extension 05:30:19 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 05:30:19 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 05:30:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:19 INFO - Successfully installed psutil 05:30:19 INFO - Cleaning up... 05:30:19 INFO - Return code: 0 05:30:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', '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 05:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:30:19 INFO - Using env: {'DISPLAY': ':0', 05:30:19 INFO - 'HOME': '/home/cltbld', 05:30:19 INFO - 'LANG': 'en_US.UTF-8', 05:30:19 INFO - 'LANGUAGE': 'en_US:en', 05:30:19 INFO - 'LOGNAME': 'cltbld', 05:30:19 INFO - 'MAIL': '/var/mail/cltbld', 05:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:19 INFO - 'MOZ_NO_REMOTE': '1', 05:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:19 INFO - 'NO_EM_RESTART': '1', 05:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:19 INFO - 'PWD': '/builds/slave/test', 05:30:19 INFO - 'SHELL': '/bin/bash', 05:30:19 INFO - 'SHLVL': '1', 05:30:19 INFO - 'TERM': 'linux', 05:30:19 INFO - 'TMOUT': '86400', 05:30:19 INFO - 'USER': 'cltbld', 05:30:19 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:19 INFO - '_': '/tools/buildbot/bin/python'} 05:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:30:20 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 05:30:20 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 05:30:20 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 05:30:20 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 05:30:20 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 05:30:20 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 05:30:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:30:22 INFO - Installing collected packages: mozsystemmonitor 05:30:22 INFO - Running setup.py install for mozsystemmonitor 05:30:22 INFO - Successfully installed mozsystemmonitor 05:30:22 INFO - Cleaning up... 05:30:22 INFO - Return code: 0 05:30:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', '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 05:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:30:22 INFO - Using env: {'DISPLAY': ':0', 05:30:22 INFO - 'HOME': '/home/cltbld', 05:30:22 INFO - 'LANG': 'en_US.UTF-8', 05:30:22 INFO - 'LANGUAGE': 'en_US:en', 05:30:22 INFO - 'LOGNAME': 'cltbld', 05:30:22 INFO - 'MAIL': '/var/mail/cltbld', 05:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:22 INFO - 'MOZ_NO_REMOTE': '1', 05:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:22 INFO - 'NO_EM_RESTART': '1', 05:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:22 INFO - 'PWD': '/builds/slave/test', 05:30:22 INFO - 'SHELL': '/bin/bash', 05:30:22 INFO - 'SHLVL': '1', 05:30:22 INFO - 'TERM': 'linux', 05:30:22 INFO - 'TMOUT': '86400', 05:30:22 INFO - 'USER': 'cltbld', 05:30:22 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:22 INFO - '_': '/tools/buildbot/bin/python'} 05:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:22 INFO - Downloading/unpacking jsonschema==2.5.1 05:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:30:24 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 05:30:24 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 05:30:24 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 05:30:24 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 05:30:24 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 05:30:24 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 05:30:24 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:24 INFO - warning: no files found matching '*.txt' 05:30:24 INFO - no previously-included directories found matching 'build' 05:30:24 INFO - no previously-included directories found matching 'dist' 05:30:24 INFO - no previously-included directories found matching '.git*' 05:30:24 INFO - Installing collected packages: jsonschema, functools32 05:30:24 INFO - Running setup.py install for functools32 05:30:24 INFO - warning: no files found matching '*.txt' 05:30:24 INFO - no previously-included directories found matching 'build' 05:30:24 INFO - no previously-included directories found matching 'dist' 05:30:24 INFO - no previously-included directories found matching '.git*' 05:30:24 INFO - Successfully installed jsonschema functools32 05:30:24 INFO - Cleaning up... 05:30:24 INFO - Return code: 0 05:30:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:24 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 0x24871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', '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 05:30:24 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 05:30:24 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 05:30:24 INFO - Using env: {'DISPLAY': ':0', 05:30:24 INFO - 'HOME': '/home/cltbld', 05:30:24 INFO - 'LANG': 'en_US.UTF-8', 05:30:24 INFO - 'LANGUAGE': 'en_US:en', 05:30:24 INFO - 'LOGNAME': 'cltbld', 05:30:24 INFO - 'MAIL': '/var/mail/cltbld', 05:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:24 INFO - 'MOZ_NO_REMOTE': '1', 05:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:24 INFO - 'NO_EM_RESTART': '1', 05:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:24 INFO - 'PWD': '/builds/slave/test', 05:30:24 INFO - 'SHELL': '/bin/bash', 05:30:24 INFO - 'SHLVL': '1', 05:30:24 INFO - 'TERM': 'linux', 05:30:24 INFO - 'TMOUT': '86400', 05:30:24 INFO - 'USER': 'cltbld', 05:30:24 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:24 INFO - '_': '/tools/buildbot/bin/python'} 05:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:30:25 INFO - Cleaning up... 05:30:25 INFO - Return code: 0 05:30:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', '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 05:30:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:30:25 INFO - Using env: {'DISPLAY': ':0', 05:30:25 INFO - 'HOME': '/home/cltbld', 05:30:25 INFO - 'LANG': 'en_US.UTF-8', 05:30:25 INFO - 'LANGUAGE': 'en_US:en', 05:30:25 INFO - 'LOGNAME': 'cltbld', 05:30:25 INFO - 'MAIL': '/var/mail/cltbld', 05:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:25 INFO - 'MOZ_NO_REMOTE': '1', 05:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:25 INFO - 'NO_EM_RESTART': '1', 05:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:25 INFO - 'PWD': '/builds/slave/test', 05:30:25 INFO - 'SHELL': '/bin/bash', 05:30:25 INFO - 'SHLVL': '1', 05:30:25 INFO - 'TERM': 'linux', 05:30:25 INFO - 'TMOUT': '86400', 05:30:25 INFO - 'USER': 'cltbld', 05:30:25 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:25 INFO - '_': '/tools/buildbot/bin/python'} 05:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:27 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 05:30:27 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 05:30:27 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 05:30:27 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 05:30:27 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 05:30:27 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 05:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:27 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 05:30:27 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 05:30:27 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 05:30:27 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 05:30:27 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 05:30:27 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 05:30:28 INFO - Downloading docopt-0.6.1.tar.gz 05:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:28 INFO - Running setup.py install for blobuploader 05:30:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:28 INFO - Running setup.py install for requests 05:30:28 INFO - Running setup.py install for docopt 05:30:28 INFO - Successfully installed blobuploader requests docopt 05:30:28 INFO - Cleaning up... 05:30:28 INFO - Return code: 0 05:30:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', '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 05:30:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:28 INFO - Using env: {'DISPLAY': ':0', 05:30:28 INFO - 'HOME': '/home/cltbld', 05:30:28 INFO - 'LANG': 'en_US.UTF-8', 05:30:28 INFO - 'LANGUAGE': 'en_US:en', 05:30:28 INFO - 'LOGNAME': 'cltbld', 05:30:28 INFO - 'MAIL': '/var/mail/cltbld', 05:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:28 INFO - 'MOZ_NO_REMOTE': '1', 05:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:28 INFO - 'NO_EM_RESTART': '1', 05:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:28 INFO - 'PWD': '/builds/slave/test', 05:30:28 INFO - 'SHELL': '/bin/bash', 05:30:28 INFO - 'SHLVL': '1', 05:30:28 INFO - 'TERM': 'linux', 05:30:28 INFO - 'TMOUT': '86400', 05:30:28 INFO - 'USER': 'cltbld', 05:30:28 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:28 INFO - '_': '/tools/buildbot/bin/python'} 05:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:29 INFO - Running setup.py (path:/tmp/pip-ojC66z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:29 INFO - Running setup.py (path:/tmp/pip-5hqWZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:29 INFO - Running setup.py (path:/tmp/pip-FML7AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:29 INFO - Running setup.py (path:/tmp/pip-_rrTZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:29 INFO - Running setup.py (path:/tmp/pip-pfI9h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:29 INFO - Running setup.py (path:/tmp/pip-h9Acca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:29 INFO - Running setup.py (path:/tmp/pip-3I4UJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:29 INFO - Running setup.py (path:/tmp/pip-LRM_ZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:29 INFO - Running setup.py (path:/tmp/pip-3vb29e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:29 INFO - Running setup.py (path:/tmp/pip-OOpjNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:29 INFO - Running setup.py (path:/tmp/pip-8d12gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:29 INFO - Running setup.py (path:/tmp/pip-5h1Jkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:29 INFO - Running setup.py (path:/tmp/pip-4u1tRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:30 INFO - Running setup.py (path:/tmp/pip-BylLsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:30 INFO - Running setup.py (path:/tmp/pip-CUtqDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:30 INFO - Running setup.py (path:/tmp/pip-jKogmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:30 INFO - Running setup.py (path:/tmp/pip-nQEJ2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:30 INFO - Running setup.py install for manifestparser 05:30:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:30 INFO - Running setup.py install for mozcrash 05:30:30 INFO - Running setup.py install for mozdebug 05:30:30 INFO - Running setup.py install for mozdevice 05:30:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:30:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:30 INFO - Running setup.py install for mozfile 05:30:30 INFO - Running setup.py install for mozhttpd 05:30:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:30 INFO - Running setup.py install for mozinfo 05:30:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Running setup.py install for mozInstall 05:30:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Running setup.py install for mozleak 05:30:31 INFO - Running setup.py install for mozlog 05:30:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Running setup.py install for moznetwork 05:30:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Running setup.py install for mozprocess 05:30:31 INFO - Running setup.py install for mozprofile 05:30:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Running setup.py install for mozrunner 05:30:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:31 INFO - Running setup.py install for mozscreenshot 05:30:31 INFO - Running setup.py install for moztest 05:30:31 INFO - Running setup.py install for mozversion 05:30:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:32 INFO - Cleaning up... 05:30:32 INFO - Return code: 0 05:30:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', '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 05:30:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:32 INFO - Using env: {'DISPLAY': ':0', 05:30:32 INFO - 'HOME': '/home/cltbld', 05:30:32 INFO - 'LANG': 'en_US.UTF-8', 05:30:32 INFO - 'LANGUAGE': 'en_US:en', 05:30:32 INFO - 'LOGNAME': 'cltbld', 05:30:32 INFO - 'MAIL': '/var/mail/cltbld', 05:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:32 INFO - 'MOZ_NO_REMOTE': '1', 05:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:32 INFO - 'NO_EM_RESTART': '1', 05:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:32 INFO - 'PWD': '/builds/slave/test', 05:30:32 INFO - 'SHELL': '/bin/bash', 05:30:32 INFO - 'SHLVL': '1', 05:30:32 INFO - 'TERM': 'linux', 05:30:32 INFO - 'TMOUT': '86400', 05:30:32 INFO - 'USER': 'cltbld', 05:30:32 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:32 INFO - '_': '/tools/buildbot/bin/python'} 05:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:32 INFO - Running setup.py (path:/tmp/pip-VuVFfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:32 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)) 05:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:32 INFO - Running setup.py (path:/tmp/pip-sFtvOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:32 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)) 05:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:32 INFO - Running setup.py (path:/tmp/pip-P0I8wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:32 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)) 05:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:32 INFO - Running setup.py (path:/tmp/pip-0YQzIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:32 INFO - Running setup.py (path:/tmp/pip-IiEv2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:32 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)) 05:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:32 INFO - Running setup.py (path:/tmp/pip-Z8RNy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:32 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)) 05:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:32 INFO - Running setup.py (path:/tmp/pip-DrPkaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:32 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)) 05:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:32 INFO - Running setup.py (path:/tmp/pip-XwngW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:32 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)) 05:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:32 INFO - Running setup.py (path:/tmp/pip-JBEzcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:32 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)) 05:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:32 INFO - Running setup.py (path:/tmp/pip-CGW5vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:33 INFO - Running setup.py (path:/tmp/pip-q45o7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:33 INFO - Running setup.py (path:/tmp/pip-DdPFWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:33 INFO - Running setup.py (path:/tmp/pip-8iIYEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:33 INFO - Running setup.py (path:/tmp/pip-FwnMUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:33 INFO - Running setup.py (path:/tmp/pip-12hQM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:33 INFO - Running setup.py (path:/tmp/pip-fnMGhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:33 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)) 05:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:33 INFO - Running setup.py (path:/tmp/pip-y4hS6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:33 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)) 05:30:33 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)) 05:30:33 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)) 05:30:33 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)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30:35 INFO - Downloading blessings-1.6.tar.gz 05:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:35 INFO - Installing collected packages: blessings 05:30:35 INFO - Running setup.py install for blessings 05:30:35 INFO - Successfully installed blessings 05:30:35 INFO - Cleaning up... 05:30:35 INFO - Return code: 0 05:30:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:36 INFO - Reading from file tmpfile_stdout 05:30:36 INFO - Current package versions: 05:30:36 INFO - argparse == 1.2.1 05:30:36 INFO - blessings == 1.6 05:30:36 INFO - blobuploader == 1.2.4 05:30:36 INFO - docopt == 0.6.1 05:30:36 INFO - functools32 == 3.2.3-2 05:30:36 INFO - jsonschema == 2.5.1 05:30:36 INFO - manifestparser == 1.1 05:30:36 INFO - mozInstall == 1.12 05:30:36 INFO - mozcrash == 1.0 05:30:36 INFO - mozdebug == 0.1 05:30:36 INFO - mozdevice == 0.49 05:30:36 INFO - mozfile == 1.2 05:30:36 INFO - mozhttpd == 0.7 05:30:36 INFO - mozinfo == 0.9 05:30:36 INFO - mozleak == 0.1 05:30:36 INFO - mozlog == 3.4 05:30:36 INFO - moznetwork == 0.27 05:30:36 INFO - mozprocess == 0.24 05:30:36 INFO - mozprofile == 0.28 05:30:36 INFO - mozrunner == 6.13 05:30:36 INFO - mozscreenshot == 0.1 05:30:36 INFO - mozsystemmonitor == 0.3 05:30:36 INFO - moztest == 0.8 05:30:36 INFO - mozversion == 1.4 05:30:36 INFO - psutil == 3.1.1 05:30:36 INFO - requests == 1.2.3 05:30:36 INFO - wsgiref == 0.1.2 05:30:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:36 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 0x24871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', '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 05:30:36 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 05:30:36 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 05:30:36 INFO - Using env: {'DISPLAY': ':0', 05:30:36 INFO - 'HOME': '/home/cltbld', 05:30:36 INFO - 'LANG': 'en_US.UTF-8', 05:30:36 INFO - 'LANGUAGE': 'en_US:en', 05:30:36 INFO - 'LOGNAME': 'cltbld', 05:30:36 INFO - 'MAIL': '/var/mail/cltbld', 05:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:36 INFO - 'MOZ_NO_REMOTE': '1', 05:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:36 INFO - 'NO_EM_RESTART': '1', 05:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:36 INFO - 'PWD': '/builds/slave/test', 05:30:36 INFO - 'SHELL': '/bin/bash', 05:30:36 INFO - 'SHLVL': '1', 05:30:36 INFO - 'TERM': 'linux', 05:30:36 INFO - 'TMOUT': '86400', 05:30:36 INFO - 'USER': 'cltbld', 05:30:36 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:36 INFO - '_': '/tools/buildbot/bin/python'} 05:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:36 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)) 05:30:36 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)) 05:30:36 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)) 05:30:36 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)) 05:30:36 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)) 05:30:36 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)) 05:30:36 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)) 05:30:36 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)) 05:30:36 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)) 05:30:36 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)) 05:30:36 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)) 05:30:36 INFO - Cleaning up... 05:30:36 INFO - Return code: 0 05:30:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:36 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 0x24871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2653a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f8c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', '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 05:30:36 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 05:30:36 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 05:30:36 INFO - Using env: {'DISPLAY': ':0', 05:30:36 INFO - 'HOME': '/home/cltbld', 05:30:36 INFO - 'LANG': 'en_US.UTF-8', 05:30:36 INFO - 'LANGUAGE': 'en_US:en', 05:30:36 INFO - 'LOGNAME': 'cltbld', 05:30:36 INFO - 'MAIL': '/var/mail/cltbld', 05:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:36 INFO - 'MOZ_NO_REMOTE': '1', 05:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:36 INFO - 'NO_EM_RESTART': '1', 05:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:36 INFO - 'PWD': '/builds/slave/test', 05:30:36 INFO - 'SHELL': '/bin/bash', 05:30:36 INFO - 'SHLVL': '1', 05:30:36 INFO - 'TERM': 'linux', 05:30:36 INFO - 'TMOUT': '86400', 05:30:36 INFO - 'USER': 'cltbld', 05:30:36 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:36 INFO - '_': '/tools/buildbot/bin/python'} 05:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:30:36 INFO - Cleaning up... 05:30:36 INFO - Return code: 0 05:30:36 INFO - Running post-action listener: _resource_record_post_action 05:30:36 INFO - Running post-action listener: _start_resource_monitoring 05:30:36 INFO - Starting resource monitoring. 05:30:36 INFO - [mozharness: 2017-02-03 13:30:36.507650Z] Finished create-virtualenv step (success) 05:30:36 INFO - [mozharness: 2017-02-03 13:30:36.508109Z] Running install step. 05:30:36 INFO - Running pre-action listener: _resource_record_pre_action 05:30:36 INFO - Running main action method: install 05:30:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:36 INFO - Reading from file tmpfile_stdout 05:30:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:36 INFO - Reading from file tmpfile_stdout 05:30:36 INFO - Output received: 05:30:36 INFO - Usage: mozinstall [options] installer 05:30:36 INFO - Options: 05:30:36 INFO - -h, --help show this help message and exit 05:30:36 INFO - -d DEST, --destination=DEST 05:30:36 INFO - Directory to install application into. [default: 05:30:36 INFO - "/builds/slave/test"] 05:30:36 INFO - --app=APP Application being installed. [default: firefox] 05:30:36 INFO - mkdir: /builds/slave/test/build/application 05:30:36 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'] 05:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:30:54 INFO - Reading from file tmpfile_stdout 05:30:54 INFO - Output received: 05:30:54 INFO - /builds/slave/test/build/application/firefox/firefox 05:30:54 INFO - Running post-action listener: _resource_record_post_action 05:30:54 INFO - [mozharness: 2017-02-03 13:30:54.313027Z] Finished install step (success) 05:30:54 INFO - [mozharness: 2017-02-03 13:30:54.313309Z] Running run-tests step. 05:30:54 INFO - Running pre-action listener: _resource_record_pre_action 05:30:54 INFO - Running main action method: run_tests 05:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:54 INFO - Python 2.7.3 05:30:54 INFO - Return code: 0 05:30:54 INFO - grabbing minidump binary from tooltool 05:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:54 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 0x27f63f0>, '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 0x27f6cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f71a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:54 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 05:30:54 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 05:30:54 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 05:30:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:54 INFO - Return code: 0 05:30:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:30:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:30:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:54 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/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:30:54 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/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 05:30:54 INFO - Using env: {'DISPLAY': ':0', 05:30:54 INFO - 'HOME': '/home/cltbld', 05:30:54 INFO - 'LANG': 'en_US.UTF-8', 05:30:54 INFO - 'LANGUAGE': 'en_US:en', 05:30:54 INFO - 'LOGNAME': 'cltbld', 05:30:54 INFO - 'MAIL': '/var/mail/cltbld', 05:30:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:54 INFO - 'MOZ_NO_REMOTE': '1', 05:30:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:54 INFO - 'NO_EM_RESTART': '1', 05:30:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:54 INFO - 'PWD': '/builds/slave/test', 05:30:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:54 INFO - 'SHELL': '/bin/bash', 05:30:54 INFO - 'SHLVL': '1', 05:30:54 INFO - 'TERM': 'linux', 05:30:54 INFO - 'TMOUT': '86400', 05:30:54 INFO - 'USER': 'cltbld', 05:30:54 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761', 05:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:54 INFO - '_': '/tools/buildbot/bin/python'} 05:30:54 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/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:30:54 INFO - mozversion application_buildid: 20170203122547 05:30:54 INFO - mozversion application_changeset: 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 05:30:54 INFO - mozversion application_display_name: Nightly 05:30:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:54 INFO - mozversion application_name: Firefox 05:30:54 INFO - mozversion application_remotingname: firefox 05:30:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:30:54 INFO - mozversion application_vendor: Mozilla 05:30:54 INFO - mozversion application_version: 54.0a1 05:30:54 INFO - mozversion platform_buildid: 20170203122547 05:30:54 INFO - mozversion platform_changeset: 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 05:30:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:30:54 INFO - mozversion platform_version: 54.0a1 05:30:54 INFO - using testdate: 1486128654 05:30:54 INFO - actual date: 1486128654 05:30:54 INFO - starting webserver on 'localhost:51137' 05:30:54 INFO - SUITE-START | Running 2 tests 05:30:54 INFO - TEST-START | dromaeo_css 05:30:54 INFO - operating with platform_type : linux_ 05:30:54 INFO - Initialising browser for dromaeo_css test... 05:30:54 INFO - TEST-INFO | started process 21310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9bFQ0X/profile http://localhost:51137/getInfo.html) 05:30:57 INFO - PROCESS | 21310 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:30:58 INFO - PROCESS | 21310 | __metrics Screen width/height:1600/1200 05:30:58 INFO - PROCESS | 21310 | colorDepth:24 05:30:58 INFO - PROCESS | 21310 | Browser inner width/height: 1024/697 05:30:58 INFO - PROCESS | 21310 | __metrics 05:30:58 INFO - PROCESS | 21310 | 1486128658877 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:30:59 INFO - PROCESS | 21310 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:30:59 INFO - PROCESS | 21310 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:59 INFO - PROCESS | 21310 | console.error: PushService: 05:30:59 INFO - PROCESS | 21310 | stateChangeProcessEnqueue: Error transitioning state 05:30:59 INFO - PROCESS | 21310 | UnknownError 05:31:00 INFO - TEST-INFO | 21310: exit 0 05:31:00 INFO - Browser initialized. 05:31:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:00 INFO - TEST-INFO | started process 21394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9bFQ0X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:12 INFO - PROCESS | 21394 | RSS: Main: 148574208 05:31:12 INFO - PROCESS | 21394 | 05:34:14 INFO - PROCESS | 21394 | Cycle 1(1): loaded http://localhost:51137/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51137/tests/dromaeo/cssquery-ext.html) 05:34:16 INFO - PROCESS | 21394 | RSS: Main: 289714176 05:34:16 INFO - PROCESS | 21394 | 05:36:02 INFO - PROCESS | 21394 | ************************* 05:36:02 INFO - PROCESS | 21394 | A coding exception was thrown and uncaught in a Task. 05:36:02 INFO - PROCESS | 21394 | 05:36:02 ERROR - PROCESS | 21394 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:36:02 INFO - PROCESS | 21394 | Full stack: 05:36:02 INFO - PROCESS | 21394 | ************************* 05:37:18 INFO - PROCESS | 21394 | Cycle 1(1): loaded http://localhost:51137/tests/dromaeo/cssquery-ext.html (next: http://localhost:51137/tests/dromaeo/cssquery-jquery.html) 05:37:19 INFO - PROCESS | 21394 | RSS: Main: 249556992 05:37:19 INFO - PROCESS | 21394 | 05:40:21 INFO - PROCESS | 21394 | Cycle 1(1): loaded http://localhost:51137/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51137/tests/dromaeo/cssquery-mootools.html) 05:40:21 INFO - PROCESS | 21394 | RSS: Main: 188092416 05:40:21 INFO - PROCESS | 21394 | 05:43:24 INFO - PROCESS | 21394 | Cycle 1(1): loaded http://localhost:51137/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51137/tests/dromaeo/cssquery-prototype.html) 05:43:24 INFO - PROCESS | 21394 | RSS: Main: 231997440 05:43:24 INFO - PROCESS | 21394 | 05:46:27 INFO - PROCESS | 21394 | Cycle 1(1): loaded http://localhost:51137/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51137/tests/dromaeo/cssquery-yui.html) 05:46:28 INFO - PROCESS | 21394 | RSS: Main: 183201792 05:46:28 INFO - PROCESS | 21394 | 05:49:30 INFO - PROCESS | 21394 | Cycle 1(1): loaded http://localhost:51137/tests/dromaeo/cssquery-yui.html (next: http://localhost:51137/tests/dromaeo/cssquery-dojo.html) 05:49:31 INFO - PROCESS | 21394 | RSS: Main: 267669504 05:49:31 INFO - PROCESS | 21394 | 05:49:31 INFO - PROCESS | 21394 | __start_tp_report 05:49:31 INFO - PROCESS | 21394 | _x_x_mozilla_page_load 05:49:31 INFO - PROCESS | 21394 | _x_x_mozilla_page_load_details 05:49:31 INFO - PROCESS | 21394 | |i|pagename|runs| 05:49:31 INFO - PROCESS | 21394 | |0;dojo.html;3155.132338606883;3174.206448387903;3211.181148807054;3212.2290650243917;3219.565358676578;5333.413324534303;5363.865903352418;5406.243125962368;5408.783648654054;5416.485433883785;5430.456954304577;5433.918491222635;5449.618526703122;5479.589030822684;5525.11598144296;4635.652326075541;4798.352222449977;4948.678335908173;4953.653244272902;5036.370453693288;4749.26386410107;4779.569838714515;4918.483559226283;4921.7785199666105;4932.210846264598;4780.354652121971;4830.516948305177;4846.660733748639;4852.757362131879;4912.926306105412;4885.36490256268;4895.437024742165;4895.779689913962;4903.19097348937;4937.901241975141;4737.620990320766;4854.053459575384;4895.143349913751;4901.8774530636665;4950.777215025332;5304.2839216706025;5387.542058924996;5451.754671039773;5478;5519.779208831642;5844.298684157886;5851.824445266649;5855;5856.32652244993;5856.853578660568;5906.055031194988;5918;5930.584859059867;5938.435848594377;5939.227900372924;5356.330458692663;5396.19057141428;5439.401665816757;5476.726163691799;5478.58910581708;5765.135229715493;5960.0165972614905;5962.761489540369;5963.075723262901;6021.578489505692;5523.309586301712;5613.129964855454;5649.378568357477;5650.039493286151;5666.263385759908;5752.424757524214;5766.654000759884;5827.562932780059;5840.941590584125;5882.794102206402;5858.765649373977;5859.1797148399255;5859.794907178229;5861.589688721749;5866;5512.476314750093;5555.361133469622;5750.079987202112;5769.624974376652;5830.038043722823;4508.41390619224;4509.233430316854;4513.368128462018;4546.272596384629;4553.795079221377;4007.479027726377;4012.3981402789814;4016;4040.878773636796;4051.1897620476025;5284;5299.072662284085;5305.840824775263;5371.274877891513;5372.194170874322;5793.304803423616;5798.10129429939;5855.3851845556455;5856.355800861902;5862.237909071879;5326.547243484347;5364.6512976656395;5372.650777699437;5377.247185394048;5378.7041712705395;5004.324416203839;5010.298558201855;5010.774515146827;5011.774470148852;5012.699238045729;6045.425684559959;6055.697215139226;6089.5737298388685;6101.314587553275;6122.142899994094;5966.343702192842;5977.790777322773;6012.518998480198;6014.8195554133445;6023.759049638141;6152.323244443018;6164.7842325518395;6166.044263139221;6166.4758495526585;6171.105189747551;5588.720563971704;5635.239242702182;5878.088896221093;5882.764689412375;5891.38140495259;5825.097109947965;5849.502792262705;5871.882562348644;5912.73392697321;5953.583249172516;5566.137248726453;5620.690862002465;5628.943710563006;5738.85222955419;5740.741666624928;5642.181883626769;5642.181883626933;5654.943450565442;5756.251687280626;5760.366359700346;5693.971530142323;5739.540836733135;5745.770169193185;5748.223989761496;5754.050581654147;5517.751701173376;5591.580631452576;5745.080787074048;5755.223044889054;5768.711564421678;5587.860303492445;5600.7199640017025;5631.49316561495;5648.604597678123;5691.402402747652 05:49:31 INFO - PROCESS | 21394 | |1;ext.html;530.6915098307694;567.7076305702562;605.9272887253529;627.9277883043451;636.8567072408708;32437.837810810972;44220.77889610551;45031;45115.54884451155;49357.753211233896;45615.31577026347;46300.76849615756;46303.536964630344;46363.30455043168;46367.53632463674;7890.421915616871;9067.365284430092;9257.351985361027;9264.7683807905;9266;7917.722879699211;10672.35965842048;10869.945650271737;10921.672349829518;11036.944815275952;11000.559977600886;11088.833667494993;11115.72210694731;11117.22179447439;11118.22172447929;10944.835827462595;10957;11008.834867476995;11020.669379918616;11034.503447344849;10781.191410644155;10856.294340867818;10857.077148442391;10857.294275872044;10857.782844343068;43642.34536481955;43889.34165987513;43941.12117757627;44039.33940990888;44047;3984.1035766952496;4021.718479706422;4024.1146947671464;4050.9392359114636;4192.5807419258135;31849.8407507961;32062.839685801657;32102.197445063826;32138.678613213804;33860;4090.509138903321;4239.194553034913;4267.869014711073;4362.411074504965;4424.491183513905;230178;231916;232103;232630;232908.9999999983;60517.69741151354;60519;60716.39283607196;60740.39259607436;60785.392146078855;64887.35112648908;64890;65041.67479162574;65075;65202.34797652058;16918.577035573962;17116.828831711773;17148.05685687299;17154;17157.142142892804;11826;12070.577529786415;12849.550265740654;13195;13273.734525309439;17089.145542722814;17236.741448878278;17266.395676151275;17331.566710832078;17415.47753567395;6829.214640316328;7042.366187043191;7051.753188638373;7132.322429369202;7139.75054365484;911.9635214591342;915.624593916491;932.9440233586007;953.0802775321848;962.8988956159502;30675.69324306773;32045.033019881954;32441.513377299358;32548.6550514288;32727.83636081852;1102.1953973599318;1105.3865104866877;1107;1136.9658910232706;1226.399064458409;16248.268827902773;17006.319747210222;17068;17102.914485427493;17319.480415587554;152720.2363988173;152964;153338;153486;153607;63326.366736332966;63411.36588634054;63427;63473;63503;1398.356755892301;1434.4333988074861;1444.1046551138152;1445.0534899640961;1451.8548145185607;29918.850405748704;30883.536746948364;31301;31974.536910006584;32171.51742723814;52136.47863521316;52636;52844.65864096333;52902.73548632232;52907;290037;290675;291592;293444;294231;34489.48265776066;36781;40739.55562666249;40954.38568421416;41176.1764764709;46779.53220467888;48227.51772482371;48499.75750121227;48774.268385974945;49089.50910490992;39726;40636.1872762549;41619.58380416157;42495;42924.78537607292;39779.60220397875;40027.3995890056;40527.79736101301;40935.18129637331;41959;37422;37933.81033094817;38043.61956380401;40369.39445908373;40849.59150408458;29850.402991939605;31984.36031279315;32682.50976235406;33104.83447582747;33238.50142247917;25283;25284.747152528238;25930.481390372464;26398.472030559664;26581.33546661349 05:49:31 INFO - PROCESS | 21394 | |2;jquery.html;434.43957295089336;445.2942086792434;446.94636643602763;452.39605127155244;452.9977350113249;19274.32539861105;21324.46688832778;21401;22052.558948821013;22321;20920.581588368223;21410;21455.141794328207;21515.892420537915;21674.89162554185;5021.497850214986;5938.346781854003;6157.938420615804;6161.168242287279;6164.5376596755195;5950.5834591578605;5960.642361458305;6003.1895694081395;6012.098185272201;6020.12708157317;5796.768129274824;5993.85015374617;5999.1301261317085;6001.60989535681;6052.878942421149;5960.284765828107;5989.43100405463;5994.490468310199;5998.790042348519;6004.219451471325;5353.652012619206;5443.455654434564;5448.8365349039195;5476.069068258365;5487.149491828773;24895.50208995828;24924.626130608056;25043.749562504505;25092;25309.114181003577;3110.580071690338;3207.3745619604188;3229.3218424130728;3233.417984762742;3286.145602143436;10717.53584198197;11133.72165695856;11179.83230251547;11342.71643208918;11350.829737553944;1859.944201673952;1885.2459016393416;1916.281394477071;1941.1555973151724;1946.523101840044;95276.52361738216;95765.5211723944;96622.51688741581;97356.0264397354;98296.50851745695;11924.880751192377;12086.456109474919;12098.939505302593;12564.434600442819;12702.555410560772;17516.649667006845;17518.737218941726;17639.73540396895;17639.73540396895;17650.735238971425;8558.272546833588;8693.782655433539;8909.73270801877;8989.235914947303;9046.773830654287;8160.918390816135;8212.425130240827;8303.709370172015;8463.703770368007;8468.703595374132;5332.520073193431;5346.385165705994;5387.703676297841;5398.839249561363;5551.333839939233;2015.6674148765583;2170.3488953313945;2237.574860776447;2243.9214627488286;2252.1441852096427;853.5007020892723;886.2776836877924;893.7140115163215;895.7715782475557;901.8241442918699;21544.676829847565;21983;21996.89001554982;22059;22117.115315387204;884.1335491218641;889.3596610440472;905.3707673167218;907.5689047702289;911.8176364727082;11356.261842980344;11688.357140357191;11892.821607675893;11998.340091294887;12056.095792815573;612433;620691;622341;633696;645331;105989;106070;109141;110620;110994.44502777435;1080.90812280957;1093.1309608860975;1098.9010989010867;1109.1293334732197;1113.0316624536542;17927.820721792614;18209.362672306404;18898.338558150397;18927.90536047311;19067.141978610718;44796.32805507985;44829.32756008728;44879;45115.32327015163;45222.77388613036;63859.6807015962;64248.67875660592;64274.67862660657;65072;66468;8562.957185214034;8655.870161947701;8801.691940782042;8842.159994800484;9031.819363612822;12873.871261287642;13297.800532992207;13360.198388096745;13790.65523361924;13891.930540347637;11754.177207595387;11989.64031079069;12193.573224937085;12253.877461225273;12421.714508494555;11700.590479333523;11892.989095926598;11909.583164589198;12024.398780061138;12246.387680616112;10491.213159013258;11644.184907056424;11731.88268117308;12065.879341206826;12431.316277604457;8460.111688272642;8579.65681372738;8648.524331161594;8808.823823523622;9257.67598134062;10502.78994420092;12149.205682693208;12184.51261949512;12201.633950981484;12315.305408377271 05:49:31 INFO - PROCESS | 21394 | |3;mootools.html;1256.9371531423426;1402.172718096323;1421.104704036457;1427.0866645346975;1432.1192466633017;7484.775456736293;8290.212429819172;8597.699080532182;8605.311575074002;8776.69281575145;8563.229309362156;8613.698520551767;8642.870356944652;8653.048164701877;8658.696945606906;1988.4332965104948;2059.5366042640435;2349.5418393413247;2384.833061685683;2387.7373488916205;2155.687425323335;2211.845170838042;2217.7782221777857;2244.2481768607536;2244.427670943907;2277.87471689057;2312.36409987254;2313.838031337807;2316.9073237070497;2318.5015221727326;2335.74306826249;2344.2732752846673;2359.634256690216;2365.9645105323348;2368.0764501844296;2309.56118337517;2351.5179388225542;2360.5632957902844;2361.1853910400882;2370.751071137523;8681.913180868174;8756.343274254456;8772.42979206356;8778.29773618109;8791.868121978176;5243.9213411798855;5366.141417373202;5371.59713021521;5382.354117505885;5390.568754499631;3052.3284877327173;3214.4696125139326;3353.446681297583;3354.932901341984;3373.7975721456546;1322.3123975532765;1348.2651954684623;1382.453930697379;1400.138914567544;1405.6204824697274;11679.182457227997;11786.116041296937;11818.054555635528;11822.172447928562;11824.23142495735;4602.585767280961;4701.34574561317;4709.222978208626;4785.105011468012;4853.733044682505;10014.599416023277;10029.749256268651;10032.79934401308;10033.548490317953;10036.297459177933;5375.059364611177;5405.459454054563;5412.621116521885;5414.269073675082;5421.972890135524;4156.937645935313;4585.9770701146945;4963.404391473046;5010;5054.721990290569;3959.287328280937;3971.900702482403;4003.6596889264156;4069.9389509156795;4093.5497095319492;1311.2984553263957;1318.756030134428;1322.5172811923578;1328.4059129045183;1344.1867670059669;965.290511474066;968.8837339519162;970.6020531582018;973.3235401396104;983.955721992512;5651.237082993744;5724.341700704473;5815.912761308584;5833.241678581757;5948.405159484104;639.5043841023244;655.8098151536001;663.2538394306405;668.812732434919;670.8121725916751;3896.8636097736444;3918.2163567286657;3921.3725803871816;3933.095388060762;3986.740861843971;9758.414495130315;10281.845772313422;10298.382097074049;10550.841737373792;10574.682759517227;10308.536115874804;10327.586896524204;10416.218783591261;10442.060214580724;10467.633632822815;7895;8115.553644549488;8126.55303958288;8140.267375936194;8143.429959902868;5784.537237020944;5866.325372582037;5887.793927212527;6005.699715014319;6078.6048906820915;8981.595828187617;9432;9450.291228157777;9456.479893605918;9477.810443790948;9759.80480390374;9771.951140244253;9777.266704997011;9783.608655653694;9785.021497850157;6484.675766211765;6700.765473208609;6703.229128650268;7598.810029749079;7713.807154821175;7389.593572353572;7475.775726727989;8131.390145738975;8247.134050924567;8341.374396920377;7351.8162045949275;7401.0748656417945;7517.135529414188;7595.3164215220895;7657.1959944205055;7229.566226026455;7287.489875708861;7338.816529586803;7353.77938661841;7359.080114985627;6637.369449902251;6753.223379311442;6753.358430949052;6758.155230596176;6764.797056088325;5240.135377662643;5265.289185959847;5277.973610132079;5287.418383977682;5534.750936207961;5298.94701053;5338.946610534001;5407.107827208467;5447.291852059207;5497.038018346853 05:49:31 INFO - PROCESS | 21394 | |4;prototype.html;400.6854619123988;401.3938952182204;419.37303730922275;419.4337644180357;425.05001322045223;5263.131583288758;5317.601179911503;5321.787128514865;5322.175062865253;5340.465953404662;5121.513456221663;5247.819240670847;5266.552343050846;5268.998890210857;5305.469453054692;4154.563770804068;4181.268278051344;4184.832606695743;4189.79051047448;4192.182524407742;4167.854125105622;4178.540360560336;4185.874423767292;4195.895102622429;4228.302330115543;4060.9137055837587;4090.8159132839096;4099.549049604541;4127.876163715078;4135.4623898893105;4094.1780907496177;4119.599336225668;4120.381942708617;4135.7518548886865;4135.793210339486;3686.562240726119;3689.815509224528;3694.224212915291;3696.2053158570766;3717.4795528626014;4907.681000734977;5138.2806407103035;5217.34783152106;5241.135212689902;5303.522682958553;4951.183054795954;4956.504349565051;4973.825916092919;4986.775595098229;4989.652793745705;5641.802536911188;5645.15322701594;5649.548036157139;5656.632318899258;5662.546996240291;4186.346393174709;4302.9569704303185;4360.869173924787;4368.7815609219415;4370.601407549585;5529.502344788948;5621.919889640859;5646.858828529279;5790.739416726257;5826.329972053183;4412.7793610319995;4414.779261036935;4417.8232870684815;4432.202203603318;4446.110777844444;4280.5505421930875;4484.506704262529;4490.461144662596;4501.942043619747;4507.3689683444345;4788.569028787426;4827.465580570159;4891.290762839369;4915.87710307238;4932.901341973212;5578.944210557924;5602.579806514527;5609.354924183689;5610.363129329209;5621.964139364697;1478.8982208254704;1511.3803340630288;1514.2201766090473;1516.5526169779941;1522.1552038618672;1075.4568942683895;1091.1598069486452;1114.2979922648842;1116.625930313354;1128.5937062657438;5049.444561098277;5053.646244762831;5055.51972562606;5078.21287700407;5086.880886205029;5415.593830462731;5486.670799752028;5499.642523235977;5502.0371434998715;5512.200730894078;4897.706137631753;5053.9494605054215;5069.239614057847;5080.399674102646;5104.897902042013;2884.365439603284;2899.4635992341487;2909.839958802244;2926.9121926342245;2951.232679503302;5680.693440508623;5685.630434021776;5698.6580805151;5705.5150312223095;5718.914216286759;5241.13521268994;5583.860403489864;5589.245451864028;5596.944030559724;5607.186957891083;5653.745581448845;5661.348944871393;5684.232628595087;5688.274180411837;5738;5365.9463405367005;5525.281713377235;5543.861403464945;5555.583331250254;5558.138488534284;5352.511082346728;5479.561635069105;5496.890062198813;5666.688332141772;5694.772209111755;5865.501432378295;5875.206847075761;5881.705914704333;5887.646741195542;5893.233879595797;4183.895402614959;4206.432131662309;4206.453161089161;4207.347861081537;4216.494020717533;5392.5416339611575;5644.379118297066;5706.2011318414625;5711.8000869969355;5729.742161602655;5528.9723551381985;5529.4470552944385;5536.397892990288;5587.5809314302405;5611.607187496836;5269.4443195051135;5513;5602.13166959122;5607.691576963306;5627.380988091225;5511.283533140666;5555.2778138841695;5603.859903502445;5604.719764011865;5611.092228642281;5594.300712410949;5597.684544132044;5601.4315991522435;5635.098384258499;5645.633033852787;5123.23151527259;5403.486668766461;5405.162199859028;5451.48210919962;5487.807926722546 05:49:31 INFO - PROCESS | 21394 | |5;yui.html;752.9698812047515;787.9133295337512;835.8579041562933;837.6733074101105;870.9433886797358;14794.630134246649;15422.768658470104;15534.456294029711;15541.689166216684;15591.922040389796;15043.548693539211;15204.391824327042;15206.23968801561;15208.619784505392;15215.39138434464;740.8259059121102;745.3105877063695;758.93928485721;769.7960040589248;770.4606775257314;771.3096778383343;772.7913463364888;773.4585789947031;773.4740376543948;773.5899973014311;806.8305655812286;810.5541951926417;810.7081450677781;811.6875003123811;812.7033632724073;805.0138580239219;805.1304591041661;806.4999700185864;806.6652339279192;806.8023334283109;594.2660813894836;594.4234092929851;594.46201187925;594.7115648910275;594.8304733151031;13831.377588008563;13886.791698124536;13900.096493727875;14261.358238879275;15491.612709682235;14247.430102795875;14670.559883203521;14827.332770025374;14849.480268190562;14999.550013499504;11644.650660480114;11809.527618895234;11817.054635629129;11997.94001029998;12203.267803931793;3651.415773476231;3654.068212605795;3676.356637588438;3700.6854417374557;3741.663250307485;76990.23009769886;77902.61048694777;78075.60962195153;78119;79547.6022619889;11470.254433461798;11497.942510287396;11501.482433290523;11502.88497115018;11812.52749890012;21988.450288742908;22250.55498890013;22538.774612253994;22546.210882619358;22547.88726056392;6912;7799.610019499002;8051.51690898548;8116.513009219466;8125.471844330218;4537.09258148365;4589.773959629643;4675.6727029108315;4687.695299805502;4712.929306060412;3572.6070132285427;3577.8747743829363;3630.6006339302658;3637.5089362935664;3665.9266814663556;628.1425853709653;634.1312402009185;635.6821589205397;653.8267359149829;658.6037600287326;755.8186035351476;758.1584441270186;776.6349815586665;786.3080489169608;801.9679212831421;10112.898871011195;10512.474376281156;10625.840612390666;10630.46847657614;10640.414777187329;704.6688056613383;706.1032488739272;711.4664001998501;720.1070672366228;721.3904250907974;4686.929696054562;4932.55606995365;4996.500349964975;5019.723915184627;5033.194688849767;79384.1385688227;81104;82159.17840821635;83766.58116709377;84151.15848841556;44038.33942490865;47384.5261547387;53408.1988770161;74301;75926;61753.691231543555;61994.38005619886;62665.37334626687;63182.36817631857;64713;9984.750381240527;10378.636747713794;10524.789504210026;10543.26197166191;10651.840222396826;39432.769860785884;39745.40381894216;40263;40454.79772601118;41578.792106040484;46187.76906115582;49816.75091624519;51928.22107668313;52096.03147400199;52551.737241313545;12963.805542916674;13019.283939383426;13118.737625247633;13136.408861601441;13192.274424906722;14953.177575233467;15022.323995420014;15055.698886022437;15145.469908553148;15640.374385024472;13536.729265414833;14017.719645607234;14215.50245741394;15006.549803505912;15090.622734431727;13477.730445391233;13493.865061349261;13613.251271180181;13668.52160174389;13966.371513281723;13889.305534723426;13964.581062568139;14292;14313.642158945693;14963.625909352353;11055.065363561505;11111.111111111253;11540.826887596524;11586.188966772244;11805.114616403976;9955.601775928882;10072.597096116073;10636.84044739345;10776.191785616267;10802.72993175177 05:49:31 INFO - PROCESS | 21394 | __end_tp_report 05:49:31 INFO - PROCESS | 21394 | __start_cc_report 05:49:31 INFO - PROCESS | 21394 | _x_x_mozilla_cycle_collect,1488 05:49:31 INFO - PROCESS | 21394 | __end_cc_report 05:49:31 INFO - PROCESS | 21394 | __startTimestamp1486129771052__endTimestamp 05:49:31 INFO - PROCESS | 21394 | 05:49:31 INFO - PROCESS | 21394 | ------- Summary: start ------- 05:49:31 INFO - PROCESS | 21394 | Number of tests: 6 05:49:31 INFO - PROCESS | 21394 | 05:49:31 INFO - PROCESS | 21394 | [#0] dojo.html Cycles:165 Average:5403.90 Median:5591.58 stddev:625.93 (11.2%) stddev-sans-first:602.48 05:49:31 INFO - PROCESS | 21394 | Values: 3155.1 3174.2 3211.2 3212.2 3219.6 5333.4 5363.9 5406.2 5408.8 5416.5 5430.5 5433.9 5449.6 5479.6 5525.1 4635.7 4798.4 4948.7 4953.7 5036.4 4749.3 4779.6 4918.5 4921.8 4932.2 4780.4 4830.5 4846.7 4852.8 4912.9 4885.4 4895.4 4895.8 4903.2 4937.9 4737.6 4854.1 4895.1 4901.9 4950.8 5304.3 5387.5 5451.8 5478.0 5519.8 5844.3 5851.8 5855.0 5856.3 5856.9 5906.1 5918.0 5930.6 5938.4 5939.2 5356.3 5396.2 5439.4 5476.7 5478.6 5765.1 5960.0 5962.8 5963.1 6021.6 5523.3 5613.1 5649.4 5650.0 5666.3 5752.4 5766.7 5827.6 5840.9 5882.8 5858.8 5859.2 5859.8 5861.6 5866.0 5512.5 5555.4 5750.1 5769.6 5830.0 4508.4 4509.2 4513.4 4546.3 4553.8 4007.5 4012.4 4016.0 4040.9 4051.2 5284.0 5299.1 5305.8 5371.3 5372.2 5793.3 5798.1 5855.4 5856.4 5862.2 5326.5 5364.7 5372.7 5377.2 5378.7 5004.3 5010.3 5010.8 5011.8 5012.7 6045.4 6055.7 6089.6 6101.3 6122.1 5966.3 5977.8 6012.5 6014.8 6023.8 6152.3 6164.8 6166.0 6166.5 6171.1 5588.7 5635.2 5878.1 5882.8 5891.4 5825.1 5849.5 5871.9 5912.7 5953.6 5566.1 5620.7 5628.9 5738.9 5740.7 5642.2 5642.2 5654.9 5756.3 5760.4 5694.0 5739.5 5745.8 5748.2 5754.1 5517.8 5591.6 5745.1 5755.2 5768.7 5587.9 5600.7 5631.5 5648.6 5691.4 05:49:31 INFO - PROCESS | 21394 | 05:49:31 INFO - PROCESS | 21394 | [#1] ext.html Cycles:180 Average:43050.95 Median:35635.24 stddev:60645.50 (170.2%) stddev-sans-first:60731.58 05:49:31 INFO - PROCESS | 21394 | Values: 530.7 567.7 605.9 627.9 636.9 32437.8 44220.8 45031.0 45115.5 49357.8 45615.3 46300.8 46303.5 46363.3 46367.5 7890.4 9067.4 9257.4 9264.8 9266.0 7917.7 10672.4 10869.9 10921.7 11036.9 11000.6 11088.8 11115.7 11117.2 11118.2 10944.8 10957.0 11008.8 11020.7 11034.5 10781.2 10856.3 10857.1 10857.3 10857.8 43642.3 43889.3 43941.1 44039.3 44047.0 3984.1 4021.7 4024.1 4050.9 4192.6 31849.8 32062.8 32102.2 32138.7 33860.0 4090.5 4239.2 4267.9 4362.4 4424.5 230178.0 231916.0 232103.0 232630.0 232909.0 60517.7 60519.0 60716.4 60740.4 60785.4 64887.4 64890.0 65041.7 65075.0 65202.3 16918.6 17116.8 17148.1 17154.0 17157.1 11826.0 12070.6 12849.6 13195.0 13273.7 17089.1 17236.7 17266.4 17331.6 17415.5 6829.2 7042.4 7051.8 7132.3 7139.8 912.0 915.6 932.9 953.1 962.9 30675.7 32045.0 32441.5 32548.7 32727.8 1102.2 1105.4 1107.0 1137.0 1226.4 16248.3 17006.3 17068.0 17102.9 17319.5 152720.2 152964.0 153338.0 153486.0 153607.0 63326.4 63411.4 63427.0 63473.0 63503.0 1398.4 1434.4 1444.1 1445.1 1451.9 29918.9 30883.5 31301.0 31974.5 32171.5 52136.5 52636.0 52844.7 52902.7 52907.0 290037.0 290675.0 291592.0 293444.0 294231.0 34489.5 36781.0 40739.6 40954.4 41176.2 46779.5 48227.5 48499.8 48774.3 49089.5 39726.0 40636.2 41619.6 42495.0 42924.8 39779.6 40027.4 40527.8 40935.2 41959.0 37422.0 37933.8 38043.6 40369.4 40849.6 29850.4 31984.4 32682.5 33104.8 33238.5 25283.0 25284.7 25930.5 26398.5 26581.3 05:49:31 INFO - PROCESS | 21394 | 05:49:31 INFO - PROCESS | 21394 | [#2] jquery.html Cycles:180 Average:34556.50 Median:3158.98 stddev:103278.99 (3269.4%) stddev-sans-first:103536.93 05:49:31 INFO - PROCESS | 21394 | Values: 434.4 445.3 446.9 452.4 453.0 19274.3 21324.5 21401.0 22052.6 22321.0 20920.6 21410.0 21455.1 21515.9 21674.9 5021.5 5938.3 6157.9 6161.2 6164.5 5950.6 5960.6 6003.2 6012.1 6020.1 5796.8 5993.9 5999.1 6001.6 6052.9 5960.3 5989.4 5994.5 5998.8 6004.2 5353.7 5443.5 5448.8 5476.1 5487.1 24895.5 24924.6 25043.7 25092.0 25309.1 3110.6 3207.4 3229.3 3233.4 3286.1 10717.5 11133.7 11179.8 11342.7 11350.8 1859.9 1885.2 1916.3 1941.2 1946.5 95276.5 95765.5 96622.5 97356.0 98296.5 11924.9 12086.5 12098.9 12564.4 12702.6 17516.6 17518.7 17639.7 17639.7 17650.7 8558.3 8693.8 8909.7 8989.2 9046.8 8160.9 8212.4 8303.7 8463.7 8468.7 5332.5 5346.4 5387.7 5398.8 5551.3 2015.7 2170.3 2237.6 2243.9 2252.1 853.5 886.3 893.7 895.8 901.8 21544.7 21983.0 21996.9 22059.0 22117.1 884.1 889.4 905.4 907.6 911.8 11356.3 11688.4 11892.8 11998.3 12056.1 612433.0 620691.0 622341.0 633696.0 645331.0 105989.0 106070.0 109141.0 110620.0 110994.4 1080.9 1093.1 1098.9 1109.1 1113.0 17927.8 18209.4 18898.3 18927.9 19067.1 44796.3 44829.3 44879.0 45115.3 45222.8 63859.7 64248.7 64274.7 65072.0 66468.0 8563.0 8655.9 8801.7 8842.2 9031.8 12873.9 13297.8 13360.2 13790.7 13891.9 11754.2 11989.6 12193.6 12253.9 12421.7 11700.6 11893.0 11909.6 12024.4 12246.4 10491.2 11644.2 11731.9 12065.9 12431.3 8460.1 8579.7 8648.5 8808.8 9257.7 10502.8 12149.2 12184.5 12201.6 12315.3 05:49:31 INFO - PROCESS | 21394 | 05:49:31 INFO - PROCESS | 21394 | [#3] mootools.html Cycles:180 Average:5640.04 Median:5352.54 stddev:3129.12 (58.5%) stddev-sans-first:3120.56 05:49:31 INFO - PROCESS | 21394 | Values: 1256.9 1402.2 1421.1 1427.1 1432.1 7484.8 8290.2 8597.7 8605.3 8776.7 8563.2 8613.7 8642.9 8653.0 8658.7 1988.4 2059.5 2349.5 2384.8 2387.7 2155.7 2211.8 2217.8 2244.2 2244.4 2277.9 2312.4 2313.8 2316.9 2318.5 2335.7 2344.3 2359.6 2366.0 2368.1 2309.6 2351.5 2360.6 2361.2 2370.8 8681.9 8756.3 8772.4 8778.3 8791.9 5243.9 5366.1 5371.6 5382.4 5390.6 3052.3 3214.5 3353.4 3354.9 3373.8 1322.3 1348.3 1382.5 1400.1 1405.6 11679.2 11786.1 11818.1 11822.2 11824.2 4602.6 4701.3 4709.2 4785.1 4853.7 10014.6 10029.7 10032.8 10033.5 10036.3 5375.1 5405.5 5412.6 5414.3 5422.0 4156.9 4586.0 4963.4 5010.0 5054.7 3959.3 3971.9 4003.7 4069.9 4093.5 1311.3 1318.8 1322.5 1328.4 1344.2 965.3 968.9 970.6 973.3 984.0 5651.2 5724.3 5815.9 5833.2 5948.4 639.5 655.8 663.3 668.8 670.8 3896.9 3918.2 3921.4 3933.1 3986.7 9758.4 10281.8 10298.4 10550.8 10574.7 10308.5 10327.6 10416.2 10442.1 10467.6 7895.0 8115.6 8126.6 8140.3 8143.4 5784.5 5866.3 5887.8 6005.7 6078.6 8981.6 9432.0 9450.3 9456.5 9477.8 9759.8 9772.0 9777.3 9783.6 9785.0 6484.7 6700.8 6703.2 7598.8 7713.8 7389.6 7475.8 8131.4 8247.1 8341.4 7351.8 7401.1 7517.1 7595.3 7657.2 7229.6 7287.5 7338.8 7353.8 7359.1 6637.4 6753.2 6753.4 6758.2 6764.8 5240.1 5265.3 5278.0 5287.4 5534.8 5298.9 5338.9 5407.1 5447.3 5497.0 05:49:31 INFO - PROCESS | 21394 | 05:49:31 INFO - PROCESS | 21394 | [#4] prototype.html Cycles:180 Average:4690.07 Median:5241.14 stddev:1314.64 (25.1%) stddev-sans-first:1278.29 05:49:31 INFO - PROCESS | 21394 | Values: 400.7 401.4 419.4 419.4 425.1 5263.1 5317.6 5321.8 5322.2 5340.5 5121.5 5247.8 5266.6 5269.0 5305.5 4154.6 4181.3 4184.8 4189.8 4192.2 4167.9 4178.5 4185.9 4195.9 4228.3 4060.9 4090.8 4099.5 4127.9 4135.5 4094.2 4119.6 4120.4 4135.8 4135.8 3686.6 3689.8 3694.2 3696.2 3717.5 4907.7 5138.3 5217.3 5241.1 5303.5 4951.2 4956.5 4973.8 4986.8 4989.7 5641.8 5645.2 5649.5 5656.6 5662.5 4186.3 4303.0 4360.9 4368.8 4370.6 5529.5 5621.9 5646.9 5790.7 5826.3 4412.8 4414.8 4417.8 4432.2 4446.1 4280.6 4484.5 4490.5 4501.9 4507.4 4788.6 4827.5 4891.3 4915.9 4932.9 5578.9 5602.6 5609.4 5610.4 5622.0 1478.9 1511.4 1514.2 1516.6 1522.2 1075.5 1091.2 1114.3 1116.6 1128.6 5049.4 5053.6 5055.5 5078.2 5086.9 5415.6 5486.7 5499.6 5502.0 5512.2 4897.7 5053.9 5069.2 5080.4 5104.9 2884.4 2899.5 2909.8 2926.9 2951.2 5680.7 5685.6 5698.7 5705.5 5718.9 5241.1 5583.9 5589.2 5596.9 5607.2 5653.7 5661.3 5684.2 5688.3 5738.0 5365.9 5525.3 5543.9 5555.6 5558.1 5352.5 5479.6 5496.9 5666.7 5694.8 5865.5 5875.2 5881.7 5887.6 5893.2 4183.9 4206.4 4206.5 4207.3 4216.5 5392.5 5644.4 5706.2 5711.8 5729.7 5529.0 5529.4 5536.4 5587.6 5611.6 5269.4 5513.0 5602.1 5607.7 5627.4 5511.3 5555.3 5603.9 5604.7 5611.1 5594.3 5597.7 5601.4 5635.1 5645.6 5123.2 5403.5 5405.2 5451.5 5487.8 05:49:31 INFO - PROCESS | 21394 | 05:49:31 INFO - PROCESS | 21394 | [#5] yui.html Cycles:180 Average:17305.64 Median:40358.90 stddev:21872.52 (54.2%) stddev-sans-first:21898.56 05:49:31 INFO - PROCESS | 21394 | Values: 753.0 787.9 835.9 837.7 870.9 14794.6 15422.8 15534.5 15541.7 15591.9 15043.5 15204.4 15206.2 15208.6 15215.4 740.8 745.3 758.9 769.8 770.5 771.3 772.8 773.5 773.5 773.6 806.8 810.6 810.7 811.7 812.7 805.0 805.1 806.5 806.7 806.8 594.3 594.4 594.5 594.7 594.8 13831.4 13886.8 13900.1 14261.4 15491.6 14247.4 14670.6 14827.3 14849.5 14999.6 11644.7 11809.5 11817.1 11997.9 12203.3 3651.4 3654.1 3676.4 3700.7 3741.7 76990.2 77902.6 78075.6 78119.0 79547.6 11470.3 11497.9 11501.5 11502.9 11812.5 21988.5 22250.6 22538.8 22546.2 22547.9 6912.0 7799.6 8051.5 8116.5 8125.5 4537.1 4589.8 4675.7 4687.7 4712.9 3572.6 3577.9 3630.6 3637.5 3665.9 628.1 634.1 635.7 653.8 658.6 755.8 758.2 776.6 786.3 802.0 10112.9 10512.5 10625.8 10630.5 10640.4 704.7 706.1 711.5 720.1 721.4 4686.9 4932.6 4996.5 5019.7 5033.2 79384.1 81104.0 82159.2 83766.6 84151.2 44038.3 47384.5 53408.2 74301.0 75926.0 61753.7 61994.4 62665.4 63182.4 64713.0 9984.8 10378.6 10524.8 10543.3 10651.8 39432.8 39745.4 40263.0 40454.8 41578.8 46187.8 49816.8 51928.2 52096.0 52551.7 12963.8 13019.3 13118.7 13136.4 13192.3 14953.2 15022.3 15055.7 15145.5 15640.4 13536.7 14017.7 14215.5 15006.5 15090.6 13477.7 13493.9 13613.3 13668.5 13966.4 13889.3 13964.6 14292.0 14313.6 14963.6 11055.1 11111.1 11540.8 11586.2 11805.1 9955.6 10072.6 10636.8 10776.2 10802.7 05:49:31 INFO - PROCESS | 21394 | -------- Summary: end -------- 05:49:31 INFO - PROCESS | 21394 | 05:49:31 INFO - TEST-INFO | 21394: exit 0 05:49:31 INFO - TEST-OK | dromaeo_css | took 1117271ms 05:49:31 INFO - TEST-START | kraken 05:49:31 INFO - operating with platform_type : linux_ 05:49:31 INFO - Initialising browser for kraken test... 05:49:31 INFO - TEST-INFO | started process 21698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpap8Dsj/profile http://localhost:51137/getInfo.html) 05:49:35 INFO - PROCESS | 21698 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:49:35 INFO - PROCESS | 21698 | __metrics Screen width/height:1600/1200 05:49:35 INFO - PROCESS | 21698 | colorDepth:24 05:49:35 INFO - PROCESS | 21698 | Browser inner width/height: 1024/697 05:49:35 INFO - PROCESS | 21698 | __metrics 05:49:36 INFO - PROCESS | 21698 | 1486129776053 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:49:36 INFO - PROCESS | 21698 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:49:36 INFO - PROCESS | 21698 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:49:36 INFO - PROCESS | 21698 | console.error: PushService: 05:49:36 INFO - PROCESS | 21698 | stateChangeProcessEnqueue: Error transitioning state 05:49:36 INFO - PROCESS | 21698 | UnknownError 05:49:37 INFO - TEST-INFO | 21698: exit 0 05:49:37 INFO - Browser initialized. 05:49:37 INFO - Running cycle 1/1 for kraken test... 05:49:37 INFO - TEST-INFO | started process 21782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpap8Dsj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:49 INFO - PROCESS | 21782 | RSS: Main: 148660224 05:49:49 INFO - PROCESS | 21782 | 05:49:52 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51137/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:52 INFO - PROCESS | 21782 | RSS: Main: 204775424 05:49:52 INFO - PROCESS | 21782 | 05:49:55 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51137/tests/kraken/driver.html?testName=audio-dft) 05:49:56 INFO - PROCESS | 21782 | RSS: Main: 183496704 05:49:56 INFO - PROCESS | 21782 | 05:49:58 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51137/tests/kraken/driver.html?testName=audio-fft) 05:49:59 INFO - PROCESS | 21782 | RSS: Main: 265224192 05:49:59 INFO - PROCESS | 21782 | 05:50:01 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51137/tests/kraken/driver.html?testName=audio-oscillator) 05:50:02 INFO - PROCESS | 21782 | RSS: Main: 177143808 05:50:02 INFO - PROCESS | 21782 | 05:50:04 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51137/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:05 INFO - PROCESS | 21782 | RSS: Main: 180580352 05:50:05 INFO - PROCESS | 21782 | 05:50:08 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51137/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:08 INFO - PROCESS | 21782 | RSS: Main: 220459008 05:50:08 INFO - PROCESS | 21782 | 05:50:11 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51137/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:12 INFO - PROCESS | 21782 | RSS: Main: 219787264 05:50:12 INFO - PROCESS | 21782 | 05:50:15 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51137/tests/kraken/driver.html?testName=json-parse-financial) 05:50:15 INFO - PROCESS | 21782 | RSS: Main: 218296320 05:50:15 INFO - PROCESS | 21782 | 05:50:17 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51137/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:18 INFO - PROCESS | 21782 | RSS: Main: 180969472 05:50:18 INFO - PROCESS | 21782 | 05:50:19 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51137/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:20 INFO - PROCESS | 21782 | RSS: Main: 188137472 05:50:20 INFO - PROCESS | 21782 | 05:50:22 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51137/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:23 INFO - PROCESS | 21782 | RSS: Main: 196239360 05:50:23 INFO - PROCESS | 21782 | 05:50:25 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:26 INFO - PROCESS | 21782 | RSS: Main: 200994816 05:50:26 INFO - PROCESS | 21782 | 05:50:29 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:29 INFO - PROCESS | 21782 | RSS: Main: 202149888 05:50:29 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | Cycle 1(1): loaded http://localhost:51137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51137/tests/kraken/driver.html?testName=ai-astar) 05:50:31 INFO - PROCESS | 21782 | RSS: Main: 254263296 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | __start_tp_report 05:50:31 INFO - PROCESS | 21782 | _x_x_mozilla_page_load 05:50:31 INFO - PROCESS | 21782 | _x_x_mozilla_page_load_details 05:50:31 INFO - PROCESS | 21782 | |i|pagename|runs| 05:50:31 INFO - PROCESS | 21782 | |0;ai-astar;103;114;115;117;115;116;113;113;113;113 05:50:31 INFO - PROCESS | 21782 | |1;audio-beat-detection;147;117;119;150;122;118;118;119;138;118 05:50:31 INFO - PROCESS | 21782 | |2;audio-dft;161;161;162;162;162;162;165;161;163;163 05:50:31 INFO - PROCESS | 21782 | |3;audio-fft;75;78;76;108;76;75;75;75;93;76 05:50:31 INFO - PROCESS | 21782 | |4;audio-oscillator;84;82;108;82;83;83;106;83;82;103 05:50:31 INFO - PROCESS | 21782 | |5;imaging-gaussian-blur;118;117;117;116;117;117;116;117;117;116 05:50:31 INFO - PROCESS | 21782 | |6;imaging-darkroom;146;146;147;147;146;146;147;147;146;147 05:50:31 INFO - PROCESS | 21782 | |7;imaging-desaturate;97;96;96;95;95;95;96;96;96;96 05:50:31 INFO - PROCESS | 21782 | |8;json-parse-financial;53;51;52;53;54;53;54;53;54;54 05:50:31 INFO - PROCESS | 21782 | |9;json-stringify-tinderbox;63;66;65;66;65;64;66;65;66;66 05:50:31 INFO - PROCESS | 21782 | |10;stanford-crypto-aes;82;83;90;82;81;89;81;81;80;82 05:50:31 INFO - PROCESS | 21782 | |11;stanford-crypto-ccm;129;136;125;128;122;132;123;124;223;140 05:50:31 INFO - PROCESS | 21782 | |12;stanford-crypto-pbkdf2;169;167;167;171;170;168;169;167;167;169 05:50:31 INFO - PROCESS | 21782 | |13;stanford-crypto-sha256-iterative;66;64;68;62;61;62;61;61;61;61 05:50:31 INFO - PROCESS | 21782 | __end_tp_report 05:50:31 INFO - PROCESS | 21782 | __start_cc_report 05:50:31 INFO - PROCESS | 21782 | _x_x_mozilla_cycle_collect,1716 05:50:31 INFO - PROCESS | 21782 | __end_cc_report 05:50:31 INFO - PROCESS | 21782 | __startTimestamp1486129831866__endTimestamp 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | ------- Summary: start ------- 05:50:31 INFO - PROCESS | 21782 | Number of tests: 14 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.50 stddev:3.85 (3.4%) stddev-sans-first:1.50 05:50:31 INFO - PROCESS | 21782 | Values: 103.0 114.0 115.0 117.0 115.0 116.0 113.0 113.0 113.0 113.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:120.50 stddev:13.10 (10.9%) stddev-sans-first:11.63 05:50:31 INFO - PROCESS | 21782 | Values: 147.0 117.0 119.0 150.0 122.0 118.0 118.0 119.0 138.0 118.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 05:50:31 INFO - PROCESS | 21782 | Values: 161.0 161.0 162.0 162.0 162.0 162.0 165.0 161.0 163.0 163.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.00 stddev:11.06 (14.5%) stddev-sans-first:11.53 05:50:31 INFO - PROCESS | 21782 | Values: 75.0 78.0 76.0 108.0 76.0 75.0 75.0 75.0 93.0 76.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:82.50 stddev:11.17 (13.5%) stddev-sans-first:11.66 05:50:31 INFO - PROCESS | 21782 | Values: 84.0 82.0 108.0 82.0 83.0 83.0 106.0 83.0 82.0 103.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 05:50:31 INFO - PROCESS | 21782 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:50:31 INFO - PROCESS | 21782 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 05:50:31 INFO - PROCESS | 21782 | Values: 97.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.50 stddev:0.99 (1.9%) stddev-sans-first:1.05 05:50:31 INFO - PROCESS | 21782 | Values: 53.0 51.0 52.0 53.0 54.0 53.0 54.0 53.0 54.0 54.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:0.73 05:50:31 INFO - PROCESS | 21782 | Values: 63.0 66.0 65.0 66.0 65.0 64.0 66.0 65.0 66.0 66.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.00 stddev:3.48 (4.2%) stddev-sans-first:3.67 05:50:31 INFO - PROCESS | 21782 | Values: 82.0 83.0 90.0 82.0 81.0 89.0 81.0 81.0 80.0 82.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:130.50 stddev:30.36 (23.3%) stddev-sans-first:32.02 05:50:31 INFO - PROCESS | 21782 | Values: 129.0 136.0 125.0 128.0 122.0 132.0 123.0 124.0 223.0 140.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:169.00 stddev:1.43 (0.8%) stddev-sans-first:1.50 05:50:31 INFO - PROCESS | 21782 | Values: 169.0 167.0 167.0 171.0 170.0 168.0 169.0 167.0 167.0 169.0 05:50:31 INFO - PROCESS | 21782 | 05:50:31 INFO - PROCESS | 21782 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:2.50 (4.0%) stddev-sans-first:2.35 05:50:31 INFO - PROCESS | 21782 | Values: 66.0 64.0 68.0 62.0 61.0 62.0 61.0 61.0 61.0 61.0 05:50:31 INFO - PROCESS | 21782 | -------- Summary: end -------- 05:50:31 INFO - PROCESS | 21782 | 05:50:32 INFO - TEST-INFO | 21782: exit 0 05:50:32 INFO - TEST-OK | kraken | took 61102ms 05:50:32 INFO - SUITE-END | took 1178s 05:50:33 INFO - Completed test suite (00:19:38) 05:50:33 INFO - javascript benchmark 05:50:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7264.4001186394025, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.132338606883, 3174.206448387903, 3211.181148807054, 3212.2290650243917, 3219.565358676578, 5333.413324534303, 5363.865903352418, 5406.243125962368, 5408.783648654054, 5416.485433883785, 5430.456954304577, 5433.918491222635, 5449.618526703122, 5479.589030822684, 5525.11598144296, 4635.652326075541, 4798.352222449977, 4948.678335908173, 4953.653244272902, 5036.370453693288, 4749.26386410107, 4779.569838714515, 4918.483559226283, 4921.7785199666105, 4932.210846264598, 4780.354652121971, 4830.516948305177, 4846.660733748639, 4852.757362131879, 4912.926306105412, 4885.36490256268, 4895.437024742165, 4895.779689913962, 4903.19097348937, 4937.901241975141, 4737.620990320766, 4854.053459575384, 4895.143349913751, 4901.8774530636665, 4950.777215025332, 5304.2839216706025, 5387.542058924996, 5451.754671039773, 5478.0, 5519.779208831642, 5844.298684157886, 5851.824445266649, 5855.0, 5856.32652244993, 5856.853578660568, 5906.055031194988, 5918.0, 5930.584859059867, 5938.435848594377, 5939.227900372924, 5356.330458692663, 5396.19057141428, 5439.401665816757, 5476.726163691799, 5478.58910581708, 5765.135229715493, 5960.0165972614905, 5962.761489540369, 5963.075723262901, 6021.578489505692, 5523.309586301712, 5613.129964855454, 5649.378568357477, 5650.039493286151, 5666.263385759908, 5752.424757524214, 5766.654000759884, 5827.562932780059, 5840.941590584125, 5882.794102206402, 5858.765649373977, 5859.1797148399255, 5859.794907178229, 5861.589688721749, 5866.0, 5512.476314750093, 5555.361133469622, 5750.079987202112, 5769.624974376652, 5830.038043722823, 4508.41390619224, 4509.233430316854, 4513.368128462018, 4546.272596384629, 4553.795079221377, 4007.479027726377, 4012.3981402789814, 4016.0, 4040.878773636796, 4051.1897620476025, 5284.0, 5299.072662284085, 5305.840824775263, 5371.274877891513, 5372.194170874322, 5793.304803423616, 5798.10129429939, 5855.3851845556455, 5856.355800861902, 5862.237909071879, 5326.547243484347, 5364.6512976656395, 5372.650777699437, 5377.247185394048, 5378.7041712705395, 5004.324416203839, 5010.298558201855, 5010.774515146827, 5011.774470148852, 5012.699238045729, 6045.425684559959, 6055.697215139226, 6089.5737298388685, 6101.314587553275, 6122.142899994094, 5966.343702192842, 5977.790777322773, 6012.518998480198, 6014.8195554133445, 6023.759049638141, 6152.323244443018, 6164.7842325518395, 6166.044263139221, 6166.4758495526585, 6171.105189747551, 5588.720563971704, 5635.239242702182, 5878.088896221093, 5882.764689412375, 5891.38140495259, 5825.097109947965, 5849.502792262705, 5871.882562348644, 5912.73392697321, 5953.583249172516, 5566.137248726453, 5620.690862002465, 5628.943710563006, 5738.85222955419, 5740.741666624928, 5642.181883626769, 5642.181883626933, 5654.943450565442, 5756.251687280626, 5760.366359700346, 5693.971530142323, 5739.540836733135, 5745.770169193185, 5748.223989761496, 5754.050581654147, 5517.751701173376, 5591.580631452576, 5745.080787074048, 5755.223044889054, 5768.711564421678, 5587.860303492445, 5600.7199640017025, 5631.49316561495, 5648.604597678123, 5691.402402747652], "value": 5361.8401807730825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.6915098307694, 567.7076305702562, 605.9272887253529, 627.9277883043451, 636.8567072408708, 32437.837810810972, 44220.77889610551, 45031.0, 45115.54884451155, 49357.753211233896, 45615.31577026347, 46300.76849615756, 46303.536964630344, 46363.30455043168, 46367.53632463674, 7890.421915616871, 9067.365284430092, 9257.351985361027, 9264.7683807905, 9266.0, 7917.722879699211, 10672.35965842048, 10869.945650271737, 10921.672349829518, 11036.944815275952, 11000.559977600886, 11088.833667494993, 11115.72210694731, 11117.22179447439, 11118.22172447929, 10944.835827462595, 10957.0, 11008.834867476995, 11020.669379918616, 11034.503447344849, 10781.191410644155, 10856.294340867818, 10857.077148442391, 10857.294275872044, 10857.782844343068, 43642.34536481955, 43889.34165987513, 43941.12117757627, 44039.33940990888, 44047.0, 3984.1035766952496, 4021.718479706422, 4024.1146947671464, 4050.9392359114636, 4192.5807419258135, 31849.8407507961, 32062.839685801657, 32102.197445063826, 32138.678613213804, 33860.0, 4090.509138903321, 4239.194553034913, 4267.869014711073, 4362.411074504965, 4424.491183513905, 230178.0, 231916.0, 232103.0, 232630.0, 232908.9999999983, 60517.69741151354, 60519.0, 60716.39283607196, 60740.39259607436, 60785.392146078855, 64887.35112648908, 64890.0, 65041.67479162574, 65075.0, 65202.34797652058, 16918.577035573962, 17116.828831711773, 17148.05685687299, 17154.0, 17157.142142892804, 11826.0, 12070.577529786415, 12849.550265740654, 13195.0, 13273.734525309439, 17089.145542722814, 17236.741448878278, 17266.395676151275, 17331.566710832078, 17415.47753567395, 6829.214640316328, 7042.366187043191, 7051.753188638373, 7132.322429369202, 7139.75054365484, 911.9635214591342, 915.624593916491, 932.9440233586007, 953.0802775321848, 962.8988956159502, 30675.69324306773, 32045.033019881954, 32441.513377299358, 32548.6550514288, 32727.83636081852, 1102.1953973599318, 1105.3865104866877, 1107.0, 1136.9658910232706, 1226.399064458409, 16248.268827902773, 17006.319747210222, 17068.0, 17102.914485427493, 17319.480415587554, 152720.2363988173, 152964.0, 153338.0, 153486.0, 153607.0, 63326.366736332966, 63411.36588634054, 63427.0, 63473.0, 63503.0, 1398.356755892301, 1434.4333988074861, 1444.1046551138152, 1445.0534899640961, 1451.8548145185607, 29918.850405748704, 30883.536746948364, 31301.0, 31974.536910006584, 32171.51742723814, 52136.47863521316, 52636.0, 52844.65864096333, 52902.73548632232, 52907.0, 290037.0, 290675.0, 291592.0, 293444.0, 294231.0, 34489.48265776066, 36781.0, 40739.55562666249, 40954.38568421416, 41176.1764764709, 46779.53220467888, 48227.51772482371, 48499.75750121227, 48774.268385974945, 49089.50910490992, 39726.0, 40636.1872762549, 41619.58380416157, 42495.0, 42924.78537607292, 39779.60220397875, 40027.3995890056, 40527.79736101301, 40935.18129637331, 41959.0, 37422.0, 37933.81033094817, 38043.61956380401, 40369.39445908373, 40849.59150408458, 29850.402991939605, 31984.36031279315, 32682.50976235406, 33104.83447582747, 33238.50142247917, 25283.0, 25284.747152528238, 25930.481390372464, 26398.472030559664, 26581.33546661349], "value": 19614.297007717323, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.43957295089336, 445.2942086792434, 446.94636643602763, 452.39605127155244, 452.9977350113249, 19274.32539861105, 21324.46688832778, 21401.0, 22052.558948821013, 22321.0, 20920.581588368223, 21410.0, 21455.141794328207, 21515.892420537915, 21674.89162554185, 5021.497850214986, 5938.346781854003, 6157.938420615804, 6161.168242287279, 6164.5376596755195, 5950.5834591578605, 5960.642361458305, 6003.1895694081395, 6012.098185272201, 6020.12708157317, 5796.768129274824, 5993.85015374617, 5999.1301261317085, 6001.60989535681, 6052.878942421149, 5960.284765828107, 5989.43100405463, 5994.490468310199, 5998.790042348519, 6004.219451471325, 5353.652012619206, 5443.455654434564, 5448.8365349039195, 5476.069068258365, 5487.149491828773, 24895.50208995828, 24924.626130608056, 25043.749562504505, 25092.0, 25309.114181003577, 3110.580071690338, 3207.3745619604188, 3229.3218424130728, 3233.417984762742, 3286.145602143436, 10717.53584198197, 11133.72165695856, 11179.83230251547, 11342.71643208918, 11350.829737553944, 1859.944201673952, 1885.2459016393416, 1916.281394477071, 1941.1555973151724, 1946.523101840044, 95276.52361738216, 95765.5211723944, 96622.51688741581, 97356.0264397354, 98296.50851745695, 11924.880751192377, 12086.456109474919, 12098.939505302593, 12564.434600442819, 12702.555410560772, 17516.649667006845, 17518.737218941726, 17639.73540396895, 17639.73540396895, 17650.735238971425, 8558.272546833588, 8693.782655433539, 8909.73270801877, 8989.235914947303, 9046.773830654287, 8160.918390816135, 8212.425130240827, 8303.709370172015, 8463.703770368007, 8468.703595374132, 5332.520073193431, 5346.385165705994, 5387.703676297841, 5398.839249561363, 5551.333839939233, 2015.6674148765583, 2170.3488953313945, 2237.574860776447, 2243.9214627488286, 2252.1441852096427, 853.5007020892723, 886.2776836877924, 893.7140115163215, 895.7715782475557, 901.8241442918699, 21544.676829847565, 21983.0, 21996.89001554982, 22059.0, 22117.115315387204, 884.1335491218641, 889.3596610440472, 905.3707673167218, 907.5689047702289, 911.8176364727082, 11356.261842980344, 11688.357140357191, 11892.821607675893, 11998.340091294887, 12056.095792815573, 612433.0, 620691.0, 622341.0, 633696.0, 645331.0, 105989.0, 106070.0, 109141.0, 110620.0, 110994.44502777435, 1080.90812280957, 1093.1309608860975, 1098.9010989010867, 1109.1293334732197, 1113.0316624536542, 17927.820721792614, 18209.362672306404, 18898.338558150397, 18927.90536047311, 19067.141978610718, 44796.32805507985, 44829.32756008728, 44879.0, 45115.32327015163, 45222.77388613036, 63859.6807015962, 64248.67875660592, 64274.67862660657, 65072.0, 66468.0, 8562.957185214034, 8655.870161947701, 8801.691940782042, 8842.159994800484, 9031.819363612822, 12873.871261287642, 13297.800532992207, 13360.198388096745, 13790.65523361924, 13891.930540347637, 11754.177207595387, 11989.64031079069, 12193.573224937085, 12253.877461225273, 12421.714508494555, 11700.590479333523, 11892.989095926598, 11909.583164589198, 12024.398780061138, 12246.387680616112, 10491.213159013258, 11644.184907056424, 11731.88268117308, 12065.879341206826, 12431.316277604457, 8460.111688272642, 8579.65681372738, 8648.524331161594, 8808.823823523622, 9257.67598134062, 10502.78994420092, 12149.205682693208, 12184.51261949512, 12201.633950981484, 12315.305408377271], "value": 9922.41346812552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.9371531423426, 1402.172718096323, 1421.104704036457, 1427.0866645346975, 1432.1192466633017, 7484.775456736293, 8290.212429819172, 8597.699080532182, 8605.311575074002, 8776.69281575145, 8563.229309362156, 8613.698520551767, 8642.870356944652, 8653.048164701877, 8658.696945606906, 1988.4332965104948, 2059.5366042640435, 2349.5418393413247, 2384.833061685683, 2387.7373488916205, 2155.687425323335, 2211.845170838042, 2217.7782221777857, 2244.2481768607536, 2244.427670943907, 2277.87471689057, 2312.36409987254, 2313.838031337807, 2316.9073237070497, 2318.5015221727326, 2335.74306826249, 2344.2732752846673, 2359.634256690216, 2365.9645105323348, 2368.0764501844296, 2309.56118337517, 2351.5179388225542, 2360.5632957902844, 2361.1853910400882, 2370.751071137523, 8681.913180868174, 8756.343274254456, 8772.42979206356, 8778.29773618109, 8791.868121978176, 5243.9213411798855, 5366.141417373202, 5371.59713021521, 5382.354117505885, 5390.568754499631, 3052.3284877327173, 3214.4696125139326, 3353.446681297583, 3354.932901341984, 3373.7975721456546, 1322.3123975532765, 1348.2651954684623, 1382.453930697379, 1400.138914567544, 1405.6204824697274, 11679.182457227997, 11786.116041296937, 11818.054555635528, 11822.172447928562, 11824.23142495735, 4602.585767280961, 4701.34574561317, 4709.222978208626, 4785.105011468012, 4853.733044682505, 10014.599416023277, 10029.749256268651, 10032.79934401308, 10033.548490317953, 10036.297459177933, 5375.059364611177, 5405.459454054563, 5412.621116521885, 5414.269073675082, 5421.972890135524, 4156.937645935313, 4585.9770701146945, 4963.404391473046, 5010.0, 5054.721990290569, 3959.287328280937, 3971.900702482403, 4003.6596889264156, 4069.9389509156795, 4093.5497095319492, 1311.2984553263957, 1318.756030134428, 1322.5172811923578, 1328.4059129045183, 1344.1867670059669, 965.290511474066, 968.8837339519162, 970.6020531582018, 973.3235401396104, 983.955721992512, 5651.237082993744, 5724.341700704473, 5815.912761308584, 5833.241678581757, 5948.405159484104, 639.5043841023244, 655.8098151536001, 663.2538394306405, 668.812732434919, 670.8121725916751, 3896.8636097736444, 3918.2163567286657, 3921.3725803871816, 3933.095388060762, 3986.740861843971, 9758.414495130315, 10281.845772313422, 10298.382097074049, 10550.841737373792, 10574.682759517227, 10308.536115874804, 10327.586896524204, 10416.218783591261, 10442.060214580724, 10467.633632822815, 7895.0, 8115.553644549488, 8126.55303958288, 8140.267375936194, 8143.429959902868, 5784.537237020944, 5866.325372582037, 5887.793927212527, 6005.699715014319, 6078.6048906820915, 8981.595828187617, 9432.0, 9450.291228157777, 9456.479893605918, 9477.810443790948, 9759.80480390374, 9771.951140244253, 9777.266704997011, 9783.608655653694, 9785.021497850157, 6484.675766211765, 6700.765473208609, 6703.229128650268, 7598.810029749079, 7713.807154821175, 7389.593572353572, 7475.775726727989, 8131.390145738975, 8247.134050924567, 8341.374396920377, 7351.8162045949275, 7401.0748656417945, 7517.135529414188, 7595.3164215220895, 7657.1959944205055, 7229.566226026455, 7287.489875708861, 7338.816529586803, 7353.77938661841, 7359.080114985627, 6637.369449902251, 6753.223379311442, 6753.358430949052, 6758.155230596176, 6764.797056088325, 5240.135377662643, 5265.289185959847, 5277.973610132079, 5287.418383977682, 5534.750936207961, 5298.94701053, 5338.946610534001, 5407.107827208467, 5447.291852059207, 5497.038018346853], "value": 4529.028793196871, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.6854619123988, 401.3938952182204, 419.37303730922275, 419.4337644180357, 425.05001322045223, 5263.131583288758, 5317.601179911503, 5321.787128514865, 5322.175062865253, 5340.465953404662, 5121.513456221663, 5247.819240670847, 5266.552343050846, 5268.998890210857, 5305.469453054692, 4154.563770804068, 4181.268278051344, 4184.832606695743, 4189.79051047448, 4192.182524407742, 4167.854125105622, 4178.540360560336, 4185.874423767292, 4195.895102622429, 4228.302330115543, 4060.9137055837587, 4090.8159132839096, 4099.549049604541, 4127.876163715078, 4135.4623898893105, 4094.1780907496177, 4119.599336225668, 4120.381942708617, 4135.7518548886865, 4135.793210339486, 3686.562240726119, 3689.815509224528, 3694.224212915291, 3696.2053158570766, 3717.4795528626014, 4907.681000734977, 5138.2806407103035, 5217.34783152106, 5241.135212689902, 5303.522682958553, 4951.183054795954, 4956.504349565051, 4973.825916092919, 4986.775595098229, 4989.652793745705, 5641.802536911188, 5645.15322701594, 5649.548036157139, 5656.632318899258, 5662.546996240291, 4186.346393174709, 4302.9569704303185, 4360.869173924787, 4368.7815609219415, 4370.601407549585, 5529.502344788948, 5621.919889640859, 5646.858828529279, 5790.739416726257, 5826.329972053183, 4412.7793610319995, 4414.779261036935, 4417.8232870684815, 4432.202203603318, 4446.110777844444, 4280.5505421930875, 4484.506704262529, 4490.461144662596, 4501.942043619747, 4507.3689683444345, 4788.569028787426, 4827.465580570159, 4891.290762839369, 4915.87710307238, 4932.901341973212, 5578.944210557924, 5602.579806514527, 5609.354924183689, 5610.363129329209, 5621.964139364697, 1478.8982208254704, 1511.3803340630288, 1514.2201766090473, 1516.5526169779941, 1522.1552038618672, 1075.4568942683895, 1091.1598069486452, 1114.2979922648842, 1116.625930313354, 1128.5937062657438, 5049.444561098277, 5053.646244762831, 5055.51972562606, 5078.21287700407, 5086.880886205029, 5415.593830462731, 5486.670799752028, 5499.642523235977, 5502.0371434998715, 5512.200730894078, 4897.706137631753, 5053.9494605054215, 5069.239614057847, 5080.399674102646, 5104.897902042013, 2884.365439603284, 2899.4635992341487, 2909.839958802244, 2926.9121926342245, 2951.232679503302, 5680.693440508623, 5685.630434021776, 5698.6580805151, 5705.5150312223095, 5718.914216286759, 5241.13521268994, 5583.860403489864, 5589.245451864028, 5596.944030559724, 5607.186957891083, 5653.745581448845, 5661.348944871393, 5684.232628595087, 5688.274180411837, 5738.0, 5365.9463405367005, 5525.281713377235, 5543.861403464945, 5555.583331250254, 5558.138488534284, 5352.511082346728, 5479.561635069105, 5496.890062198813, 5666.688332141772, 5694.772209111755, 5865.501432378295, 5875.206847075761, 5881.705914704333, 5887.646741195542, 5893.233879595797, 4183.895402614959, 4206.432131662309, 4206.453161089161, 4207.347861081537, 4216.494020717533, 5392.5416339611575, 5644.379118297066, 5706.2011318414625, 5711.8000869969355, 5729.742161602655, 5528.9723551381985, 5529.4470552944385, 5536.397892990288, 5587.5809314302405, 5611.607187496836, 5269.4443195051135, 5513.0, 5602.13166959122, 5607.691576963306, 5627.380988091225, 5511.283533140666, 5555.2778138841695, 5603.859903502445, 5604.719764011865, 5611.092228642281, 5594.300712410949, 5597.684544132044, 5601.4315991522435, 5635.098384258499, 5645.633033852787, 5123.23151527259, 5403.486668766461, 5405.162199859028, 5451.48210919962, 5487.807926722546], "value": 4301.649641726173, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.9698812047515, 787.9133295337512, 835.8579041562933, 837.6733074101105, 870.9433886797358, 14794.630134246649, 15422.768658470104, 15534.456294029711, 15541.689166216684, 15591.922040389796, 15043.548693539211, 15204.391824327042, 15206.23968801561, 15208.619784505392, 15215.39138434464, 740.8259059121102, 745.3105877063695, 758.93928485721, 769.7960040589248, 770.4606775257314, 771.3096778383343, 772.7913463364888, 773.4585789947031, 773.4740376543948, 773.5899973014311, 806.8305655812286, 810.5541951926417, 810.7081450677781, 811.6875003123811, 812.7033632724073, 805.0138580239219, 805.1304591041661, 806.4999700185864, 806.6652339279192, 806.8023334283109, 594.2660813894836, 594.4234092929851, 594.46201187925, 594.7115648910275, 594.8304733151031, 13831.377588008563, 13886.791698124536, 13900.096493727875, 14261.358238879275, 15491.612709682235, 14247.430102795875, 14670.559883203521, 14827.332770025374, 14849.480268190562, 14999.550013499504, 11644.650660480114, 11809.527618895234, 11817.054635629129, 11997.94001029998, 12203.267803931793, 3651.415773476231, 3654.068212605795, 3676.356637588438, 3700.6854417374557, 3741.663250307485, 76990.23009769886, 77902.61048694777, 78075.60962195153, 78119.0, 79547.6022619889, 11470.254433461798, 11497.942510287396, 11501.482433290523, 11502.88497115018, 11812.52749890012, 21988.450288742908, 22250.55498890013, 22538.774612253994, 22546.210882619358, 22547.88726056392, 6912.0, 7799.610019499002, 8051.51690898548, 8116.513009219466, 8125.471844330218, 4537.09258148365, 4589.773959629643, 4675.6727029108315, 4687.695299805502, 4712.929306060412, 3572.6070132285427, 3577.8747743829363, 3630.6006339302658, 3637.5089362935664, 3665.9266814663556, 628.1425853709653, 634.1312402009185, 635.6821589205397, 653.8267359149829, 658.6037600287326, 755.8186035351476, 758.1584441270186, 776.6349815586665, 786.3080489169608, 801.9679212831421, 10112.898871011195, 10512.474376281156, 10625.840612390666, 10630.46847657614, 10640.414777187329, 704.6688056613383, 706.1032488739272, 711.4664001998501, 720.1070672366228, 721.3904250907974, 4686.929696054562, 4932.55606995365, 4996.500349964975, 5019.723915184627, 5033.194688849767, 79384.1385688227, 81104.0, 82159.17840821635, 83766.58116709377, 84151.15848841556, 44038.33942490865, 47384.5261547387, 53408.1988770161, 74301.0, 75926.0, 61753.691231543555, 61994.38005619886, 62665.37334626687, 63182.36817631857, 64713.0, 9984.750381240527, 10378.636747713794, 10524.789504210026, 10543.26197166191, 10651.840222396826, 39432.769860785884, 39745.40381894216, 40263.0, 40454.79772601118, 41578.792106040484, 46187.76906115582, 49816.75091624519, 51928.22107668313, 52096.03147400199, 52551.737241313545, 12963.805542916674, 13019.283939383426, 13118.737625247633, 13136.408861601441, 13192.274424906722, 14953.177575233467, 15022.323995420014, 15055.698886022437, 15145.469908553148, 15640.374385024472, 13536.729265414833, 14017.719645607234, 14215.50245741394, 15006.549803505912, 15090.622734431727, 13477.730445391233, 13493.865061349261, 13613.251271180181, 13668.52160174389, 13966.371513281723, 13889.305534723426, 13964.581062568139, 14292.0, 14313.642158945693, 14963.625909352353, 11055.065363561505, 11111.111111111253, 11540.826887596524, 11586.188966772244, 11805.114616403976, 9955.601775928882, 10072.597096116073, 10636.84044739345, 10776.191785616267, 10802.72993175177], "value": 7227.85384107513, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 115.0, 117.0, 115.0, 116.0, 113.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 119.0, 150.0, 122.0, 118.0, 118.0, 119.0, 138.0, 118.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 165.0, 161.0, 163.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 108.0, 76.0, 75.0, 75.0, 75.0, 93.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 108.0, 82.0, 83.0, 83.0, 106.0, 83.0, 82.0, 103.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 53.0, 54.0, 53.0, 54.0, 53.0, 54.0, 54.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 66.0, 65.0, 64.0, 66.0, 65.0, 66.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 90.0, 82.0, 81.0, 89.0, 81.0, 81.0, 80.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 136.0, 125.0, 128.0, 122.0, 132.0, 123.0, 124.0, 223.0, 140.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 167.0, 171.0, 170.0, 168.0, 169.0, 167.0, 167.0, 169.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 68.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 62.7, "unit": "score"}]}]} 05:50:33 INFO - Return code: 0 05:50:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:50:33 ERROR - # TBPL SUCCESS # 05:50:33 INFO - Running post-action listener: _resource_record_post_action 05:50:33 INFO - [mozharness: 2017-02-03 13:50:33.158283Z] Finished run-tests step (success) 05:50:33 INFO - Running post-run listener: _resource_record_post_run 05:50:33 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 409600000; Read time: 212; Write time: 288244 05:50:33 INFO - TinderboxPrint: CPU usage
13.1% 05:50:33 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 212 05:50:33 INFO - TinderboxPrint: I/O write bytes / time
409,600,000 / 288,244 05:50:33 INFO - TinderboxPrint: CPU idle
8,297.2 (86.9%) 05:50:33 INFO - TinderboxPrint: CPU user
1,203.0 (12.6%) 05:50:33 INFO - TinderboxPrint: Swap in / out
0 / 0 05:50:33 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 114315264; Read time: 0; Write time: 97088 05:50:33 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 12288; Write bytes: 295284736; Read time: 212; Write time: 191156 05:50:33 INFO - Running post-run listener: _upload_blobber_files 05:50:33 INFO - Blob upload gear active. 05:50:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:50:33 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 05:50:33 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'] 05:50:33 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 05:50:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:50:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:50:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:50:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:34 INFO - (blobuploader) - INFO - Done attempting. 05:50:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:50:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:50:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:35 INFO - (blobuploader) - INFO - Done attempting. 05:50:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:50:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:50:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:39 INFO - (blobuploader) - INFO - Done attempting. 05:50:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:50:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:50:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:40 INFO - (blobuploader) - INFO - Done attempting. 05:50:40 INFO - (blobuploader) - INFO - Iteration through files over. 05:50:40 INFO - Return code: 0 05:50:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:50:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:50:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db4fdb8e76274ca727faf98d3f64b2620a0f4ce7be228db7a249b68dae2f4e02c43b8e4036659b8ad7b43f6e75e80c922b17c46710c183ad765555d72b7a4174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e83f3ca920314938d2615094fb2e124ee042b2d0ef52899ed610125e403aad7ffdf43071751801bcce1833365494964b0725ba6d1e3fa78d3c5c1364e37f6de9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd99bdf684775ae232934160bd942f9414b907f7e019753bcfa6aa79d96537451d1411b9cf9b5bf0a964a86a0a0f3857e50b287ed49dc36688bc639220082a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84f7313f5cede993dad1587918d8f99a58f40e2307b962178f1fc38387c42605520836acb271bccbdaa06993ee6fe472ef7bc2347d851fdc597ae3d1c84d3800"} 05:50:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:50:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:50:40 INFO - Contents: 05:50:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db4fdb8e76274ca727faf98d3f64b2620a0f4ce7be228db7a249b68dae2f4e02c43b8e4036659b8ad7b43f6e75e80c922b17c46710c183ad765555d72b7a4174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e83f3ca920314938d2615094fb2e124ee042b2d0ef52899ed610125e403aad7ffdf43071751801bcce1833365494964b0725ba6d1e3fa78d3c5c1364e37f6de9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd99bdf684775ae232934160bd942f9414b907f7e019753bcfa6aa79d96537451d1411b9cf9b5bf0a964a86a0a0f3857e50b287ed49dc36688bc639220082a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84f7313f5cede993dad1587918d8f99a58f40e2307b962178f1fc38387c42605520836acb271bccbdaa06993ee6fe472ef7bc2347d851fdc597ae3d1c84d3800"} 05:50:40 INFO - Running post-run listener: copy_logs_to_upload_dir 05:50:40 INFO - Copying logs to upload dir... 05:50:40 INFO - mkdir: /builds/slave/test/build/upload/logs 05:50:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.057757 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-02-03 05:50:40.420385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 05:50:40.424068) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761 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/db4fdb8e76274ca727faf98d3f64b2620a0f4ce7be228db7a249b68dae2f4e02c43b8e4036659b8ad7b43f6e75e80c922b17c46710c183ad765555d72b7a4174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e83f3ca920314938d2615094fb2e124ee042b2d0ef52899ed610125e403aad7ffdf43071751801bcce1833365494964b0725ba6d1e3fa78d3c5c1364e37f6de9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd99bdf684775ae232934160bd942f9414b907f7e019753bcfa6aa79d96537451d1411b9cf9b5bf0a964a86a0a0f3857e50b287ed49dc36688bc639220082a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84f7313f5cede993dad1587918d8f99a58f40e2307b962178f1fc38387c42605520836acb271bccbdaa06993ee6fe472ef7bc2347d851fdc597ae3d1c84d3800"} build_url:https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/RP9BjumASLuaDHUNzlFvlQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db4fdb8e76274ca727faf98d3f64b2620a0f4ce7be228db7a249b68dae2f4e02c43b8e4036659b8ad7b43f6e75e80c922b17c46710c183ad765555d72b7a4174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e83f3ca920314938d2615094fb2e124ee042b2d0ef52899ed610125e403aad7ffdf43071751801bcce1833365494964b0725ba6d1e3fa78d3c5c1364e37f6de9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd99bdf684775ae232934160bd942f9414b907f7e019753bcfa6aa79d96537451d1411b9cf9b5bf0a964a86a0a0f3857e50b287ed49dc36688bc639220082a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84f7313f5cede993dad1587918d8f99a58f40e2307b962178f1fc38387c42605520836acb271bccbdaa06993ee6fe472ef7bc2347d851fdc597ae3d1c84d3800"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 05:50:40.448951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:50:40.449265) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1486128595.448917-389934761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:50:40.533457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 05:50:40.533901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 05:50:40.534315) ========= ========= Total master_lag: 0.15 =========