builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1490615045.49 results: success (0) revision: 0583275688f1f5e8e6d6c6842514c7ec183f5381 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:05.489405) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:05.489940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:05.490327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:05.505944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:05.506412) ========= 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=ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-27 04:44:06-- 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% 86.6M=0s 2017-03-27 04:44:07 (86.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.372777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:05.893509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:05.893822) ========= 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=ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016130 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:05.954604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 04:44:05.954942) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0583275688f1f5e8e6d6c6842514c7ec183f5381 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0583275688f1f5e8e6d6c6842514c7ec183f5381 --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=ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-27 04:44:07,250 truncating revision to first 12 chars 2017-03-27 04:44:07,250 Setting DEBUG logging. 2017-03-27 04:44:07,250 attempt 1/10 2017-03-27 04:44:07,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0583275688f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 04:44:08,266 unpacking tar archive at: mozilla-aurora-0583275688f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 04:44:07.292948) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:07.293280) ========= script_repo_revision: 0583275688f1f5e8e6d6c6842514c7ec183f5381 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:07.293661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:07.293922) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 04:44:07.303783) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-27 04:44:07.304166) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:44:08 INFO - MultiFileLogger online at 20170327 04:44:08 in /builds/slave/test 04:44:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:44:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:44:08 INFO - {'append_to_log': False, 04:44:08 INFO - 'base_work_dir': '/builds/slave/test', 04:44:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:44:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:44:08 INFO - 'branch': 'Mozilla-Aurora', 04:44:08 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:08 INFO - 'config_files': ('talos/linux_config.py',), 04:44:08 INFO - 'default_actions': ('clobber', 04:44:08 INFO - 'read-buildbot-config', 04:44:08 INFO - 'download-and-extract', 04:44:08 INFO - 'populate-webroot', 04:44:08 INFO - 'create-virtualenv', 04:44:08 INFO - 'install', 04:44:08 INFO - 'run-tests'), 04:44:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:08 INFO - 'download_minidump_stackwalk': True, 04:44:08 INFO - 'download_symbols': 'ondemand', 04:44:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:08 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:08 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:08 INFO - 'gecko_profile': False, 04:44:08 INFO - 'gecko_profile_interval': 0, 04:44:08 INFO - 'installer_path': 'installer.exe', 04:44:08 INFO - 'log_level': 'info', 04:44:08 INFO - 'log_name': 'talos', 04:44:08 INFO - 'log_to_console': True, 04:44:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:44:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:44:08 INFO - 'opt_config_files': (), 04:44:08 INFO - 'pip_index': False, 04:44:08 INFO - 'suite': 'dromaeojs', 04:44:08 INFO - 'system_bits': '32', 04:44:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:08 INFO - 'title': 'talos-linux64-ix-029', 04:44:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:08 INFO - 'use_talos_json': True, 04:44:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:44:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:08 INFO - 'work_dir': 'build'} 04:44:08 INFO - [mozharness: 2017-03-27 11:44:08.696342Z] Running clobber step. 04:44:08 INFO - Running pre-action listener: _resource_record_pre_action 04:44:08 INFO - Running main action method: clobber 04:44:08 INFO - rmtree: /builds/slave/test/build 04:44:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:44:09 INFO - Running post-action listener: _resource_record_post_action 04:44:09 INFO - [mozharness: 2017-03-27 11:44:09.655181Z] Finished clobber step (success) 04:44:09 INFO - [mozharness: 2017-03-27 11:44:09.655281Z] Running read-buildbot-config step. 04:44:09 INFO - Running pre-action listener: _resource_record_pre_action 04:44:09 INFO - Running main action method: read_buildbot_config 04:44:09 INFO - Using buildbot properties: 04:44:09 INFO - { 04:44:09 INFO - "project": "", 04:44:09 INFO - "product": "firefox", 04:44:09 INFO - "who": "cbook@mozilla.com", 04:44:09 INFO - "installer_path": "public/build/target.tar.bz2", 04:44:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:44:09 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 04:44:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:44:09 INFO - "stage_platform": "linux64-pgo", 04:44:09 INFO - "basedir": "/builds/slave/test", 04:44:09 INFO - "buildnumber": 1118, 04:44:09 INFO - "platform": "ubuntu64_hw", 04:44:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:44:09 INFO - "slavebuilddir": "test", 04:44:09 INFO - "taskId": "f3S-senMR4W4ugcnHih3rg", 04:44:09 INFO - "branch": "mozilla-aurora", 04:44:09 INFO - "script_repo_revision": "production", 04:44:09 INFO - "revision": "0583275688f1f5e8e6d6c6842514c7ec183f5381", 04:44:09 INFO - "slavename": "talos-linux64-ix-029", 04:44:09 INFO - "repo_path": "releases/mozilla-aurora" 04:44:09 INFO - } 04:44:09 INFO - Finding installer, test and symbols from parent task. 04:44:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f3S-senMR4W4ugcnHih3rg'}, attempt #1 04:44:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f3S-senMR4W4ugcnHih3rg'}, attempt #1 04:44:10 INFO - Task dependencies: SFUy3Jd2TcWvRvXeXyQOvw 04:44:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw'}, attempt #1 04:44:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.tar.bz2 04:44:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/test_packages.json 04:44:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.crashreporter-symbols.zip 04:44:11 INFO - Running post-action listener: _resource_record_post_action 04:44:11 INFO - [mozharness: 2017-03-27 11:44:11.193778Z] Finished read-buildbot-config step (success) 04:44:11 INFO - [mozharness: 2017-03-27 11:44:11.193996Z] Running download-and-extract step. 04:44:11 INFO - Running pre-action listener: _resource_record_pre_action 04:44:11 INFO - Running main action method: download_and_extract 04:44:11 INFO - mkdir: /builds/slave/test/build/tests 04:44:11 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')]} 04:44:11 INFO - trying https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.test_packages.json 04:44:11 INFO - Downloading https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:44:12 INFO - Downloaded 896 bytes. 04:44:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:44:12 INFO - Using the following test package requirements: 04:44:12 INFO - {u'common': [u'target.common.tests.zip'], 04:44:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:44:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:44:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:44:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:44:12 INFO - u'mozbase': [u'target.common.tests.zip'], 04:44:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:44:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:44:12 INFO - u'web-platform': [u'target.common.tests.zip', 04:44:12 INFO - u'target.web-platform.tests.zip'], 04:44:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:44:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:44:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.common.tests.zip 04:44:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:44:12 INFO - Fetch https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.common.tests.zip into memory 04:44:13 INFO - Expected file size: 59537428 04:44:13 INFO - Obtained file size: 59537428 04:44:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:44:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.common.tests.zip 04:44:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:44:23 INFO - Fetch https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.common.tests.zip into memory 04:44:24 INFO - Expected file size: 59537428 04:44:24 INFO - Obtained file size: 59537428 04:44:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.talos.tests.zip 04:44:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:44:35 INFO - Fetch https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.talos.tests.zip into memory 04:44:36 INFO - Expected file size: 14404438 04:44:36 INFO - Obtained file size: 14404438 04:44: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')]} 04:44:36 INFO - trying https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.tar.bz2 04:44:36 INFO - Downloading https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:44:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:44:37 INFO - Downloaded 66671936 bytes. 04:44:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.tar.bz2 04:44:37 INFO - mkdir: /builds/slave/test/properties 04:44:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:37 INFO - Contents: 04:44:37 INFO - build_url:https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.tar.bz2 04:44:37 INFO - Running post-action listener: _resource_record_post_action 04:44:37 INFO - Running post-action listener: set_extra_try_arguments 04:44:37 INFO - [mozharness: 2017-03-27 11:44:37.514560Z] Finished download-and-extract step (success) 04:44:37 INFO - [mozharness: 2017-03-27 11:44:37.514657Z] Running populate-webroot step. 04:44:37 INFO - Running pre-action listener: _resource_record_pre_action 04:44:37 INFO - Running main action method: populate_webroot 04:44:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:37 INFO - '--tppagecycles', 04:44:37 INFO - '7'], 04:44:37 INFO - 'tests': ['tsvgm']}}, 04:44:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:44:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:44:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:44:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['damp', 'tps']}, 04:44:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'tests': ['damp', 'tps']}, 04:44:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['dromaeo_dom']}, 04:44:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['basic_compositor_video']}, 04:44:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:44:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['tsvgx', 04:44:37 INFO - 'tsvgr_opacity', 04:44:37 INFO - 'tart', 04:44:37 INFO - 'tscrollx', 04:44:37 INFO - 'cart', 04:44:37 INFO - 'tsvg_static']}, 04:44:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:44:37 INFO - 'tsvgr_opacity', 04:44:37 INFO - 'tart', 04:44:37 INFO - 'tscrollx', 04:44:37 INFO - 'cart', 04:44:37 INFO - 'tsvg_static']}, 04:44:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['tp5o']}, 04:44:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:44:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'talos_options': ['--disable-e10s', 04:44:37 INFO - '--xperf_path', 04:44:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:37 INFO - 'tests': ['tp5n']}, 04:44:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'talos_options': ['--xperf_path', 04:44:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:37 INFO - 'tests': ['tp5n']}}, 04:44:37 INFO - 'talos.zip': {'path': '', 04:44:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:37 INFO - Running post-action listener: _resource_record_post_action 04:44:37 INFO - [mozharness: 2017-03-27 11:44:37.527760Z] Finished populate-webroot step (success) 04:44:37 INFO - [mozharness: 2017-03-27 11:44:37.527851Z] Running create-virtualenv step. 04:44:37 INFO - Running pre-action listener: _resource_record_pre_action 04:44:37 INFO - Running main action method: create_virtualenv 04:44:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44:37 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 04:44:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:37 INFO - Using real prefix '/usr' 04:44:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:44:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:40 INFO - Installing pip.................done. 04:44:40 INFO - Return code: 0 04:44:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:44:40 INFO - Reading from file tmpfile_stdout 04:44:40 INFO - Output received: 04:44:40 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) 04:44:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:40 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 0x27f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, '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': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', '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 04:44:40 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 04:44:40 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 04:44:40 INFO - Using env: {'DISPLAY': ':0', 04:44:40 INFO - 'HOME': '/home/cltbld', 04:44:40 INFO - 'LANG': 'en_US.UTF-8', 04:44:40 INFO - 'LANGUAGE': 'en_US:en', 04:44:40 INFO - 'LOGNAME': 'cltbld', 04:44:40 INFO - 'MAIL': '/var/mail/cltbld', 04:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:40 INFO - 'MOZ_NO_REMOTE': '1', 04:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:40 INFO - 'NO_EM_RESTART': '1', 04:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:40 INFO - 'PWD': '/builds/slave/test', 04:44:40 INFO - 'SHELL': '/bin/bash', 04:44:40 INFO - 'SHLVL': '1', 04:44:40 INFO - 'TERM': 'linux', 04:44:40 INFO - 'TMOUT': '86400', 04:44:40 INFO - 'USER': 'cltbld', 04:44:40 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:40 INFO - '_': '/tools/buildbot/bin/python'} 04:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:40 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 04:44:40 INFO - Cleaning up... 04:44:40 INFO - Return code: 0 04:44:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:40 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 0x27f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, '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': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', '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 04:44:40 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 04:44:40 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 04:44:40 INFO - Using env: {'DISPLAY': ':0', 04:44:40 INFO - 'HOME': '/home/cltbld', 04:44:40 INFO - 'LANG': 'en_US.UTF-8', 04:44:40 INFO - 'LANGUAGE': 'en_US:en', 04:44:40 INFO - 'LOGNAME': 'cltbld', 04:44:40 INFO - 'MAIL': '/var/mail/cltbld', 04:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:40 INFO - 'MOZ_NO_REMOTE': '1', 04:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:40 INFO - 'NO_EM_RESTART': '1', 04:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:40 INFO - 'PWD': '/builds/slave/test', 04:44:40 INFO - 'SHELL': '/bin/bash', 04:44:40 INFO - 'SHLVL': '1', 04:44:40 INFO - 'TERM': 'linux', 04:44:40 INFO - 'TMOUT': '86400', 04:44:40 INFO - 'USER': 'cltbld', 04:44:40 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:40 INFO - '_': '/tools/buildbot/bin/python'} 04:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:40 INFO - Downloading/unpacking psutil>=3.1.1 04:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:44:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:42 INFO - Installing collected packages: psutil 04:44:42 INFO - Running setup.py install for psutil 04:44:42 INFO - building 'psutil._psutil_linux' extension 04:44:42 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 04:44:43 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 04:44:43 INFO - building 'psutil._psutil_posix' extension 04:44:43 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 04:44:43 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 04:44:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:43 INFO - Successfully installed psutil 04:44:43 INFO - Cleaning up... 04:44:43 INFO - Return code: 0 04:44:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, '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': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', '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 04:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:44:43 INFO - Using env: {'DISPLAY': ':0', 04:44:43 INFO - 'HOME': '/home/cltbld', 04:44:43 INFO - 'LANG': 'en_US.UTF-8', 04:44:43 INFO - 'LANGUAGE': 'en_US:en', 04:44:43 INFO - 'LOGNAME': 'cltbld', 04:44:43 INFO - 'MAIL': '/var/mail/cltbld', 04:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:43 INFO - 'MOZ_NO_REMOTE': '1', 04:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:43 INFO - 'NO_EM_RESTART': '1', 04:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:43 INFO - 'PWD': '/builds/slave/test', 04:44:43 INFO - 'SHELL': '/bin/bash', 04:44:43 INFO - 'SHLVL': '1', 04:44:43 INFO - 'TERM': 'linux', 04:44:43 INFO - 'TMOUT': '86400', 04:44:43 INFO - 'USER': 'cltbld', 04:44:43 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:43 INFO - '_': '/tools/buildbot/bin/python'} 04:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:44:43 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 04:44:43 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 04:44:43 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 04:44:43 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 04:44:43 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 04:44:43 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 04:44:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:44:45 INFO - Installing collected packages: mozsystemmonitor 04:44:45 INFO - Running setup.py install for mozsystemmonitor 04:44:45 INFO - Successfully installed mozsystemmonitor 04:44:45 INFO - Cleaning up... 04:44:45 INFO - Return code: 0 04:44:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:44:45 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')]} 04:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:45 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')]} 04:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:45 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 0x27f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, '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': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', '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 04:44:45 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 04:44:45 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 04:44:45 INFO - Using env: {'DISPLAY': ':0', 04:44:45 INFO - 'HOME': '/home/cltbld', 04:44:45 INFO - 'LANG': 'en_US.UTF-8', 04:44:45 INFO - 'LANGUAGE': 'en_US:en', 04:44:45 INFO - 'LOGNAME': 'cltbld', 04:44:45 INFO - 'MAIL': '/var/mail/cltbld', 04:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:45 INFO - 'MOZ_NO_REMOTE': '1', 04:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:45 INFO - 'NO_EM_RESTART': '1', 04:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:45 INFO - 'PWD': '/builds/slave/test', 04:44:45 INFO - 'SHELL': '/bin/bash', 04:44:45 INFO - 'SHLVL': '1', 04:44:45 INFO - 'TERM': 'linux', 04:44:45 INFO - 'TMOUT': '86400', 04:44:45 INFO - 'USER': 'cltbld', 04:44:45 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:45 INFO - '_': '/tools/buildbot/bin/python'} 04:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:46 INFO - Downloading/unpacking jsonschema==2.5.1 04:44:46 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 04:44:46 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 04:44:46 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 04:44:46 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 04:44:46 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 04:44:46 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 04:44:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:44:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:44:48 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 04:44:48 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 04:44:48 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 04:44:48 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 04:44:48 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 04:44:48 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 04:44:48 INFO - Downloading functools32-3.2.3-2.tar.gz 04:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:44:48 INFO - warning: no files found matching '*.txt' 04:44:48 INFO - no previously-included directories found matching 'build' 04:44:48 INFO - no previously-included directories found matching 'dist' 04:44:48 INFO - no previously-included directories found matching '.git*' 04:44:48 INFO - Installing collected packages: jsonschema, functools32 04:44:48 INFO - Running setup.py install for functools32 04:44:48 INFO - warning: no files found matching '*.txt' 04:44:48 INFO - no previously-included directories found matching 'build' 04:44:48 INFO - no previously-included directories found matching 'dist' 04:44:48 INFO - no previously-included directories found matching '.git*' 04:44:48 INFO - Successfully installed jsonschema functools32 04:44:48 INFO - Cleaning up... 04:44:48 INFO - Return code: 0 04:44:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:44:48 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')]} 04:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:48 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')]} 04:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:48 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 0x27f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, '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': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', '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 04:44:48 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 04:44:48 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 04:44:48 INFO - Using env: {'DISPLAY': ':0', 04:44:48 INFO - 'HOME': '/home/cltbld', 04:44:48 INFO - 'LANG': 'en_US.UTF-8', 04:44:48 INFO - 'LANGUAGE': 'en_US:en', 04:44:48 INFO - 'LOGNAME': 'cltbld', 04:44:48 INFO - 'MAIL': '/var/mail/cltbld', 04:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:48 INFO - 'MOZ_NO_REMOTE': '1', 04:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:48 INFO - 'NO_EM_RESTART': '1', 04:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:48 INFO - 'PWD': '/builds/slave/test', 04:44:48 INFO - 'SHELL': '/bin/bash', 04:44:48 INFO - 'SHLVL': '1', 04:44:48 INFO - 'TERM': 'linux', 04:44:48 INFO - 'TMOUT': '86400', 04:44:48 INFO - 'USER': 'cltbld', 04:44:48 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:48 INFO - '_': '/tools/buildbot/bin/python'} 04:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:44:48 INFO - Cleaning up... 04:44:48 INFO - Return code: 0 04:44:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44:48 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')]} 04:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:48 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')]} 04:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:48 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 0x27f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, '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': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', '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 04:44:48 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 04:44:48 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 04:44:48 INFO - Using env: {'DISPLAY': ':0', 04:44:48 INFO - 'HOME': '/home/cltbld', 04:44:48 INFO - 'LANG': 'en_US.UTF-8', 04:44:48 INFO - 'LANGUAGE': 'en_US:en', 04:44:48 INFO - 'LOGNAME': 'cltbld', 04:44:48 INFO - 'MAIL': '/var/mail/cltbld', 04:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:48 INFO - 'MOZ_NO_REMOTE': '1', 04:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:48 INFO - 'NO_EM_RESTART': '1', 04:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:48 INFO - 'PWD': '/builds/slave/test', 04:44:48 INFO - 'SHELL': '/bin/bash', 04:44:48 INFO - 'SHLVL': '1', 04:44:48 INFO - 'TERM': 'linux', 04:44:48 INFO - 'TMOUT': '86400', 04:44:48 INFO - 'USER': 'cltbld', 04:44:48 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:48 INFO - '_': '/tools/buildbot/bin/python'} 04:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:44:49 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 04:44:49 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 04:44:49 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 04:44:49 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 04:44:49 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 04:44:49 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 04:44:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44:51 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 04:44:51 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 04:44:51 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 04:44:51 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 04:44:51 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 04:44:51 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 04:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44:51 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 04:44:51 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 04:44:51 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 04:44:51 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 04:44:51 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 04:44:51 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 04:44:51 INFO - Downloading docopt-0.6.1.tar.gz 04:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:51 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:51 INFO - Running setup.py install for blobuploader 04:44:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:51 INFO - Running setup.py install for requests 04:44:52 INFO - Running setup.py install for docopt 04:44:52 INFO - Successfully installed blobuploader requests docopt 04:44:52 INFO - Cleaning up... 04:44:52 INFO - Return code: 0 04:44:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:52 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 0x27f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, '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': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', '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 04:44:52 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 04:44:52 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 04:44:52 INFO - Using env: {'DISPLAY': ':0', 04:44:52 INFO - 'HOME': '/home/cltbld', 04:44:52 INFO - 'LANG': 'en_US.UTF-8', 04:44:52 INFO - 'LANGUAGE': 'en_US:en', 04:44:52 INFO - 'LOGNAME': 'cltbld', 04:44:52 INFO - 'MAIL': '/var/mail/cltbld', 04:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:52 INFO - 'MOZ_NO_REMOTE': '1', 04:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:52 INFO - 'NO_EM_RESTART': '1', 04:44:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:52 INFO - 'PWD': '/builds/slave/test', 04:44:52 INFO - 'SHELL': '/bin/bash', 04:44:52 INFO - 'SHLVL': '1', 04:44:52 INFO - 'TERM': 'linux', 04:44:52 INFO - 'TMOUT': '86400', 04:44:52 INFO - 'USER': 'cltbld', 04:44:52 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:52 INFO - '_': '/tools/buildbot/bin/python'} 04:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:52 INFO - Running setup.py (path:/tmp/pip-3Xv1UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:52 INFO - Running setup.py (path:/tmp/pip-8Q068U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:52 INFO - Running setup.py (path:/tmp/pip-j4dFy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:52 INFO - Running setup.py (path:/tmp/pip-Bx0j0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:53 INFO - Running setup.py (path:/tmp/pip-PQCW6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:53 INFO - Running setup.py (path:/tmp/pip-gvtXC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:53 INFO - Running setup.py (path:/tmp/pip-2DCzCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:53 INFO - Running setup.py (path:/tmp/pip-OzwAvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:53 INFO - Running setup.py (path:/tmp/pip-xkk8Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:53 INFO - Running setup.py (path:/tmp/pip-g76QuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:53 INFO - Running setup.py (path:/tmp/pip-CAM1fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:53 INFO - Running setup.py (path:/tmp/pip-0furSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:53 INFO - Running setup.py (path:/tmp/pip-qq6JJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:53 INFO - Running setup.py (path:/tmp/pip-2AuFsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:53 INFO - Running setup.py (path:/tmp/pip-SMC50s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:53 INFO - Running setup.py (path:/tmp/pip-o5Sy5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:53 INFO - Running setup.py (path:/tmp/pip-9qh0qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:44:53 INFO - Running setup.py install for manifestparser 04:44:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Running setup.py install for mozcrash 04:44:54 INFO - Running setup.py install for mozdebug 04:44:54 INFO - Running setup.py install for mozdevice 04:44:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Running setup.py install for mozfile 04:44:54 INFO - Running setup.py install for mozhttpd 04:44:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Running setup.py install for mozinfo 04:44:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Running setup.py install for mozInstall 04:44:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:44:54 INFO - Running setup.py install for mozleak 04:44:54 INFO - Running setup.py install for mozlog 04:44:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Running setup.py install for moznetwork 04:44:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Running setup.py install for mozprocess 04:44:55 INFO - Running setup.py install for mozprofile 04:44:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Running setup.py install for mozrunner 04:44:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Running setup.py install for mozscreenshot 04:44:55 INFO - Running setup.py install for moztest 04:44:55 INFO - Running setup.py install for mozversion 04:44:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:44:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:44:55 INFO - Cleaning up... 04:44:55 INFO - Return code: 0 04:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:55 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 0x27f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, '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': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', '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 04:44:55 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 04:44:55 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 04:44:55 INFO - Using env: {'DISPLAY': ':0', 04:44:55 INFO - 'HOME': '/home/cltbld', 04:44:55 INFO - 'LANG': 'en_US.UTF-8', 04:44:55 INFO - 'LANGUAGE': 'en_US:en', 04:44:55 INFO - 'LOGNAME': 'cltbld', 04:44:55 INFO - 'MAIL': '/var/mail/cltbld', 04:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:55 INFO - 'MOZ_NO_REMOTE': '1', 04:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:55 INFO - 'NO_EM_RESTART': '1', 04:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:55 INFO - 'PWD': '/builds/slave/test', 04:44:55 INFO - 'SHELL': '/bin/bash', 04:44:55 INFO - 'SHLVL': '1', 04:44:55 INFO - 'TERM': 'linux', 04:44:55 INFO - 'TMOUT': '86400', 04:44:55 INFO - 'USER': 'cltbld', 04:44:55 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:55 INFO - '_': '/tools/buildbot/bin/python'} 04:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:56 INFO - Running setup.py (path:/tmp/pip-vwqYlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:56 INFO - Running setup.py (path:/tmp/pip-JnDCNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:56 INFO - Running setup.py (path:/tmp/pip-TwcmCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:56 INFO - Running setup.py (path:/tmp/pip-1H31XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:56 INFO - Running setup.py (path:/tmp/pip-aqki3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:56 INFO - Running setup.py (path:/tmp/pip-gnF_6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:56 INFO - Running setup.py (path:/tmp/pip-cxGsdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:56 INFO - Running setup.py (path:/tmp/pip-jzfUYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:56 INFO - Running setup.py (path:/tmp/pip-z0Eb3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:56 INFO - Running setup.py (path:/tmp/pip-jqoa4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:56 INFO - Running setup.py (path:/tmp/pip-s_PdT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:56 INFO - Running setup.py (path:/tmp/pip-KKgdyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:56 INFO - Running setup.py (path:/tmp/pip-EeowM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:56 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)) 04:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:56 INFO - Running setup.py (path:/tmp/pip-i2kLTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:57 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)) 04:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:57 INFO - Running setup.py (path:/tmp/pip-Adg27x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:57 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)) 04:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:57 INFO - Running setup.py (path:/tmp/pip-E5p7Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:57 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)) 04:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:57 INFO - Running setup.py (path:/tmp/pip-san3Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:57 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)) 04:44:57 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)) 04:44:57 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)) 04:44:57 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)) 04:44:57 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)) 04:44:57 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)) 04:44:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:57 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 04:44:57 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 04:44:57 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 04:44:57 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 04:44:57 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 04:44:57 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 04:44:59 INFO - Downloading blessings-1.6.tar.gz 04:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:44:59 INFO - Installing collected packages: blessings 04:44:59 INFO - Running setup.py install for blessings 04:44:59 INFO - Successfully installed blessings 04:44:59 INFO - Cleaning up... 04:44:59 INFO - Return code: 0 04:44:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:59 INFO - Reading from file tmpfile_stdout 04:44:59 INFO - Current package versions: 04:44:59 INFO - argparse == 1.2.1 04:44:59 INFO - blessings == 1.6 04:44:59 INFO - blobuploader == 1.2.4 04:44:59 INFO - docopt == 0.6.1 04:44:59 INFO - functools32 == 3.2.3-2 04:44:59 INFO - jsonschema == 2.5.1 04:44:59 INFO - manifestparser == 1.1 04:44:59 INFO - mozInstall == 1.12 04:44:59 INFO - mozcrash == 1.0 04:44:59 INFO - mozdebug == 0.1 04:44:59 INFO - mozdevice == 0.49 04:44:59 INFO - mozfile == 1.2 04:44:59 INFO - mozhttpd == 0.7 04:44:59 INFO - mozinfo == 0.9 04:44:59 INFO - mozleak == 0.1 04:44:59 INFO - mozlog == 3.4 04:44:59 INFO - moznetwork == 0.27 04:44:59 INFO - mozprocess == 0.25 04:44:59 INFO - mozprofile == 0.28 04:44:59 INFO - mozrunner == 6.13 04:44:59 INFO - mozscreenshot == 0.1 04:44:59 INFO - mozsystemmonitor == 0.3 04:44:59 INFO - moztest == 0.8 04:44:59 INFO - mozversion == 1.4 04:44:59 INFO - psutil == 3.1.1 04:44:59 INFO - requests == 1.2.3 04:44:59 INFO - wsgiref == 0.1.2 04:44:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:59 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 0x27f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, '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': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', '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 04:44:59 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 04:44:59 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 04:44:59 INFO - Using env: {'DISPLAY': ':0', 04:44:59 INFO - 'HOME': '/home/cltbld', 04:44:59 INFO - 'LANG': 'en_US.UTF-8', 04:44:59 INFO - 'LANGUAGE': 'en_US:en', 04:44:59 INFO - 'LOGNAME': 'cltbld', 04:44:59 INFO - 'MAIL': '/var/mail/cltbld', 04:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:59 INFO - 'MOZ_NO_REMOTE': '1', 04:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:59 INFO - 'NO_EM_RESTART': '1', 04:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:59 INFO - 'PWD': '/builds/slave/test', 04:44:59 INFO - 'SHELL': '/bin/bash', 04:44:59 INFO - 'SHLVL': '1', 04:44:59 INFO - 'TERM': 'linux', 04:44:59 INFO - 'TMOUT': '86400', 04:44:59 INFO - 'USER': 'cltbld', 04:44:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:59 INFO - '_': '/tools/buildbot/bin/python'} 04:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:59 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)) 04:44:59 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)) 04:44:59 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)) 04:44:59 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)) 04:44:59 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)) 04:44:59 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)) 04:44:59 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)) 04:44:59 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)) 04:44:59 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)) 04:44:59 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)) 04:44:59 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)) 04:44:59 INFO - Cleaning up... 04:44:59 INFO - Return code: 0 04:44:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, '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': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', '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 04:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:44:59 INFO - Using env: {'DISPLAY': ':0', 04:44:59 INFO - 'HOME': '/home/cltbld', 04:44:59 INFO - 'LANG': 'en_US.UTF-8', 04:44:59 INFO - 'LANGUAGE': 'en_US:en', 04:44:59 INFO - 'LOGNAME': 'cltbld', 04:44:59 INFO - 'MAIL': '/var/mail/cltbld', 04:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:59 INFO - 'MOZ_NO_REMOTE': '1', 04:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:59 INFO - 'NO_EM_RESTART': '1', 04:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:59 INFO - 'PWD': '/builds/slave/test', 04:44:59 INFO - 'SHELL': '/bin/bash', 04:44:59 INFO - 'SHLVL': '1', 04:44:59 INFO - 'TERM': 'linux', 04:44:59 INFO - 'TMOUT': '86400', 04:44:59 INFO - 'USER': 'cltbld', 04:44:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:59 INFO - '_': '/tools/buildbot/bin/python'} 04:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:00 INFO - Cleaning up... 04:45:00 INFO - Return code: 0 04:45:00 INFO - Running post-action listener: _resource_record_post_action 04:45:00 INFO - Running post-action listener: _start_resource_monitoring 04:45:00 INFO - Starting resource monitoring. 04:45:00 INFO - [mozharness: 2017-03-27 11:45:00.201587Z] Finished create-virtualenv step (success) 04:45:00 INFO - [mozharness: 2017-03-27 11:45:00.202101Z] Running install step. 04:45:00 INFO - Running pre-action listener: _resource_record_pre_action 04:45:00 INFO - Running main action method: install 04:45:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:00 INFO - Reading from file tmpfile_stdout 04:45:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:00 INFO - Reading from file tmpfile_stdout 04:45:00 INFO - Output received: 04:45:00 INFO - Usage: mozinstall [options] installer 04:45:00 INFO - Options: 04:45:00 INFO - -h, --help show this help message and exit 04:45:00 INFO - -d DEST, --destination=DEST 04:45:00 INFO - Directory to install application into. [default: 04:45:00 INFO - "/builds/slave/test"] 04:45:00 INFO - --app=APP Application being installed. [default: firefox] 04:45:00 INFO - mkdir: /builds/slave/test/build/application 04:45:00 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'] 04:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:45:17 INFO - Reading from file tmpfile_stdout 04:45:17 INFO - Output received: 04:45:17 INFO - /builds/slave/test/build/application/firefox/firefox 04:45:17 INFO - Running post-action listener: _resource_record_post_action 04:45:17 INFO - [mozharness: 2017-03-27 11:45:17.063029Z] Finished install step (success) 04:45:17 INFO - [mozharness: 2017-03-27 11:45:17.063369Z] Running run-tests step. 04:45:17 INFO - Running pre-action listener: _resource_record_pre_action 04:45:17 INFO - Running main action method: run_tests 04:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:17 INFO - Python 2.7.3 04:45:17 INFO - Return code: 0 04:45:17 INFO - grabbing minidump binary from tooltool 04:45:17 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')]} 04:45:17 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 0x2a8b290>, '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 0x2a8bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:17 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 04:45:17 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 04:45:17 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 04:45:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:17 INFO - Return code: 0 04:45:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:45:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:17 INFO - ENV: RUST_BACKTRACE is now 1 04:45:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:45:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 04:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 04:45:17 INFO - Using env: {'DISPLAY': ':0', 04:45:17 INFO - 'HOME': '/home/cltbld', 04:45:17 INFO - 'LANG': 'en_US.UTF-8', 04:45:17 INFO - 'LANGUAGE': 'en_US:en', 04:45:17 INFO - 'LOGNAME': 'cltbld', 04:45:17 INFO - 'MAIL': '/var/mail/cltbld', 04:45:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:17 INFO - 'MOZ_NO_REMOTE': '1', 04:45:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:17 INFO - 'NO_EM_RESTART': '1', 04:45:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:17 INFO - 'PWD': '/builds/slave/test', 04:45:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:17 INFO - 'RUST_BACKTRACE': '1', 04:45:17 INFO - 'SHELL': '/bin/bash', 04:45:17 INFO - 'SHLVL': '1', 04:45:17 INFO - 'TERM': 'linux', 04:45:17 INFO - 'TMOUT': '86400', 04:45:17 INFO - 'USER': 'cltbld', 04:45:17 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835', 04:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:17 INFO - '_': '/tools/buildbot/bin/python'} 04:45:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 04:45:17 INFO - mozversion application_buildid: 20170327105142 04:45:17 INFO - mozversion application_changeset: 0583275688f1f5e8e6d6c6842514c7ec183f5381 04:45:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:45:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:17 INFO - mozversion application_name: Firefox 04:45:17 INFO - mozversion application_remotingname: firefox-dev 04:45:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:17 INFO - mozversion application_vendor: Mozilla 04:45:17 INFO - mozversion application_version: 54.0a2 04:45:17 INFO - mozversion platform_buildid: 20170327105142 04:45:17 INFO - mozversion platform_changeset: 0583275688f1f5e8e6d6c6842514c7ec183f5381 04:45:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:17 INFO - mozversion platform_version: 54.0a2 04:45:17 INFO - using testdate: 1490615117 04:45:17 INFO - actual date: 1490615117 04:45:17 INFO - starting webserver on 'localhost:49902' 04:45:17 INFO - SUITE-START | Running 2 tests 04:45:17 INFO - TEST-START | dromaeo_css 04:45:17 INFO - operating with platform_type : linux_ 04:45:17 INFO - Initialising browser for dromaeo_css test... 04:45:17 INFO - TEST-INFO | started process 14719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTAN8VR/profile http://localhost:49902/getInfo.html) 04:45:21 INFO - PROCESS | 14719 | __metrics Screen width/height:1600/1200 04:45:21 INFO - PROCESS | 14719 | colorDepth:24 04:45:21 INFO - PROCESS | 14719 | Browser inner width/height: 1024/697 04:45:21 INFO - PROCESS | 14719 | __metrics 04:45:22 INFO - PROCESS | 14719 | 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" 04:45:22 INFO - PROCESS | 14719 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:23 INFO - TEST-INFO | 14719: exit 0 04:45:23 INFO - Browser initialized. 04:45:23 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:23 INFO - TEST-INFO | started process 14809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTAN8VR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:35 INFO - PROCESS | 14809 | RSS: Main: 139350016 04:45:35 INFO - PROCESS | 14809 | 04:48:37 INFO - PROCESS | 14809 | Cycle 1(1): loaded http://localhost:49902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49902/tests/dromaeo/cssquery-ext.html) 04:48:38 INFO - PROCESS | 14809 | RSS: Main: 274558976 04:48:38 INFO - PROCESS | 14809 | 04:50:26 INFO - PROCESS | 14809 | ************************* 04:50:26 INFO - PROCESS | 14809 | A coding exception was thrown and uncaught in a Task. 04:50:26 INFO - PROCESS | 14809 | 04:50:26 ERROR - PROCESS | 14809 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:26 INFO - PROCESS | 14809 | Full stack: 04:50:26 INFO - PROCESS | 14809 | ************************* 04:51:40 INFO - PROCESS | 14809 | Cycle 1(1): loaded http://localhost:49902/tests/dromaeo/cssquery-ext.html (next: http://localhost:49902/tests/dromaeo/cssquery-jquery.html) 04:51:41 INFO - PROCESS | 14809 | RSS: Main: 226050048 04:51:41 INFO - PROCESS | 14809 | 04:54:43 INFO - PROCESS | 14809 | Cycle 1(1): loaded http://localhost:49902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49902/tests/dromaeo/cssquery-mootools.html) 04:54:43 INFO - PROCESS | 14809 | RSS: Main: 170012672 04:54:43 INFO - PROCESS | 14809 | 04:57:45 INFO - PROCESS | 14809 | Cycle 1(1): loaded http://localhost:49902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49902/tests/dromaeo/cssquery-prototype.html) 04:57:46 INFO - PROCESS | 14809 | RSS: Main: 170512384 04:57:46 INFO - PROCESS | 14809 | 05:00:49 INFO - PROCESS | 14809 | Cycle 1(1): loaded http://localhost:49902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49902/tests/dromaeo/cssquery-yui.html) 05:00:49 INFO - PROCESS | 14809 | RSS: Main: 174882816 05:00:49 INFO - PROCESS | 14809 | 05:03:52 INFO - PROCESS | 14809 | Cycle 1(1): loaded http://localhost:49902/tests/dromaeo/cssquery-yui.html (next: http://localhost:49902/tests/dromaeo/cssquery-dojo.html) 05:03:52 INFO - PROCESS | 14809 | RSS: Main: 260923392 05:03:52 INFO - PROCESS | 14809 | 05:03:52 INFO - PROCESS | 14809 | __start_tp_report 05:03:52 INFO - PROCESS | 14809 | _x_x_mozilla_page_load 05:03:52 INFO - PROCESS | 14809 | _x_x_mozilla_page_load_details 05:03:52 INFO - PROCESS | 14809 | |i|pagename|runs| 05:03:52 INFO - PROCESS | 14809 | |0;dojo.html;3376.7805092668973;3399.9320013599745;3407.8296085195734;3437.329720704464;3453.5855697316324;5668.404817494161;5728.112142617901;5743.626664266831;5747.224124743164;5757.251557297551;5739.282589676291;5781.277340332458;5784.103463963082;5795.855103622401;5798.65208087515;5097.362829646304;5139.126348520742;5170.043541944733;5175.922361164586;5229.2417599448245;5049.772760225798;5233.1103712368795;5234.136367499358;5238.978399212155;5268.736563171845;5057.393112826466;5123.513266239701;5161.870953226162;5225.634205605609;5235.083860324447;5208.713520756357;5243.2659427680155;5247.737613119329;5253.0544501989625;5258.947410525884;5096.745162741848;5139.126348520723;5214.113600687854;5217.50433708797;5236.136037553837;5569.777208911639;5582.972085139589;5604.299462567179;5605.439456054402;5615.550755939515;6027.397260273981;6027.487663548603;6059.242594675666;6061.757529698807;6090.177825993478;6122.295935967376;6124.203853499017;6135.3864613538735;6136.20229370179;6141.785037523665;5556.138798486241;5561.360443548962;5722.313322401297;5736.541076713853;5763.7982670606325;6274.6548939807835;6287.905681414691;6292.874142517216;6293.402126797947;6293.842653933688;6002.699865006733;6048.0625503047095;6079.544034197453;6087.634741915499;6102.389761023862;5992.370801065913;6043.244594425697;6045.667488288186;6187.84530386744;6191.226096737908;6077.301110372364;6115.908261376083;6117.082437634302;6127.877442451215;6129.356417576179;5979.611325263844;6026.6986650667295;6034.034554471351;6108.144859719643;6120.60216085953;4621.329907163443;4659;4688.343631891538;4692.554207350297;4716.221823399169;4185.100203456272;4191.140816132685;4225.72532785368;4233.936490952638;4241.97879010603;5738.942610573924;5801.9419805802245;5891.41085891416;5948.256467941507;6018.247719035121;6173.290071641819;6209.410106040009;6209.813705588839;6209.875802484015;6210.285817131088;6006.339302676702;6009.369016253318;6010.909836352458;6013.188219590387;6046.939530604637;5113.948860511422;5143.408508021551;5210.426853046162;5248.107821670325;5276.472352764769;6443.6455994920725;6451.741930322734;6457.257415397102;6460.192475940507;6461.386168314003;6168.9691551541955;6204.751809927552;6213.1922850029205;6218.098375735583;6220.160278362363;6208.658523781235;6225.066240063846;6333.524985626189;6403.199600049994;6476.06097115925;6008.309044459943;6050.6369617823075;6079.392060794062;6092.025275955826;6101.60339577926;6186.298058916677;6205.968970155121;6219.751209951552;6219.937800621936;6225.346338634378;5816.563757718272;5919.585629005928;6070.368800339233;6073.058675905242;6115.6330620162935;5990.8502287441415;5993;6039.15451836752;6098.725557349841;6121.4490695837585;6058.666773327333;6064;6064.514838812796;6077.331493535796;6077.453029227391;5882.294124705063;5883.823485295448;5936.643801371932;5946;6131.724072416841;5871.324797648325;5912.911306330495;5937.406259374028;5963.314218864886;5974.193483879794 05:03:52 INFO - PROCESS | 14809 | |1;ext.html;763.5304287862966;819.7540737778666;830.4809494066207;907.3285768531281;908.8000639859229;30270.848645756767;42482.575174248246;42829;42991.35512967308;43295.567044329546;37970.81014594923;38263.42604860929;38390;41316.380254296135;41356;7593.886091708629;8968.596413161424;9097.317701172406;9105.317101217403;9113.772155696128;7567.924320756777;10526;10681.679549613486;10704.946475267652;10734.087602553793;10835.83746243807;10849.077828384598;10855.837162442569;10860.13118950482;10860.402677852715;10742;10762.623308184255;10773.83839242412;10777.78444431111;10822.134229261641;10601.257911946166;10624;10648.41433721145;10654.73363165927;10655.200859935458;39841.40237896434;39906.40140397896;39919.401208981886;40136.197276054605;40150.397744033864;4058.7767672777986;4074.8166332515107;4128.690348223895;4195.601417865298;4242.130363275552;29875;29909;30198.396032079236;30388;30543.236419089477;4019.095703466726;4095.5494895561465;4133.607307305801;4145.564715704838;4224.366345048236;217220;220947;273873;274371;363677.9999999974;45529.317060244124;46105;46127.53872461232;46188.5381146191;46195.307070393974;47604.28593571099;47723.5227647726;47861.52138478571;47923;47990.28014579714;15377.769333460006;15620.453284135001;15622.76565851513;15624.76562851558;15637;10858;10972.067374273116;13668.794968075486;13695.520656776966;13710.38303276335;11721.4139293035;11808.114391420679;12671.11302208855;12845;12975.09174357786;5493.148561972901;5497.9932324701995;5503.477169668875;5641.52047075995;5684.317881854204;1160.0951258018758;1164.5923926625612;1167.287954347847;1186.9347185904685;1196.9940150299192;18243.81756182448;18871.811281887007;18995.715064274045;19020.42938711841;19356.90321548383;1248.918820276679;1252.987470125287;1263.406199086428;1285.8135570342247;1306.5361796562274;9742.951285243671;9961.302708810459;10001.199904007663;10019.599216031276;10050.59797608102;320836;321357;321659;323458;324376;56087.15869261965;56176;56238;56302;56316.15525767117;1525.351725516651;1529.17424590722;1564.1788061267926;1567.3730507796972;1575.8030246219223;18137.637247255247;18165.818341816943;18386;18578;18592.907035464737;42372.15255694807;42430.151396972506;42472.15055698807;42491.15017699567;42574.57425425706;278830;279399;280507;280902;281768;32854.507182391804;33158.502622461165;33362.833185833915;33459.49810752792;33472;35406.645933540334;38147.618523815516;49529.50470495249;53346.73326633342;53369;37289.81355093207;37398.786179746494;37418.251634966604;37623.059423514635;38339.42490862695;37210.441843372915;37223.81388093042;37584.624153758115;37654.62345376511;37846.62153378431;42739.57260427356;42887.57112428961;42939.35590966076;43054.56945430631;43116;35598.11004724903;35809.82095089612;35952.4607130888;36272.45591316185;36435.27129457449;28296.43407131887;28629.28426789347;28657.856710716314;28821.711782881903;28954.710452896044 05:03:52 INFO - PROCESS | 14809 | |2;jquery.html;443.7404118590624;450.20089341418975;453.96595255355845;462.94676112247083;463.45312531213165;19907.60184796305;20584.485387865294;20931;21048.789512104875;21971.890140549294;20807.68788468174;22026;22150.22474213403;22175.223867164652;22396.664050039264;5842.941570584304;6000.6099603525845;6372.330905254951;6749.156355455568;6822.28366021568;6553.6395498247575;6730.966345168292;6796.184457865038;6801;6807.795766127024;6528.543001989862;6563.835904102411;6576.408123268905;6583.473322134242;6790.253072162058;6559.737610495575;6688.230853451867;6720.95825147103;6749.595024298558;6769.3907548320885;6607.207135143765;6638.800835974928;6646.667666616699;6650.20197576294;6651.76718814844;24553.508929821302;24851.378715532075;25448.872755636105;25528.361790955376;25701.48597028049;3122.437961167012;3211.3577284542953;3234.2237862912966;3257.2062963403628;3287.079617707046;16158.515244542683;16230.188490575423;16503.91748041264;16983.23575439096;17331.480055598353;2209.5139069404704;2275.5335156293086;2286.119843860126;2315.710536182977;2339.6841426407386;70701.64649176772;91198.5440072802;92470;104226.47886760518;119840;18335.816641833677;18340.816591834177;18644.16101275446;18783.81216187848;19150;32830.34339313248;32899.34201316008;32943.50584741231;33072.17319566982;33096.66903330984;9793.118619324152;9825.213982881352;9871.555779989918;10044.648437304659;10139.949300253451;8074;8147.511149331059;8169.959150204211;8339.583020848933;8350.498970061815;9354.625814967461;9376.156145946761;9570.665026724031;9615.56729947154;9743.464109474047;3478.8519788469744;3634.7819130852236;3780.4896338994436;3815.351390263662;3877.592852750477;966.9323147379756;977.9364341317792;980.3333733061444;985.1330828870548;1010.0555980158575;20501.58996820085;20512.692309615366;20597.89701051485;20677.483062923548;21237.469063273234;958.3866325551653;982.4056445850158;991.4299277915084;997.8952210017989;998.930074894765;10979.341239525655;11505.044142495795;11711.355875426763;11793.469293881795;11888.227265227733;541869;551893;555164;563148;565163;103449.48275258575;104718;109365;114233.42883285531;115322.42338788252;1308.9018323625576;1323.715401188749;1373.642852858264;1380.7790753479394;1383.7440073586217;19205;19312.517187069872;19448.70826937569;19560;19588.11853466569;47099.76450117728;49978;50990.490095098576;52176;52326.73836630792;64531.677341612994;65435.672821635584;65457;67048.32951670616;67159;12505.187162834387;13074;13086.14940028895;13119.147255428366;13140.868591313965;13611.183329000292;14500.564983050524;14553;14653.780193296896;15048.473303434328;12126.878731212575;12135.150539462153;12210.389480526115;12292.631221063382;12378.876211237772;10934.398608076313;11145.609903653332;11151.888481115086;11222.270552414067;11282.984531392214;12106.878931210575;12270.509179632714;12426.192297500995;12450.439730212343;12897.22616642967;12957.481700731865;12961.805572916603;12974.805377919527;13042.608721738363;13130.868691312964;12245.448954796877;12292.877071229532;12506.624801255977;12640;12728.554500592434 05:03:52 INFO - PROCESS | 14809 | |3;mootools.html;1534.156214082256;1539.3688587679046;1541.5067178502877;1559.5009596928983;1567.2242240091157;10370.792584148321;11008.339499630029;11009.119270458365;11029.889701102986;11031.338119712824;10634.840477392845;10751.62369317074;10903.29128606642;10931.398773067498;10935.671929842098;2461.6307553866927;2494.8004159667184;2500.3124140861228;2500.362407586063;2504.511620234055;2420.455397535558;2475.7400472950353;2529.620556916459;2532.0757923357933;2533.949321013579;2452.1540068676277;2463.4949835283724;2487.32842132625;2493.5885578879465;2494.0546373828442;2329.6156134237917;2358.78770910618;2364.5980183368697;2371.6442533619925;2426.5632186206476;2356.15178535727;2380.0479808076907;2391.5575618510456;2392.593259145932;2398.136670798511;10995.780084398348;11179.776404471946;11198.496067676973;11212.66362009141;11214.775704485864;5655.886882262332;5833.649981001154;5834.708264586754;5835.270591176103;5844.415558444164;3331.683490068464;3430.125318043908;3471.3230919970615;3474.1314671332166;3528.4707293905863;1297.9805302920463;1332.7734285171448;1332.9000324975568;1378.4692893236077;1398.4615922869768;14116.294185290695;14447.78328325076;15572.688546229125;15645.061296322257;15760.290786914617;4782.139214941274;4846.5638092571835;4881.316615673809;4949.554540091409;4982;12294.815577766341;12367.876321236852;12368.567100151451;12419.19275247106;12423.695511971293;5756.683382413924;5769.221155144001;5774.538036957033;5779.797707080232;5784.132380142928;5422;5485.232067510552;5485.6434331768305;5500.58745594082;5562.332520097614;3967.781772002568;4033.4353190553347;4090.9386359204636;4106.507219133723;4118.629323360912;1087.211771465681;1092.153580974735;1092.6066616018227;1109.0295991007868;1111.8610173728284;989.6387818446216;1003.9447830369254;1008.3899240959261;1013.8023085498257;1022.5091955861228;6792.558483698643;6883.8967415488805;7024.508284420143;7080.6633810842295;7199.964000179965;1056.292284169593;1095;1103.7295862513736;1115.7099154219961;1121.786860496503;4435.445569303837;4490.955090449119;4503.81984720614;4549.818007279738;4553.54464553542;13387;13897.444102235797;14223.217723025125;14237.288135593179;14261.42954281817;13922.721545569235;13962.650933726738;13986.650333741738;14012.299385030708;14052.648683782783;8878.156575125482;10519.94740026295;10559.683209503728;10587.311824731369;10674.946625266824;5604.663720176803;6792.796216113525;6960.965195173992;6991.825204369931;7043.190033146049;11980.58067967617;12314.26114433101;12603.747925041265;12708.809367859674;12874.806877897026;12754.68113297175;12891.677708057374;13032.087753857519;13098.345082745634;13369.866301336862;9478.763030924281;9581.520923953634;9633.518324083909;9677.322587419094;9749.853752193865;10418.68743937683;10469.267151299337;10630.362178269328;10685.038346548848;10697.679069627924;8799.296056315607;8821.558922054;8853.867191991996;8896.421732587361;9028.232600229054;8522.74431767048;8668.739937801876;8698.304135669005;8884.422512536665;8906.821863562822;8467.57662116904;8471.788205294917;8494.150584941457;8577.31381489467;8580.828383432421;5934.258217722785;5936.139259807217;5999.640021598718;6022.307434645072;6099.939000610115;6170.876582468415;6189.257289125334;6218.06728990655;6293;6343.492520598434 05:03:52 INFO - PROCESS | 14809 | |4;prototype.html;416.52724158080576;416.9562195969423;421.00024881811396;425.2918890048068;431.0731926358331;5274.314339135907;5304.143549757583;5308.70802105884;5325.707086110262;5328.520433161015;4979.975100124503;5130.6152038597065;5161.690298582088;5189.6107791915665;5190.558802501782;4148.23257697327;4170.791460426982;4174.66602671787;4180.707350485475;4181.790910454481;4167.562405947378;4177.958220417802;4184.644305234059;4216.241076606209;4223.746575205498;4021.678265738734;4150.564190759972;4158.584141585848;4168.666506679474;4220.36694495825;4090.2842002649713;4127.390317776069;4146.564610715862;4152.647025002879;4159.5216550096675;3763.833211704353;3789.810509474543;3801.144742432958;3815.561210460805;3856.614338566149;4820.879478013043;5030.899382012376;5146.30524879144;5177.534021938006;5183.585313174937;4976;5030.798768049273;5043.52086551777;5053.2818841594035;5082.872928176788;5427.240186373911;5469.562435005229;5482.479164479408;5491.917621235684;5498.5876059295715;4359.934600980988;4442.2892337225885;4568.360429539867;4589.173948689235;4621.630269578459;5367.684917195312;5515.0697255960495;5631.211630371751;5640.351359593658;5678.545716342683;4594.632429405639;4658.673892827537;4670.252759558454;4701.976490117528;4704.529547045268;4761.262004389325;4767.380240568704;4770.546798054179;4779.211430114062;4780.928286075712;4824.204006338985;4895.437024742129;4933.5578888450445;5015.623828212899;5065.721385323843;5447.428020057916;5471.562275018068;5478.534324582375;5514.393416724157;5521.503064724114;1558.7739777732393;1647.5963388969778;1649.5628658405533;1654.9751753723704;1668.4077152610892;1252.1860790486257;1252.787026205529;1267.8525934029717;1269.7968325067945;1299.3503248375812;5255.868603284948;5380.139177731622;5381.865453363697;5476.534494567926;5484.890302193934;5566.332040155207;5591.329040515164;5592.273004509388;5596.209213051784;5629.183768353566;5153.819616313411;5281.39263984639;5384.973075134678;5403.379361009907;5416.756245968941;2915.941681166365;2916.562515622631;2943.0876428306865;2943.910753021396;2948.719871612236;5792.292932523189;5814.778896431712;5820.883582328414;5846.590738648254;5855.59010869235;5497.39528651848;5665.405132461115;5681.375048744635;5692.288463942007;5700.857478562986;5776.989026920356;5785.797497087582;5808.94191058084;5810.448007439287;5862.941370586324;5261.5264626183825;5571;5592.916106258491;5614.21401003868;5640;5294.2852714883;5415.458454154553;5442.510174084193;5515.69663668486;5527.972360138335;5673.234113394639;5741.822926300182;5814.854628634318;5915.704214789157;5917.881642367042;4683.367745354333;4684.6486513510945;4689.155951928686;4725.645576581839;4726.338312636165;5393.6951273319;5524.613277070727;5559.776849093193;5568.721563921868;5600.243967064394;5411.891762164656;5442;5452.727363631723;5463.344398672185;5500.8017423534375;5449.782008719607;5455.099908515051;5474.562035037267;5491.697956612425;5530.6128570999645;5173.586113110867;5489.737360407208;5553.916691249554;5557.055300598827;5561.499465048165;5494.340679118532;5527.8894422110525;5570.749316280858;5581.860453488695;5634.7464364104535;5136.5377116059735;5325.201219817059;5372.105223712777;5448.56411487088;5480.451954804487 05:03:52 INFO - PROCESS | 14809 | |5;yui.html;819.4714409206058;851.0808327006833;921.143336696872;934.3039435620464;941.6798288581883;13882.444702211911;15912;15929.123898185595;16104.677906441864;16224.351025958962;14391.352389142488;14505.492307769231;15691.058536487819;15919.044857308541;15966.600834979103;833.5582141465034;857.498363457375;866.7226487523994;868.9087645797196;870.316801310971;871.6382701179003;875.155474966657;882.9646814127427;893.6738090596917;894.3962825093068;945.9337846350758;948.8766460360179;948.928830337724;949.0225068179751;949.06991148674;928.5496534180883;929.4794914847707;936.5317341329335;937.0863408177041;937.1097457415483;700.0514303119302;700.7442283566512;701.0570782297801;701.0780823217452;701.6596950479013;15369.692606147926;15402.3839046438;15413.614659633487;15510.457134000257;15694.607634809106;14999.775003374958;15300.234988250655;15679.608009799733;15691.058536487733;16157;13551.796723049063;13572.728545429036;13665.111767735065;13761.31193440324;14051.43794248229;3825.980870095632;3850.8074596270076;3852.903677408059;3923.019245188703;4037;86705;87316;87703.12296877077;89297;91085.54457227672;12057.758844823054;12063.517459301705;12072.3360215189;12189.878101219052;12211.328376939176;23465.86451738619;23569.764302356758;23672.88163559171;23728.169514066925;23963.52072958531;8257.133001034925;8341.249287564027;8364.37267204962;8535.146485351415;8647.221750042401;4502.144592527409;4560.247559152769;4642.744649044267;4751.40607424072;4787.569118779326;3705.5368078990127;3802.3155831950517;3805.162864169878;3805.6765174960437;3807.124361396894;638.6774678787183;640.7917426836296;650.0346984727676;661.5699795133106;662.3939095727452;799.6681377228501;801.317722476957;801.7240527101496;824.0482243009334;832.8459235041537;10889.455527223607;12179.695507612381;12216.816747748791;12582.43379047945;12798;667.4893706314673;681.6012632609879;688.6900894597451;706.8162277807807;714.6926821466819;5269.631125821155;5630.0991841305195;5660.575456840754;5722;5723.77104915807;78080.2191978073;78733;78779;79150.60424697955;79989;59912.70043649754;68428;69917.65041174761;70181.2981870185;70958;61297.38702612917;61336;61372;61857.69071154705;62229.37770622236;11120.777584448104;11424.771504570028;11864.703382415164;12047.156699030984;12216.389180541115;36095;41197.1760564793;42798.71603851889;43624.56375436332;43748;55475.72262138664;58099;59577;60084.69957650184;60092.69953650204;13221.669458263621;13537.796933045815;13714;13740.175589464665;13783.862161378658;16561.25474353633;16675.332986680398;16678.166091695122;16901.239444224793;16910.57723556921;14716.337764800395;14766.114033158045;14919.85080149228;14954.700905981601;15676.451324203597;15560.28432116609;16116.838831611534;16122.677546448771;16404.753928691316;16641.583960401087;15519.301631426388;15714.371425142866;17043.82956170472;17064.14679266007;17169.91415042917;10820;10921.890781092405;11136.665900023012;11356.602518911799;11966.162368634112;12710.809337859755;12859.421326040538;13006;13259.602211933658;13404.798928016282 05:03:52 INFO - PROCESS | 14809 | __end_tp_report 05:03:52 INFO - PROCESS | 14809 | __start_cc_report 05:03:52 INFO - PROCESS | 14809 | _x_x_mozilla_cycle_collect,1379 05:03:52 INFO - PROCESS | 14809 | __end_cc_report 05:03:52 INFO - PROCESS | 14809 | __startTimestamp1490616232465__endTimestamp 05:03:52 INFO - PROCESS | 14809 | 05:03:52 INFO - PROCESS | 14809 | ------- Summary: start ------- 05:03:52 INFO - PROCESS | 14809 | Number of tests: 6 05:03:52 INFO - PROCESS | 14809 | 05:03:52 INFO - PROCESS | 14809 | [#0] dojo.html Cycles:165 Average:5708.97 Median:5992.37 stddev:649.72 (10.8%) stddev-sans-first:625.42 05:03:52 INFO - PROCESS | 14809 | Values: 3376.8 3399.9 3407.8 3437.3 3453.6 5668.4 5728.1 5743.6 5747.2 5757.3 5739.3 5781.3 5784.1 5795.9 5798.7 5097.4 5139.1 5170.0 5175.9 5229.2 5049.8 5233.1 5234.1 5239.0 5268.7 5057.4 5123.5 5161.9 5225.6 5235.1 5208.7 5243.3 5247.7 5253.1 5258.9 5096.7 5139.1 5214.1 5217.5 5236.1 5569.8 5583.0 5604.3 5605.4 5615.6 6027.4 6027.5 6059.2 6061.8 6090.2 6122.3 6124.2 6135.4 6136.2 6141.8 5556.1 5561.4 5722.3 5736.5 5763.8 6274.7 6287.9 6292.9 6293.4 6293.8 6002.7 6048.1 6079.5 6087.6 6102.4 5992.4 6043.2 6045.7 6187.8 6191.2 6077.3 6115.9 6117.1 6127.9 6129.4 5979.6 6026.7 6034.0 6108.1 6120.6 4621.3 4659.0 4688.3 4692.6 4716.2 4185.1 4191.1 4225.7 4233.9 4242.0 5738.9 5801.9 5891.4 5948.3 6018.2 6173.3 6209.4 6209.8 6209.9 6210.3 6006.3 6009.4 6010.9 6013.2 6046.9 5113.9 5143.4 5210.4 5248.1 5276.5 6443.6 6451.7 6457.3 6460.2 6461.4 6169.0 6204.8 6213.2 6218.1 6220.2 6208.7 6225.1 6333.5 6403.2 6476.1 6008.3 6050.6 6079.4 6092.0 6101.6 6186.3 6206.0 6219.8 6219.9 6225.3 5816.6 5919.6 6070.4 6073.1 6115.6 5990.9 5993.0 6039.2 6098.7 6121.4 6058.7 6064.0 6064.5 6077.3 6077.5 5882.3 5883.8 5936.6 5946.0 6131.7 5871.3 5912.9 5937.4 5963.3 5974.2 05:03:52 INFO - PROCESS | 14809 | 05:03:52 INFO - PROCESS | 14809 | [#1] ext.html Cycles:180 Average:45408.32 Median:33465.75 stddev:76780.56 (229.4%) stddev-sans-first:76922.78 05:03:52 INFO - PROCESS | 14809 | Values: 763.5 819.8 830.5 907.3 908.8 30270.8 42482.6 42829.0 42991.4 43295.6 37970.8 38263.4 38390.0 41316.4 41356.0 7593.9 8968.6 9097.3 9105.3 9113.8 7567.9 10526.0 10681.7 10704.9 10734.1 10835.8 10849.1 10855.8 10860.1 10860.4 10742.0 10762.6 10773.8 10777.8 10822.1 10601.3 10624.0 10648.4 10654.7 10655.2 39841.4 39906.4 39919.4 40136.2 40150.4 4058.8 4074.8 4128.7 4195.6 4242.1 29875.0 29909.0 30198.4 30388.0 30543.2 4019.1 4095.5 4133.6 4145.6 4224.4 217220.0 220947.0 273873.0 274371.0 363678.0 45529.3 46105.0 46127.5 46188.5 46195.3 47604.3 47723.5 47861.5 47923.0 47990.3 15377.8 15620.5 15622.8 15624.8 15637.0 10858.0 10972.1 13668.8 13695.5 13710.4 11721.4 11808.1 12671.1 12845.0 12975.1 5493.1 5498.0 5503.5 5641.5 5684.3 1160.1 1164.6 1167.3 1186.9 1197.0 18243.8 18871.8 18995.7 19020.4 19356.9 1248.9 1253.0 1263.4 1285.8 1306.5 9743.0 9961.3 10001.2 10019.6 10050.6 320836.0 321357.0 321659.0 323458.0 324376.0 56087.2 56176.0 56238.0 56302.0 56316.2 1525.4 1529.2 1564.2 1567.4 1575.8 18137.6 18165.8 18386.0 18578.0 18592.9 42372.2 42430.2 42472.2 42491.2 42574.6 278830.0 279399.0 280507.0 280902.0 281768.0 32854.5 33158.5 33362.8 33459.5 33472.0 35406.6 38147.6 49529.5 53346.7 53369.0 37289.8 37398.8 37418.3 37623.1 38339.4 37210.4 37223.8 37584.6 37654.6 37846.6 42739.6 42887.6 42939.4 43054.6 43116.0 35598.1 35809.8 35952.5 36272.5 36435.3 28296.4 28629.3 28657.9 28821.7 28954.7 05:03:52 INFO - PROCESS | 14809 | 05:03:52 INFO - PROCESS | 14809 | [#2] jquery.html Cycles:180 Average:34096.20 Median:24702.44 stddev:91679.40 (371.1%) stddev-sans-first:91901.77 05:03:52 INFO - PROCESS | 14809 | Values: 443.7 450.2 454.0 462.9 463.5 19907.6 20584.5 20931.0 21048.8 21971.9 20807.7 22026.0 22150.2 22175.2 22396.7 5842.9 6000.6 6372.3 6749.2 6822.3 6553.6 6731.0 6796.2 6801.0 6807.8 6528.5 6563.8 6576.4 6583.5 6790.3 6559.7 6688.2 6721.0 6749.6 6769.4 6607.2 6638.8 6646.7 6650.2 6651.8 24553.5 24851.4 25448.9 25528.4 25701.5 3122.4 3211.4 3234.2 3257.2 3287.1 16158.5 16230.2 16503.9 16983.2 17331.5 2209.5 2275.5 2286.1 2315.7 2339.7 70701.6 91198.5 92470.0 104226.5 119840.0 18335.8 18340.8 18644.2 18783.8 19150.0 32830.3 32899.3 32943.5 33072.2 33096.7 9793.1 9825.2 9871.6 10044.6 10139.9 8074.0 8147.5 8170.0 8339.6 8350.5 9354.6 9376.2 9570.7 9615.6 9743.5 3478.9 3634.8 3780.5 3815.4 3877.6 966.9 977.9 980.3 985.1 1010.1 20501.6 20512.7 20597.9 20677.5 21237.5 958.4 982.4 991.4 997.9 998.9 10979.3 11505.0 11711.4 11793.5 11888.2 541869.0 551893.0 555164.0 563148.0 565163.0 103449.5 104718.0 109365.0 114233.4 115322.4 1308.9 1323.7 1373.6 1380.8 1383.7 19205.0 19312.5 19448.7 19560.0 19588.1 47099.8 49978.0 50990.5 52176.0 52326.7 64531.7 65435.7 65457.0 67048.3 67159.0 12505.2 13074.0 13086.1 13119.1 13140.9 13611.2 14500.6 14553.0 14653.8 15048.5 12126.9 12135.2 12210.4 12292.6 12378.9 10934.4 11145.6 11151.9 11222.3 11283.0 12106.9 12270.5 12426.2 12450.4 12897.2 12957.5 12961.8 12974.8 13042.6 13130.9 12245.4 12292.9 12506.6 12640.0 12728.6 05:03:52 INFO - PROCESS | 14809 | 05:03:52 INFO - PROCESS | 14809 | [#3] mootools.html Cycles:180 Average:6907.58 Median:2462.56 stddev:4282.12 (173.9%) stddev-sans-first:4275.09 05:03:52 INFO - PROCESS | 14809 | Values: 1534.2 1539.4 1541.5 1559.5 1567.2 10370.8 11008.3 11009.1 11029.9 11031.3 10634.8 10751.6 10903.3 10931.4 10935.7 2461.6 2494.8 2500.3 2500.4 2504.5 2420.5 2475.7 2529.6 2532.1 2533.9 2452.2 2463.5 2487.3 2493.6 2494.1 2329.6 2358.8 2364.6 2371.6 2426.6 2356.2 2380.0 2391.6 2392.6 2398.1 10995.8 11179.8 11198.5 11212.7 11214.8 5655.9 5833.6 5834.7 5835.3 5844.4 3331.7 3430.1 3471.3 3474.1 3528.5 1298.0 1332.8 1332.9 1378.5 1398.5 14116.3 14447.8 15572.7 15645.1 15760.3 4782.1 4846.6 4881.3 4949.6 4982.0 12294.8 12367.9 12368.6 12419.2 12423.7 5756.7 5769.2 5774.5 5779.8 5784.1 5422.0 5485.2 5485.6 5500.6 5562.3 3967.8 4033.4 4090.9 4106.5 4118.6 1087.2 1092.2 1092.6 1109.0 1111.9 989.6 1003.9 1008.4 1013.8 1022.5 6792.6 6883.9 7024.5 7080.7 7200.0 1056.3 1095.0 1103.7 1115.7 1121.8 4435.4 4491.0 4503.8 4549.8 4553.5 13387.0 13897.4 14223.2 14237.3 14261.4 13922.7 13962.7 13986.7 14012.3 14052.6 8878.2 10519.9 10559.7 10587.3 10674.9 5604.7 6792.8 6961.0 6991.8 7043.2 11980.6 12314.3 12603.7 12708.8 12874.8 12754.7 12891.7 13032.1 13098.3 13369.9 9478.8 9581.5 9633.5 9677.3 9749.9 10418.7 10469.3 10630.4 10685.0 10697.7 8799.3 8821.6 8853.9 8896.4 9028.2 8522.7 8668.7 8698.3 8884.4 8906.8 8467.6 8471.8 8494.2 8577.3 8580.8 5934.3 5936.1 5999.6 6022.3 6099.9 6170.9 6189.3 6218.1 6293.0 6343.5 05:03:52 INFO - PROCESS | 14809 | 05:03:52 INFO - PROCESS | 14809 | [#4] prototype.html Cycles:180 Average:4739.52 Median:5277.85 stddev:1280.78 (24.3%) stddev-sans-first:1242.59 05:03:52 INFO - PROCESS | 14809 | Values: 416.5 417.0 421.0 425.3 431.1 5274.3 5304.1 5308.7 5325.7 5328.5 4980.0 5130.6 5161.7 5189.6 5190.6 4148.2 4170.8 4174.7 4180.7 4181.8 4167.6 4178.0 4184.6 4216.2 4223.7 4021.7 4150.6 4158.6 4168.7 4220.4 4090.3 4127.4 4146.6 4152.6 4159.5 3763.8 3789.8 3801.1 3815.6 3856.6 4820.9 5030.9 5146.3 5177.5 5183.6 4976.0 5030.8 5043.5 5053.3 5082.9 5427.2 5469.6 5482.5 5491.9 5498.6 4359.9 4442.3 4568.4 4589.2 4621.6 5367.7 5515.1 5631.2 5640.4 5678.5 4594.6 4658.7 4670.3 4702.0 4704.5 4761.3 4767.4 4770.5 4779.2 4780.9 4824.2 4895.4 4933.6 5015.6 5065.7 5447.4 5471.6 5478.5 5514.4 5521.5 1558.8 1647.6 1649.6 1655.0 1668.4 1252.2 1252.8 1267.9 1269.8 1299.4 5255.9 5380.1 5381.9 5476.5 5484.9 5566.3 5591.3 5592.3 5596.2 5629.2 5153.8 5281.4 5385.0 5403.4 5416.8 2915.9 2916.6 2943.1 2943.9 2948.7 5792.3 5814.8 5820.9 5846.6 5855.6 5497.4 5665.4 5681.4 5692.3 5700.9 5777.0 5785.8 5808.9 5810.4 5862.9 5261.5 5571.0 5592.9 5614.2 5640.0 5294.3 5415.5 5442.5 5515.7 5528.0 5673.2 5741.8 5814.9 5915.7 5917.9 4683.4 4684.6 4689.2 4725.6 4726.3 5393.7 5524.6 5559.8 5568.7 5600.2 5411.9 5442.0 5452.7 5463.3 5500.8 5449.8 5455.1 5474.6 5491.7 5530.6 5173.6 5489.7 5553.9 5557.1 5561.5 5494.3 5527.9 5570.7 5581.9 5634.7 5136.5 5325.2 5372.1 5448.6 5480.5 05:03:52 INFO - PROCESS | 14809 | 05:03:52 INFO - PROCESS | 14809 | [#5] yui.html Cycles:180 Average:18566.90 Median:22617.09 stddev:23075.81 (102.0%) stddev-sans-first:23102.06 05:03:52 INFO - PROCESS | 14809 | Values: 819.5 851.1 921.1 934.3 941.7 13882.4 15912.0 15929.1 16104.7 16224.4 14391.4 14505.5 15691.1 15919.0 15966.6 833.6 857.5 866.7 868.9 870.3 871.6 875.2 883.0 893.7 894.4 945.9 948.9 948.9 949.0 949.1 928.5 929.5 936.5 937.1 937.1 700.1 700.7 701.1 701.1 701.7 15369.7 15402.4 15413.6 15510.5 15694.6 14999.8 15300.2 15679.6 15691.1 16157.0 13551.8 13572.7 13665.1 13761.3 14051.4 3826.0 3850.8 3852.9 3923.0 4037.0 86705.0 87316.0 87703.1 89297.0 91085.5 12057.8 12063.5 12072.3 12189.9 12211.3 23465.9 23569.8 23672.9 23728.2 23963.5 8257.1 8341.2 8364.4 8535.1 8647.2 4502.1 4560.2 4642.7 4751.4 4787.6 3705.5 3802.3 3805.2 3805.7 3807.1 638.7 640.8 650.0 661.6 662.4 799.7 801.3 801.7 824.0 832.8 10889.5 12179.7 12216.8 12582.4 12798.0 667.5 681.6 688.7 706.8 714.7 5269.6 5630.1 5660.6 5722.0 5723.8 78080.2 78733.0 78779.0 79150.6 79989.0 59912.7 68428.0 69917.7 70181.3 70958.0 61297.4 61336.0 61372.0 61857.7 62229.4 11120.8 11424.8 11864.7 12047.2 12216.4 36095.0 41197.2 42798.7 43624.6 43748.0 55475.7 58099.0 59577.0 60084.7 60092.7 13221.7 13537.8 13714.0 13740.2 13783.9 16561.3 16675.3 16678.2 16901.2 16910.6 14716.3 14766.1 14919.9 14954.7 15676.5 15560.3 16116.8 16122.7 16404.8 16641.6 15519.3 15714.4 17043.8 17064.1 17169.9 10820.0 10921.9 11136.7 11356.6 11966.2 12710.8 12859.4 13006.0 13259.6 13404.8 05:03:52 INFO - PROCESS | 14809 | -------- Summary: end -------- 05:03:52 INFO - PROCESS | 14809 | 05:03:53 INFO - TEST-INFO | 14809: exit 0 05:03:53 INFO - TEST-OK | dromaeo_css | took 1116029ms 05:03:53 INFO - TEST-START | kraken 05:03:53 INFO - operating with platform_type : linux_ 05:03:53 INFO - Initialising browser for kraken test... 05:03:53 INFO - TEST-INFO | started process 15129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplbrIIQ/profile http://localhost:49902/getInfo.html) 05:03:57 INFO - PROCESS | 15129 | __metrics Screen width/height:1600/1200 05:03:57 INFO - PROCESS | 15129 | colorDepth:24 05:03:57 INFO - PROCESS | 15129 | Browser inner width/height: 1024/697 05:03:57 INFO - PROCESS | 15129 | __metrics 05:03:58 INFO - PROCESS | 15129 | 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:03:58 INFO - PROCESS | 15129 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:03:59 INFO - TEST-INFO | 15129: exit 0 05:03:59 INFO - Browser initialized. 05:03:59 INFO - Running cycle 1/1 for kraken test... 05:03:59 INFO - TEST-INFO | started process 15219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplbrIIQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:11 INFO - PROCESS | 15219 | RSS: Main: 139501568 05:04:11 INFO - PROCESS | 15219 | 05:04:13 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49902/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:14 INFO - PROCESS | 15219 | RSS: Main: 182919168 05:04:14 INFO - PROCESS | 15219 | 05:04:17 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49902/tests/kraken/driver.html?testName=audio-dft) 05:04:17 INFO - PROCESS | 15219 | RSS: Main: 173809664 05:04:17 INFO - PROCESS | 15219 | 05:04:20 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49902/tests/kraken/driver.html?testName=audio-fft) 05:04:21 INFO - PROCESS | 15219 | RSS: Main: 265318400 05:04:21 INFO - PROCESS | 15219 | 05:04:23 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49902/tests/kraken/driver.html?testName=audio-oscillator) 05:04:23 INFO - PROCESS | 15219 | RSS: Main: 171417600 05:04:23 INFO - PROCESS | 15219 | 05:04:26 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:26 INFO - PROCESS | 15219 | RSS: Main: 174534656 05:04:26 INFO - PROCESS | 15219 | 05:04:29 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49902/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:30 INFO - PROCESS | 15219 | RSS: Main: 211378176 05:04:30 INFO - PROCESS | 15219 | 05:04:33 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49902/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:34 INFO - PROCESS | 15219 | RSS: Main: 211824640 05:04:34 INFO - PROCESS | 15219 | 05:04:36 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49902/tests/kraken/driver.html?testName=json-parse-financial) 05:04:37 INFO - PROCESS | 15219 | RSS: Main: 210980864 05:04:37 INFO - PROCESS | 15219 | 05:04:38 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:39 INFO - PROCESS | 15219 | RSS: Main: 172752896 05:04:39 INFO - PROCESS | 15219 | 05:04:41 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49902/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:04:41 INFO - PROCESS | 15219 | RSS: Main: 180019200 05:04:41 INFO - PROCESS | 15219 | 05:04:43 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:04:44 INFO - PROCESS | 15219 | RSS: Main: 189956096 05:04:44 INFO - PROCESS | 15219 | 05:04:46 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:04:47 INFO - PROCESS | 15219 | RSS: Main: 198676480 05:04:47 INFO - PROCESS | 15219 | 05:04:50 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:04:50 INFO - PROCESS | 15219 | RSS: Main: 195002368 05:04:50 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:49902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49902/tests/kraken/driver.html?testName=ai-astar) 05:04:52 INFO - PROCESS | 15219 | RSS: Main: 245858304 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | __start_tp_report 05:04:52 INFO - PROCESS | 15219 | _x_x_mozilla_page_load 05:04:52 INFO - PROCESS | 15219 | _x_x_mozilla_page_load_details 05:04:52 INFO - PROCESS | 15219 | |i|pagename|runs| 05:04:52 INFO - PROCESS | 15219 | |0;ai-astar;104;112;111;113;113;112;112;111;111;110 05:04:52 INFO - PROCESS | 15219 | |1;audio-beat-detection;137;114;115;145;121;120;116;114;131;121 05:04:52 INFO - PROCESS | 15219 | |2;audio-dft;162;161;160;161;159;160;160;160;159;161 05:04:52 INFO - PROCESS | 15219 | |3;audio-fft;76;75;74;109;76;76;76;76;99;75 05:04:52 INFO - PROCESS | 15219 | |4;audio-oscillator;81;80;103;83;84;82;91;81;81;93 05:04:52 INFO - PROCESS | 15219 | |5;imaging-gaussian-blur;113;114;113;112;112;112;114;113;113;112 05:04:52 INFO - PROCESS | 15219 | |6;imaging-darkroom;146;145;145;146;146;146;146;146;146;146 05:04:52 INFO - PROCESS | 15219 | |7;imaging-desaturate;97;95;94;94;94;93;94;94;94;94 05:04:52 INFO - PROCESS | 15219 | |8;json-parse-financial;54;54;54;53;54;54;56;54;53;54 05:04:52 INFO - PROCESS | 15219 | |9;json-stringify-tinderbox;53;53;52;53;53;53;52;54;53;53 05:04:52 INFO - PROCESS | 15219 | |10;stanford-crypto-aes;84;79;75;81;78;84;76;84;85;83 05:04:52 INFO - PROCESS | 15219 | |11;stanford-crypto-ccm;121;129;123;119;119;123;120;130;158;117 05:04:52 INFO - PROCESS | 15219 | |12;stanford-crypto-pbkdf2;161;166;160;160;162;159;159;159;169;164 05:04:52 INFO - PROCESS | 15219 | |13;stanford-crypto-sha256-iterative;61;64;60;59;60;59;59;58;58;58 05:04:52 INFO - PROCESS | 15219 | __end_tp_report 05:04:52 INFO - PROCESS | 15219 | __start_cc_report 05:04:52 INFO - PROCESS | 15219 | _x_x_mozilla_cycle_collect,1699 05:04:52 INFO - PROCESS | 15219 | __end_cc_report 05:04:52 INFO - PROCESS | 15219 | __startTimestamp1490616292855__endTimestamp 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | ------- Summary: start ------- 05:04:52 INFO - PROCESS | 15219 | Number of tests: 14 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.60 (2.3%) stddev-sans-first:1.00 05:04:52 INFO - PROCESS | 15219 | Values: 104.0 112.0 111.0 113.0 113.0 112.0 112.0 111.0 111.0 110.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#1] audio-beat-detection Cycles:10 Average:123.40 Median:121.00 stddev:10.72 (8.9%) stddev-sans-first:10.18 05:04:52 INFO - PROCESS | 15219 | Values: 137.0 114.0 115.0 145.0 121.0 120.0 116.0 114.0 131.0 121.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 05:04:52 INFO - PROCESS | 15219 | Values: 162.0 161.0 160.0 161.0 159.0 160.0 160.0 160.0 159.0 161.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:12.26 (16.1%) stddev-sans-first:12.86 05:04:52 INFO - PROCESS | 15219 | Values: 76.0 75.0 74.0 109.0 76.0 76.0 76.0 76.0 99.0 75.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:82.50 stddev:7.48 (9.1%) stddev-sans-first:7.72 05:04:52 INFO - PROCESS | 15219 | Values: 81.0 80.0 103.0 83.0 84.0 82.0 91.0 81.0 81.0 93.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 05:04:52 INFO - PROCESS | 15219 | Values: 113.0 114.0 113.0 112.0 112.0 112.0 114.0 113.0 113.0 112.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:04:52 INFO - PROCESS | 15219 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.06 (1.1%) stddev-sans-first:0.50 05:04:52 INFO - PROCESS | 15219 | Values: 97.0 95.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 05:04:52 INFO - PROCESS | 15219 | Values: 54.0 54.0 54.0 53.0 54.0 54.0 56.0 54.0 53.0 54.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#9] json-stringify-tinderbox Cycles:10 Average:52.90 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 05:04:52 INFO - PROCESS | 15219 | Values: 53.0 53.0 52.0 53.0 53.0 53.0 52.0 54.0 53.0 53.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:83.50 stddev:3.67 (4.4%) stddev-sans-first:3.71 05:04:52 INFO - PROCESS | 15219 | Values: 84.0 79.0 75.0 81.0 78.0 84.0 76.0 84.0 85.0 83.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:123.00 stddev:12.05 (9.8%) stddev-sans-first:12.65 05:04:52 INFO - PROCESS | 15219 | Values: 121.0 129.0 123.0 119.0 119.0 123.0 120.0 130.0 158.0 117.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:161.50 stddev:3.41 (2.1%) stddev-sans-first:3.61 05:04:52 INFO - PROCESS | 15219 | Values: 161.0 166.0 160.0 160.0 162.0 159.0 159.0 159.0 169.0 164.0 05:04:52 INFO - PROCESS | 15219 | 05:04:52 INFO - PROCESS | 15219 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:59.50 stddev:1.84 (3.1%) stddev-sans-first:1.88 05:04:52 INFO - PROCESS | 15219 | Values: 61.0 64.0 60.0 59.0 60.0 59.0 59.0 58.0 58.0 58.0 05:04:52 INFO - PROCESS | 15219 | -------- Summary: end -------- 05:04:52 INFO - PROCESS | 15219 | 05:04:53 INFO - TEST-INFO | 15219: exit 0 05:04:53 INFO - TEST-OK | kraken | took 60548ms 05:04:53 INFO - SUITE-END | took 1176s 05:04:54 INFO - Completed test suite (00:19:36) 05:04:54 INFO - javascript benchmark 05:04:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7742.882560169745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.7805092668973, 3399.9320013599745, 3407.8296085195734, 3437.329720704464, 3453.5855697316324, 5668.404817494161, 5728.112142617901, 5743.626664266831, 5747.224124743164, 5757.251557297551, 5739.282589676291, 5781.277340332458, 5784.103463963082, 5795.855103622401, 5798.65208087515, 5097.362829646304, 5139.126348520742, 5170.043541944733, 5175.922361164586, 5229.2417599448245, 5049.772760225798, 5233.1103712368795, 5234.136367499358, 5238.978399212155, 5268.736563171845, 5057.393112826466, 5123.513266239701, 5161.870953226162, 5225.634205605609, 5235.083860324447, 5208.713520756357, 5243.2659427680155, 5247.737613119329, 5253.0544501989625, 5258.947410525884, 5096.745162741848, 5139.126348520723, 5214.113600687854, 5217.50433708797, 5236.136037553837, 5569.777208911639, 5582.972085139589, 5604.299462567179, 5605.439456054402, 5615.550755939515, 6027.397260273981, 6027.487663548603, 6059.242594675666, 6061.757529698807, 6090.177825993478, 6122.295935967376, 6124.203853499017, 6135.3864613538735, 6136.20229370179, 6141.785037523665, 5556.138798486241, 5561.360443548962, 5722.313322401297, 5736.541076713853, 5763.7982670606325, 6274.6548939807835, 6287.905681414691, 6292.874142517216, 6293.402126797947, 6293.842653933688, 6002.699865006733, 6048.0625503047095, 6079.544034197453, 6087.634741915499, 6102.389761023862, 5992.370801065913, 6043.244594425697, 6045.667488288186, 6187.84530386744, 6191.226096737908, 6077.301110372364, 6115.908261376083, 6117.082437634302, 6127.877442451215, 6129.356417576179, 5979.611325263844, 6026.6986650667295, 6034.034554471351, 6108.144859719643, 6120.60216085953, 4621.329907163443, 4659.0, 4688.343631891538, 4692.554207350297, 4716.221823399169, 4185.100203456272, 4191.140816132685, 4225.72532785368, 4233.936490952638, 4241.97879010603, 5738.942610573924, 5801.9419805802245, 5891.41085891416, 5948.256467941507, 6018.247719035121, 6173.290071641819, 6209.410106040009, 6209.813705588839, 6209.875802484015, 6210.285817131088, 6006.339302676702, 6009.369016253318, 6010.909836352458, 6013.188219590387, 6046.939530604637, 5113.948860511422, 5143.408508021551, 5210.426853046162, 5248.107821670325, 5276.472352764769, 6443.6455994920725, 6451.741930322734, 6457.257415397102, 6460.192475940507, 6461.386168314003, 6168.9691551541955, 6204.751809927552, 6213.1922850029205, 6218.098375735583, 6220.160278362363, 6208.658523781235, 6225.066240063846, 6333.524985626189, 6403.199600049994, 6476.06097115925, 6008.309044459943, 6050.6369617823075, 6079.392060794062, 6092.025275955826, 6101.60339577926, 6186.298058916677, 6205.968970155121, 6219.751209951552, 6219.937800621936, 6225.346338634378, 5816.563757718272, 5919.585629005928, 6070.368800339233, 6073.058675905242, 6115.6330620162935, 5990.8502287441415, 5993.0, 6039.15451836752, 6098.725557349841, 6121.4490695837585, 6058.666773327333, 6064.0, 6064.514838812796, 6077.331493535796, 6077.453029227391, 5882.294124705063, 5883.823485295448, 5936.643801371932, 5946.0, 6131.724072416841, 5871.324797648325, 5912.911306330495, 5937.406259374028, 5963.314218864886, 5974.193483879794], "value": 5665.765185074115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.5304287862966, 819.7540737778666, 830.4809494066207, 907.3285768531281, 908.8000639859229, 30270.848645756767, 42482.575174248246, 42829.0, 42991.35512967308, 43295.567044329546, 37970.81014594923, 38263.42604860929, 38390.0, 41316.380254296135, 41356.0, 7593.886091708629, 8968.596413161424, 9097.317701172406, 9105.317101217403, 9113.772155696128, 7567.924320756777, 10526.0, 10681.679549613486, 10704.946475267652, 10734.087602553793, 10835.83746243807, 10849.077828384598, 10855.837162442569, 10860.13118950482, 10860.402677852715, 10742.0, 10762.623308184255, 10773.83839242412, 10777.78444431111, 10822.134229261641, 10601.257911946166, 10624.0, 10648.41433721145, 10654.73363165927, 10655.200859935458, 39841.40237896434, 39906.40140397896, 39919.401208981886, 40136.197276054605, 40150.397744033864, 4058.7767672777986, 4074.8166332515107, 4128.690348223895, 4195.601417865298, 4242.130363275552, 29875.0, 29909.0, 30198.396032079236, 30388.0, 30543.236419089477, 4019.095703466726, 4095.5494895561465, 4133.607307305801, 4145.564715704838, 4224.366345048236, 217220.0, 220947.0, 273873.0, 274371.0, 363677.9999999974, 45529.317060244124, 46105.0, 46127.53872461232, 46188.5381146191, 46195.307070393974, 47604.28593571099, 47723.5227647726, 47861.52138478571, 47923.0, 47990.28014579714, 15377.769333460006, 15620.453284135001, 15622.76565851513, 15624.76562851558, 15637.0, 10858.0, 10972.067374273116, 13668.794968075486, 13695.520656776966, 13710.38303276335, 11721.4139293035, 11808.114391420679, 12671.11302208855, 12845.0, 12975.09174357786, 5493.148561972901, 5497.9932324701995, 5503.477169668875, 5641.52047075995, 5684.317881854204, 1160.0951258018758, 1164.5923926625612, 1167.287954347847, 1186.9347185904685, 1196.9940150299192, 18243.81756182448, 18871.811281887007, 18995.715064274045, 19020.42938711841, 19356.90321548383, 1248.918820276679, 1252.987470125287, 1263.406199086428, 1285.8135570342247, 1306.5361796562274, 9742.951285243671, 9961.302708810459, 10001.199904007663, 10019.599216031276, 10050.59797608102, 320836.0, 321357.0, 321659.0, 323458.0, 324376.0, 56087.15869261965, 56176.0, 56238.0, 56302.0, 56316.15525767117, 1525.351725516651, 1529.17424590722, 1564.1788061267926, 1567.3730507796972, 1575.8030246219223, 18137.637247255247, 18165.818341816943, 18386.0, 18578.0, 18592.907035464737, 42372.15255694807, 42430.151396972506, 42472.15055698807, 42491.15017699567, 42574.57425425706, 278830.0, 279399.0, 280507.0, 280902.0, 281768.0, 32854.507182391804, 33158.502622461165, 33362.833185833915, 33459.49810752792, 33472.0, 35406.645933540334, 38147.618523815516, 49529.50470495249, 53346.73326633342, 53369.0, 37289.81355093207, 37398.786179746494, 37418.251634966604, 37623.059423514635, 38339.42490862695, 37210.441843372915, 37223.81388093042, 37584.624153758115, 37654.62345376511, 37846.62153378431, 42739.57260427356, 42887.57112428961, 42939.35590966076, 43054.56945430631, 43116.0, 35598.11004724903, 35809.82095089612, 35952.4607130888, 36272.45591316185, 36435.27129457449, 28296.43407131887, 28629.28426789347, 28657.856710716314, 28821.711782881903, 28954.710452896044], "value": 18488.866888522294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.7404118590624, 450.20089341418975, 453.96595255355845, 462.94676112247083, 463.45312531213165, 19907.60184796305, 20584.485387865294, 20931.0, 21048.789512104875, 21971.890140549294, 20807.68788468174, 22026.0, 22150.22474213403, 22175.223867164652, 22396.664050039264, 5842.941570584304, 6000.6099603525845, 6372.330905254951, 6749.156355455568, 6822.28366021568, 6553.6395498247575, 6730.966345168292, 6796.184457865038, 6801.0, 6807.795766127024, 6528.543001989862, 6563.835904102411, 6576.408123268905, 6583.473322134242, 6790.253072162058, 6559.737610495575, 6688.230853451867, 6720.95825147103, 6749.595024298558, 6769.3907548320885, 6607.207135143765, 6638.800835974928, 6646.667666616699, 6650.20197576294, 6651.76718814844, 24553.508929821302, 24851.378715532075, 25448.872755636105, 25528.361790955376, 25701.48597028049, 3122.437961167012, 3211.3577284542953, 3234.2237862912966, 3257.2062963403628, 3287.079617707046, 16158.515244542683, 16230.188490575423, 16503.91748041264, 16983.23575439096, 17331.480055598353, 2209.5139069404704, 2275.5335156293086, 2286.119843860126, 2315.710536182977, 2339.6841426407386, 70701.64649176772, 91198.5440072802, 92470.0, 104226.47886760518, 119840.0, 18335.816641833677, 18340.816591834177, 18644.16101275446, 18783.81216187848, 19150.0, 32830.34339313248, 32899.34201316008, 32943.50584741231, 33072.17319566982, 33096.66903330984, 9793.118619324152, 9825.213982881352, 9871.555779989918, 10044.648437304659, 10139.949300253451, 8074.0, 8147.511149331059, 8169.959150204211, 8339.583020848933, 8350.498970061815, 9354.625814967461, 9376.156145946761, 9570.665026724031, 9615.56729947154, 9743.464109474047, 3478.8519788469744, 3634.7819130852236, 3780.4896338994436, 3815.351390263662, 3877.592852750477, 966.9323147379756, 977.9364341317792, 980.3333733061444, 985.1330828870548, 1010.0555980158575, 20501.58996820085, 20512.692309615366, 20597.89701051485, 20677.483062923548, 21237.469063273234, 958.3866325551653, 982.4056445850158, 991.4299277915084, 997.8952210017989, 998.930074894765, 10979.341239525655, 11505.044142495795, 11711.355875426763, 11793.469293881795, 11888.227265227733, 541869.0, 551893.0, 555164.0, 563148.0, 565163.0, 103449.48275258575, 104718.0, 109365.0, 114233.42883285531, 115322.42338788252, 1308.9018323625576, 1323.715401188749, 1373.642852858264, 1380.7790753479394, 1383.7440073586217, 19205.0, 19312.517187069872, 19448.70826937569, 19560.0, 19588.11853466569, 47099.76450117728, 49978.0, 50990.490095098576, 52176.0, 52326.73836630792, 64531.677341612994, 65435.672821635584, 65457.0, 67048.32951670616, 67159.0, 12505.187162834387, 13074.0, 13086.14940028895, 13119.147255428366, 13140.868591313965, 13611.183329000292, 14500.564983050524, 14553.0, 14653.780193296896, 15048.473303434328, 12126.878731212575, 12135.150539462153, 12210.389480526115, 12292.631221063382, 12378.876211237772, 10934.398608076313, 11145.609903653332, 11151.888481115086, 11222.270552414067, 11282.984531392214, 12106.878931210575, 12270.509179632714, 12426.192297500995, 12450.439730212343, 12897.22616642967, 12957.481700731865, 12961.805572916603, 12974.805377919527, 13042.608721738363, 13130.868691312964, 12245.448954796877, 12292.877071229532, 12506.624801255977, 12640.0, 12728.554500592434], "value": 11326.802060625847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.156214082256, 1539.3688587679046, 1541.5067178502877, 1559.5009596928983, 1567.2242240091157, 10370.792584148321, 11008.339499630029, 11009.119270458365, 11029.889701102986, 11031.338119712824, 10634.840477392845, 10751.62369317074, 10903.29128606642, 10931.398773067498, 10935.671929842098, 2461.6307553866927, 2494.8004159667184, 2500.3124140861228, 2500.362407586063, 2504.511620234055, 2420.455397535558, 2475.7400472950353, 2529.620556916459, 2532.0757923357933, 2533.949321013579, 2452.1540068676277, 2463.4949835283724, 2487.32842132625, 2493.5885578879465, 2494.0546373828442, 2329.6156134237917, 2358.78770910618, 2364.5980183368697, 2371.6442533619925, 2426.5632186206476, 2356.15178535727, 2380.0479808076907, 2391.5575618510456, 2392.593259145932, 2398.136670798511, 10995.780084398348, 11179.776404471946, 11198.496067676973, 11212.66362009141, 11214.775704485864, 5655.886882262332, 5833.649981001154, 5834.708264586754, 5835.270591176103, 5844.415558444164, 3331.683490068464, 3430.125318043908, 3471.3230919970615, 3474.1314671332166, 3528.4707293905863, 1297.9805302920463, 1332.7734285171448, 1332.9000324975568, 1378.4692893236077, 1398.4615922869768, 14116.294185290695, 14447.78328325076, 15572.688546229125, 15645.061296322257, 15760.290786914617, 4782.139214941274, 4846.5638092571835, 4881.316615673809, 4949.554540091409, 4982.0, 12294.815577766341, 12367.876321236852, 12368.567100151451, 12419.19275247106, 12423.695511971293, 5756.683382413924, 5769.221155144001, 5774.538036957033, 5779.797707080232, 5784.132380142928, 5422.0, 5485.232067510552, 5485.6434331768305, 5500.58745594082, 5562.332520097614, 3967.781772002568, 4033.4353190553347, 4090.9386359204636, 4106.507219133723, 4118.629323360912, 1087.211771465681, 1092.153580974735, 1092.6066616018227, 1109.0295991007868, 1111.8610173728284, 989.6387818446216, 1003.9447830369254, 1008.3899240959261, 1013.8023085498257, 1022.5091955861228, 6792.558483698643, 6883.8967415488805, 7024.508284420143, 7080.6633810842295, 7199.964000179965, 1056.292284169593, 1095.0, 1103.7295862513736, 1115.7099154219961, 1121.786860496503, 4435.445569303837, 4490.955090449119, 4503.81984720614, 4549.818007279738, 4553.54464553542, 13387.0, 13897.444102235797, 14223.217723025125, 14237.288135593179, 14261.42954281817, 13922.721545569235, 13962.650933726738, 13986.650333741738, 14012.299385030708, 14052.648683782783, 8878.156575125482, 10519.94740026295, 10559.683209503728, 10587.311824731369, 10674.946625266824, 5604.663720176803, 6792.796216113525, 6960.965195173992, 6991.825204369931, 7043.190033146049, 11980.58067967617, 12314.26114433101, 12603.747925041265, 12708.809367859674, 12874.806877897026, 12754.68113297175, 12891.677708057374, 13032.087753857519, 13098.345082745634, 13369.866301336862, 9478.763030924281, 9581.520923953634, 9633.518324083909, 9677.322587419094, 9749.853752193865, 10418.68743937683, 10469.267151299337, 10630.362178269328, 10685.038346548848, 10697.679069627924, 8799.296056315607, 8821.558922054, 8853.867191991996, 8896.421732587361, 9028.232600229054, 8522.74431767048, 8668.739937801876, 8698.304135669005, 8884.422512536665, 8906.821863562822, 8467.57662116904, 8471.788205294917, 8494.150584941457, 8577.31381489467, 8580.828383432421, 5934.258217722785, 5936.139259807217, 5999.640021598718, 6022.307434645072, 6099.939000610115, 6170.876582468415, 6189.257289125334, 6218.06728990655, 6293.0, 6343.492520598434], "value": 5300.807166228013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.52724158080576, 416.9562195969423, 421.00024881811396, 425.2918890048068, 431.0731926358331, 5274.314339135907, 5304.143549757583, 5308.70802105884, 5325.707086110262, 5328.520433161015, 4979.975100124503, 5130.6152038597065, 5161.690298582088, 5189.6107791915665, 5190.558802501782, 4148.23257697327, 4170.791460426982, 4174.66602671787, 4180.707350485475, 4181.790910454481, 4167.562405947378, 4177.958220417802, 4184.644305234059, 4216.241076606209, 4223.746575205498, 4021.678265738734, 4150.564190759972, 4158.584141585848, 4168.666506679474, 4220.36694495825, 4090.2842002649713, 4127.390317776069, 4146.564610715862, 4152.647025002879, 4159.5216550096675, 3763.833211704353, 3789.810509474543, 3801.144742432958, 3815.561210460805, 3856.614338566149, 4820.879478013043, 5030.899382012376, 5146.30524879144, 5177.534021938006, 5183.585313174937, 4976.0, 5030.798768049273, 5043.52086551777, 5053.2818841594035, 5082.872928176788, 5427.240186373911, 5469.562435005229, 5482.479164479408, 5491.917621235684, 5498.5876059295715, 4359.934600980988, 4442.2892337225885, 4568.360429539867, 4589.173948689235, 4621.630269578459, 5367.684917195312, 5515.0697255960495, 5631.211630371751, 5640.351359593658, 5678.545716342683, 4594.632429405639, 4658.673892827537, 4670.252759558454, 4701.976490117528, 4704.529547045268, 4761.262004389325, 4767.380240568704, 4770.546798054179, 4779.211430114062, 4780.928286075712, 4824.204006338985, 4895.437024742129, 4933.5578888450445, 5015.623828212899, 5065.721385323843, 5447.428020057916, 5471.562275018068, 5478.534324582375, 5514.393416724157, 5521.503064724114, 1558.7739777732393, 1647.5963388969778, 1649.5628658405533, 1654.9751753723704, 1668.4077152610892, 1252.1860790486257, 1252.787026205529, 1267.8525934029717, 1269.7968325067945, 1299.3503248375812, 5255.868603284948, 5380.139177731622, 5381.865453363697, 5476.534494567926, 5484.890302193934, 5566.332040155207, 5591.329040515164, 5592.273004509388, 5596.209213051784, 5629.183768353566, 5153.819616313411, 5281.39263984639, 5384.973075134678, 5403.379361009907, 5416.756245968941, 2915.941681166365, 2916.562515622631, 2943.0876428306865, 2943.910753021396, 2948.719871612236, 5792.292932523189, 5814.778896431712, 5820.883582328414, 5846.590738648254, 5855.59010869235, 5497.39528651848, 5665.405132461115, 5681.375048744635, 5692.288463942007, 5700.857478562986, 5776.989026920356, 5785.797497087582, 5808.94191058084, 5810.448007439287, 5862.941370586324, 5261.5264626183825, 5571.0, 5592.916106258491, 5614.21401003868, 5640.0, 5294.2852714883, 5415.458454154553, 5442.510174084193, 5515.69663668486, 5527.972360138335, 5673.234113394639, 5741.822926300182, 5814.854628634318, 5915.704214789157, 5917.881642367042, 4683.367745354333, 4684.6486513510945, 4689.155951928686, 4725.645576581839, 4726.338312636165, 5393.6951273319, 5524.613277070727, 5559.776849093193, 5568.721563921868, 5600.243967064394, 5411.891762164656, 5442.0, 5452.727363631723, 5463.344398672185, 5500.8017423534375, 5449.782008719607, 5455.099908515051, 5474.562035037267, 5491.697956612425, 5530.6128570999645, 5173.586113110867, 5489.737360407208, 5553.916691249554, 5557.055300598827, 5561.499465048165, 5494.340679118532, 5527.8894422110525, 5570.749316280858, 5581.860453488695, 5634.7464364104535, 5136.5377116059735, 5325.201219817059, 5372.105223712777, 5448.56411487088, 5480.451954804487], "value": 4371.691756978716, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.4714409206058, 851.0808327006833, 921.143336696872, 934.3039435620464, 941.6798288581883, 13882.444702211911, 15912.0, 15929.123898185595, 16104.677906441864, 16224.351025958962, 14391.352389142488, 14505.492307769231, 15691.058536487819, 15919.044857308541, 15966.600834979103, 833.5582141465034, 857.498363457375, 866.7226487523994, 868.9087645797196, 870.316801310971, 871.6382701179003, 875.155474966657, 882.9646814127427, 893.6738090596917, 894.3962825093068, 945.9337846350758, 948.8766460360179, 948.928830337724, 949.0225068179751, 949.06991148674, 928.5496534180883, 929.4794914847707, 936.5317341329335, 937.0863408177041, 937.1097457415483, 700.0514303119302, 700.7442283566512, 701.0570782297801, 701.0780823217452, 701.6596950479013, 15369.692606147926, 15402.3839046438, 15413.614659633487, 15510.457134000257, 15694.607634809106, 14999.775003374958, 15300.234988250655, 15679.608009799733, 15691.058536487733, 16157.0, 13551.796723049063, 13572.728545429036, 13665.111767735065, 13761.31193440324, 14051.43794248229, 3825.980870095632, 3850.8074596270076, 3852.903677408059, 3923.019245188703, 4037.0, 86705.0, 87316.0, 87703.12296877077, 89297.0, 91085.54457227672, 12057.758844823054, 12063.517459301705, 12072.3360215189, 12189.878101219052, 12211.328376939176, 23465.86451738619, 23569.764302356758, 23672.88163559171, 23728.169514066925, 23963.52072958531, 8257.133001034925, 8341.249287564027, 8364.37267204962, 8535.146485351415, 8647.221750042401, 4502.144592527409, 4560.247559152769, 4642.744649044267, 4751.40607424072, 4787.569118779326, 3705.5368078990127, 3802.3155831950517, 3805.162864169878, 3805.6765174960437, 3807.124361396894, 638.6774678787183, 640.7917426836296, 650.0346984727676, 661.5699795133106, 662.3939095727452, 799.6681377228501, 801.317722476957, 801.7240527101496, 824.0482243009334, 832.8459235041537, 10889.455527223607, 12179.695507612381, 12216.816747748791, 12582.43379047945, 12798.0, 667.4893706314673, 681.6012632609879, 688.6900894597451, 706.8162277807807, 714.6926821466819, 5269.631125821155, 5630.0991841305195, 5660.575456840754, 5722.0, 5723.77104915807, 78080.2191978073, 78733.0, 78779.0, 79150.60424697955, 79989.0, 59912.70043649754, 68428.0, 69917.65041174761, 70181.2981870185, 70958.0, 61297.38702612917, 61336.0, 61372.0, 61857.69071154705, 62229.37770622236, 11120.777584448104, 11424.771504570028, 11864.703382415164, 12047.156699030984, 12216.389180541115, 36095.0, 41197.1760564793, 42798.71603851889, 43624.56375436332, 43748.0, 55475.72262138664, 58099.0, 59577.0, 60084.69957650184, 60092.69953650204, 13221.669458263621, 13537.796933045815, 13714.0, 13740.175589464665, 13783.862161378658, 16561.25474353633, 16675.332986680398, 16678.166091695122, 16901.239444224793, 16910.57723556921, 14716.337764800395, 14766.114033158045, 14919.85080149228, 14954.700905981601, 15676.451324203597, 15560.28432116609, 16116.838831611534, 16122.677546448771, 16404.753928691316, 16641.583960401087, 15519.301631426388, 15714.371425142866, 17043.82956170472, 17064.14679266007, 17169.91415042917, 10820.0, 10921.890781092405, 11136.665900023012, 11356.602518911799, 11966.162368634112, 12710.809337859755, 12859.421326040538, 13006.0, 13259.602211933658, 13404.798928016282], "value": 7836.275316011472, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1449.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 113.0, 113.0, 112.0, 112.0, 111.0, 111.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 114.0, 115.0, 145.0, 121.0, 120.0, 116.0, 114.0, 131.0, 121.0], "value": 123.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 159.0, 160.0, 160.0, 160.0, 159.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 109.0, 76.0, 76.0, 76.0, 76.0, 99.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 103.0, 83.0, 84.0, 82.0, 91.0, 81.0, 81.0, 93.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 112.0, 112.0, 112.0, 114.0, 113.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 56.0, 54.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 52.0, 54.0, 53.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 75.0, 81.0, 78.0, 84.0, 76.0, 84.0, 85.0, 83.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 129.0, 123.0, 119.0, 119.0, 123.0, 120.0, 130.0, 158.0, 117.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 160.0, 160.0, 162.0, 159.0, 159.0, 159.0, 169.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 60.0, 59.0, 60.0, 59.0, 59.0, 58.0, 58.0, 58.0], "value": 59.6, "unit": "score"}]}]} 05:04:54 INFO - Return code: 0 05:04:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:04:54 ERROR - # TBPL SUCCESS # 05:04:54 INFO - Running post-action listener: _resource_record_post_action 05:04:54 INFO - [mozharness: 2017-03-27 12:04:54.160512Z] Finished run-tests step (success) 05:04:54 INFO - Running post-run listener: _resource_record_post_run 05:04:54 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 363708416; Read time: 0; Write time: 515040 05:04:54 INFO - TinderboxPrint: CPU usage
13.2% 05:04:54 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:04:54 INFO - TinderboxPrint: I/O write bytes / time
363,708,416 / 515,040 05:04:54 INFO - TinderboxPrint: CPU idle
8,265.5 (86.8%) 05:04:54 INFO - TinderboxPrint: CPU user
1,203.9 (12.6%) 05:04:54 INFO - TinderboxPrint: Swap in / out
0 / 0 05:04:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110985216; Read time: 0; Write time: 245092 05:04:54 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 252723200; Read time: 0; Write time: 269948 05:04:54 INFO - Running post-run listener: _upload_blobber_files 05:04:54 INFO - Blob upload gear active. 05:04:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:04:54 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:04:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:04:55 INFO - (blobuploader) - INFO - Open directory for files ... 05:04:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:04:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:04:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:56 INFO - (blobuploader) - INFO - Done attempting. 05:04:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:04:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:57 INFO - (blobuploader) - INFO - Done attempting. 05:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:05:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:01 INFO - (blobuploader) - INFO - Done attempting. 05:05:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:05:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:05:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:02 INFO - (blobuploader) - INFO - Done attempting. 05:05:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:02 INFO - Return code: 0 05:05:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/285bd7b26e8e09bc3986aaa4c1fdb03a9ec39cc7e26ab1c49864c8e65d15ef4ab275008b8361fe06ccfa0222640fa8d0d51def424046d18bdf62619618c3753c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5c710964f60ef71b428a6465129f5db4218533cb74d923a7a35e4da35a83bdedc041088ba4810a1e1513bcbf9fe766b4ba0f0dc34c83916f90e8cea986ec819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba57b1dc3c9ac17d2bf4e9d7473db41c996f477ff300b730f43c8f78fb772e6316ff2f3a730c6eefc4cb70dcb0f9b7b5c31ba5aa7a07706f38409b626062b228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3aeb5410b7558ca6fd9548291db05eef1605de220188ee0a09e3c51cd2e1f74a518d990e14475ee92aa3e09939e56022cdf3bdd64d4462d779a409c6d943c2"} 05:05:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:02 INFO - Contents: 05:05:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/285bd7b26e8e09bc3986aaa4c1fdb03a9ec39cc7e26ab1c49864c8e65d15ef4ab275008b8361fe06ccfa0222640fa8d0d51def424046d18bdf62619618c3753c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5c710964f60ef71b428a6465129f5db4218533cb74d923a7a35e4da35a83bdedc041088ba4810a1e1513bcbf9fe766b4ba0f0dc34c83916f90e8cea986ec819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba57b1dc3c9ac17d2bf4e9d7473db41c996f477ff300b730f43c8f78fb772e6316ff2f3a730c6eefc4cb70dcb0f9b7b5c31ba5aa7a07706f38409b626062b228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3aeb5410b7558ca6fd9548291db05eef1605de220188ee0a09e3c51cd2e1f74a518d990e14475ee92aa3e09939e56022cdf3bdd64d4462d779a409c6d943c2"} 05:05:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:02 INFO - Copying logs to upload dir... 05:05:02 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.817455 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-27 05:05:01.133365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 05:05:01.136663) ========= 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=ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/285bd7b26e8e09bc3986aaa4c1fdb03a9ec39cc7e26ab1c49864c8e65d15ef4ab275008b8361fe06ccfa0222640fa8d0d51def424046d18bdf62619618c3753c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5c710964f60ef71b428a6465129f5db4218533cb74d923a7a35e4da35a83bdedc041088ba4810a1e1513bcbf9fe766b4ba0f0dc34c83916f90e8cea986ec819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba57b1dc3c9ac17d2bf4e9d7473db41c996f477ff300b730f43c8f78fb772e6316ff2f3a730c6eefc4cb70dcb0f9b7b5c31ba5aa7a07706f38409b626062b228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3aeb5410b7558ca6fd9548291db05eef1605de220188ee0a09e3c51cd2e1f74a518d990e14475ee92aa3e09939e56022cdf3bdd64d4462d779a409c6d943c2"} build_url:https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/SFUy3Jd2TcWvRvXeXyQOvw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/285bd7b26e8e09bc3986aaa4c1fdb03a9ec39cc7e26ab1c49864c8e65d15ef4ab275008b8361fe06ccfa0222640fa8d0d51def424046d18bdf62619618c3753c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5c710964f60ef71b428a6465129f5db4218533cb74d923a7a35e4da35a83bdedc041088ba4810a1e1513bcbf9fe766b4ba0f0dc34c83916f90e8cea986ec819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba57b1dc3c9ac17d2bf4e9d7473db41c996f477ff300b730f43c8f78fb772e6316ff2f3a730c6eefc4cb70dcb0f9b7b5c31ba5aa7a07706f38409b626062b228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3aeb5410b7558ca6fd9548291db05eef1605de220188ee0a09e3c51cd2e1f74a518d990e14475ee92aa3e09939e56022cdf3bdd64d4462d779a409c6d943c2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 05:05:01.162690) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:05:01.163052) ========= 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=ba164b0a7b0ec7655860e956000001c1-1490615045.981587-1673182835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:05:01.246325) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 05:05:01.246674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 05:05:01.247010) ========= ========= Total master_lag: 0.18 =========