builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1489939405.71 results: success (0) revision: 6a72a11138b9b41a02455a3cb32a8994a7f41934 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:25.705939) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:25.706386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:25.706967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:25.770187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:25.770526) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-19 09:03:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.7M=0.001s 2017-03-19 09:03:28 (20.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:25.887378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:25.887686) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020288 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:25.936738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:25.937034) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6a72a11138b9b41a02455a3cb32a8994a7f41934 --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 6a72a11138b9b41a02455a3cb32a8994a7f41934 --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=516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-19 09:03:28,366 truncating revision to first 12 chars 2017-03-19 09:03:28,366 Setting DEBUG logging. 2017-03-19 09:03:28,366 attempt 1/10 2017-03-19 09:03:28,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6a72a11138b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-19 09:03:29,013 unpacking tar archive at: mozilla-aurora-6a72a11138b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.933245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:26.886934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:26.887219) ========= script_repo_revision: 6a72a11138b9b41a02455a3cb32a8994a7f41934 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:26.887629) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:26.887931) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-19 09:03:26.898766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-19 09:03:26.899045) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:03:29 INFO - MultiFileLogger online at 20170319 09:03:29 in /builds/slave/test 09:03:29 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 09:03:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:03:29 INFO - {'append_to_log': False, 09:03:29 INFO - 'base_work_dir': '/builds/slave/test', 09:03:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:03:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:03:29 INFO - 'branch': 'Mozilla-Aurora', 09:03:29 INFO - 'buildbot_json_path': 'buildprops.json', 09:03:29 INFO - 'config_files': ('talos/linux_config.py',), 09:03:29 INFO - 'default_actions': ('clobber', 09:03:29 INFO - 'read-buildbot-config', 09:03:29 INFO - 'download-and-extract', 09:03:29 INFO - 'populate-webroot', 09:03:29 INFO - 'create-virtualenv', 09:03:29 INFO - 'install', 09:03:29 INFO - 'run-tests'), 09:03:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:03:29 INFO - 'download_minidump_stackwalk': True, 09:03:29 INFO - 'download_symbols': 'ondemand', 09:03:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:03:29 INFO - 'tooltool.py': '/tools/tooltool.py', 09:03:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:03:29 INFO - '/tools/misc-python/virtualenv.py')}, 09:03:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:03:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:03:29 INFO - 'gecko_profile': False, 09:03:29 INFO - 'gecko_profile_interval': 0, 09:03:29 INFO - 'installer_path': 'installer.exe', 09:03:29 INFO - 'log_level': 'info', 09:03:29 INFO - 'log_name': 'talos', 09:03:29 INFO - 'log_to_console': True, 09:03:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:03:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:03:29 INFO - 'opt_config_files': (), 09:03:29 INFO - 'pip_index': False, 09:03:29 INFO - 'suite': 'dromaeojs', 09:03:29 INFO - 'system_bits': '32', 09:03:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:03:29 INFO - 'title': 'talos-linux64-ix-061', 09:03:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:03:29 INFO - 'use_talos_json': True, 09:03:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:03:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:03:29 INFO - 'work_dir': 'build'} 09:03:29 INFO - [mozharness: 2017-03-19 16:03:29.427941Z] Running clobber step. 09:03:29 INFO - Running pre-action listener: _resource_record_pre_action 09:03:29 INFO - Running main action method: clobber 09:03:29 INFO - rmtree: /builds/slave/test/build 09:03:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:03:30 INFO - Running post-action listener: _resource_record_post_action 09:03:30 INFO - [mozharness: 2017-03-19 16:03:30.861928Z] Finished clobber step (success) 09:03:30 INFO - [mozharness: 2017-03-19 16:03:30.862027Z] Running read-buildbot-config step. 09:03:30 INFO - Running pre-action listener: _resource_record_pre_action 09:03:30 INFO - Running main action method: read_buildbot_config 09:03:30 INFO - Using buildbot properties: 09:03:30 INFO - { 09:03:30 INFO - "project": "", 09:03:30 INFO - "product": "firefox", 09:03:30 INFO - "who": "ffxbld@noreply.mozilla.org", 09:03:30 INFO - "installer_path": "public/build/target.tar.bz2", 09:03:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:03:30 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:03:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:03:30 INFO - "stage_platform": "linux64-pgo", 09:03:30 INFO - "basedir": "/builds/slave/test", 09:03:30 INFO - "buildnumber": 797, 09:03:30 INFO - "platform": "ubuntu64_hw", 09:03:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:03:30 INFO - "slavebuilddir": "test", 09:03:30 INFO - "taskId": "cav0qyxSSIaAMg4xZG5SsA", 09:03:30 INFO - "branch": "mozilla-aurora", 09:03:30 INFO - "script_repo_revision": "production", 09:03:30 INFO - "revision": "6a72a11138b9b41a02455a3cb32a8994a7f41934", 09:03:30 INFO - "slavename": "talos-linux64-ix-061", 09:03:30 INFO - "repo_path": "releases/mozilla-aurora" 09:03:30 INFO - } 09:03:30 INFO - Finding installer, test and symbols from parent task. 09:03:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cav0qyxSSIaAMg4xZG5SsA'}, attempt #1 09:03:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cav0qyxSSIaAMg4xZG5SsA'}, attempt #1 09:03:31 INFO - Task dependencies: P8MLHpSRRHK0mVz6ssH0uA 09:03:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA'}, attempt #1 09:03:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.tar.bz2 09:03:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/test_packages.json 09:03:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.crashreporter-symbols.zip 09:03:32 INFO - Running post-action listener: _resource_record_post_action 09:03:32 INFO - [mozharness: 2017-03-19 16:03:32.274118Z] Finished read-buildbot-config step (success) 09:03:32 INFO - [mozharness: 2017-03-19 16:03:32.274336Z] Running download-and-extract step. 09:03:32 INFO - Running pre-action listener: _resource_record_pre_action 09:03:32 INFO - Running main action method: download_and_extract 09:03:32 INFO - mkdir: /builds/slave/test/build/tests 09:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:32 INFO - trying https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.test_packages.json 09:03:32 INFO - Downloading https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:03:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:03:32 INFO - Downloaded 896 bytes. 09:03:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:03:32 INFO - Using the following test package requirements: 09:03:32 INFO - {u'common': [u'target.common.tests.zip'], 09:03:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:03:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:03:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:03:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:03:32 INFO - u'mozbase': [u'target.common.tests.zip'], 09:03:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:03:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:03:32 INFO - u'web-platform': [u'target.common.tests.zip', 09:03:32 INFO - u'target.web-platform.tests.zip'], 09:03:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:03:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:03:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.common.tests.zip 09:03:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:03:32 INFO - Fetch https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.common.tests.zip into memory 09:03:34 INFO - Expected file size: 59532476 09:03:34 INFO - Obtained file size: 59532476 09:03:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:03:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.common.tests.zip 09:03:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:03:44 INFO - Fetch https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.common.tests.zip into memory 09:03:46 INFO - Expected file size: 59532476 09:03:46 INFO - Obtained file size: 59532476 09:03:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.talos.tests.zip 09:03:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:03:56 INFO - Fetch https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.talos.tests.zip into memory 09:03:58 INFO - Expected file size: 14404424 09:03:58 INFO - Obtained file size: 14404424 09:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:58 INFO - trying https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.tar.bz2 09:03:58 INFO - Downloading https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:03:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:04:01 INFO - Downloaded 66726233 bytes. 09:04:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.tar.bz2 09:04:01 INFO - mkdir: /builds/slave/test/properties 09:04:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:04:01 INFO - Writing to file /builds/slave/test/properties/build_url 09:04:01 INFO - Contents: 09:04:01 INFO - build_url:https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.tar.bz2 09:04:01 INFO - Running post-action listener: _resource_record_post_action 09:04:01 INFO - Running post-action listener: set_extra_try_arguments 09:04:01 INFO - [mozharness: 2017-03-19 16:04:01.277313Z] Finished download-and-extract step (success) 09:04:01 INFO - [mozharness: 2017-03-19 16:04:01.277454Z] Running populate-webroot step. 09:04:01 INFO - Running pre-action listener: _resource_record_pre_action 09:04:01 INFO - Running main action method: populate_webroot 09:04:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:01 INFO - '--tppagecycles', 09:04:01 INFO - '7'], 09:04:01 INFO - 'tests': ['tsvgm']}}, 09:04:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:04:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:04:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:04:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:04:01 INFO - 'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:04:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:04:01 INFO - 'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['damp', 'tps']}, 09:04:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:04:01 INFO - 'tests': ['damp', 'tps']}, 09:04:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['dromaeo_dom']}, 09:04:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['basic_compositor_video']}, 09:04:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:04:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['a11yr', 09:04:01 INFO - 'ts_paint', 09:04:01 INFO - 'tpaint', 09:04:01 INFO - 'sessionrestore', 09:04:01 INFO - 'sessionrestore_no_auto_restore', 09:04:01 INFO - 'tabpaint']}, 09:04:01 INFO - 'other-e10s': {'tests': ['a11yr', 09:04:01 INFO - 'ts_paint', 09:04:01 INFO - 'tpaint', 09:04:01 INFO - 'sessionrestore', 09:04:01 INFO - 'sessionrestore_no_auto_restore', 09:04:01 INFO - 'tabpaint']}, 09:04:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:04:01 INFO - 'ts_paint', 09:04:01 INFO - 'tpaint', 09:04:01 INFO - 'sessionrestore', 09:04:01 INFO - 'sessionrestore_no_auto_restore', 09:04:01 INFO - 'tabpaint']}, 09:04:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:04:01 INFO - 'ts_paint', 09:04:01 INFO - 'tpaint', 09:04:01 INFO - 'sessionrestore', 09:04:01 INFO - 'sessionrestore_no_auto_restore', 09:04:01 INFO - 'tabpaint']}, 09:04:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['a11yr', 09:04:01 INFO - 'ts_paint', 09:04:01 INFO - 'tpaint', 09:04:01 INFO - 'sessionrestore', 09:04:01 INFO - 'sessionrestore_no_auto_restore', 09:04:01 INFO - 'tabpaint']}, 09:04:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['a11yr', 09:04:01 INFO - 'ts_paint', 09:04:01 INFO - 'tpaint', 09:04:01 INFO - 'sessionrestore', 09:04:01 INFO - 'sessionrestore_no_auto_restore', 09:04:01 INFO - 'tabpaint']}, 09:04:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['tsvgx', 09:04:01 INFO - 'tsvgr_opacity', 09:04:01 INFO - 'tart', 09:04:01 INFO - 'tscrollx', 09:04:01 INFO - 'cart', 09:04:01 INFO - 'tsvg_static']}, 09:04:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:04:01 INFO - 'tsvgr_opacity', 09:04:01 INFO - 'tart', 09:04:01 INFO - 'tscrollx', 09:04:01 INFO - 'cart', 09:04:01 INFO - 'tsvg_static']}, 09:04:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:04:01 INFO - 'talos_options': ['--disable-e10s'], 09:04:01 INFO - 'tests': ['tp5o']}, 09:04:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:04:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:04:01 INFO - 'talos_options': ['--disable-e10s', 09:04:01 INFO - '--xperf_path', 09:04:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:01 INFO - 'tests': ['tp5n']}, 09:04:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:04:01 INFO - 'talos_options': ['--xperf_path', 09:04:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:01 INFO - 'tests': ['tp5n']}}, 09:04:01 INFO - 'talos.zip': {'path': '', 09:04:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:01 INFO - Running post-action listener: _resource_record_post_action 09:04:01 INFO - [mozharness: 2017-03-19 16:04:01.293037Z] Finished populate-webroot step (success) 09:04:01 INFO - [mozharness: 2017-03-19 16:04:01.293127Z] Running create-virtualenv step. 09:04:01 INFO - Running pre-action listener: _resource_record_pre_action 09:04:01 INFO - Running main action method: create_virtualenv 09:04:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:04:01 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 09:04:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:04:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:01 INFO - Using real prefix '/usr' 09:04:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:04:01 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:03 INFO - Installing pip.................done. 09:04:03 INFO - Return code: 0 09:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:04:04 INFO - Reading from file tmpfile_stdout 09:04:04 INFO - Output received: 09:04:04 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) 09:04:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:04:04 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')]} 09:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:04 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')]} 09:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:04 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 0x12af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', '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 09:04:04 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 09:04:04 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 09:04:04 INFO - Using env: {'DISPLAY': ':0', 09:04:04 INFO - 'HOME': '/home/cltbld', 09:04:04 INFO - 'LANG': 'en_US.UTF-8', 09:04:04 INFO - 'LANGUAGE': 'en_US:en', 09:04:04 INFO - 'LOGNAME': 'cltbld', 09:04:04 INFO - 'MAIL': '/var/mail/cltbld', 09:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:04 INFO - 'MOZ_NO_REMOTE': '1', 09:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:04 INFO - 'NO_EM_RESTART': '1', 09:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:04 INFO - 'PWD': '/builds/slave/test', 09:04:04 INFO - 'SHELL': '/bin/bash', 09:04:04 INFO - 'SHLVL': '1', 09:04:04 INFO - 'TERM': 'linux', 09:04:04 INFO - 'TMOUT': '86400', 09:04:04 INFO - 'USER': 'cltbld', 09:04:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:04 INFO - '_': '/tools/buildbot/bin/python'} 09:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:04 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 09:04:04 INFO - Cleaning up... 09:04:04 INFO - Return code: 0 09:04:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:04:04 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')]} 09:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:04 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')]} 09:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:04 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 0x12af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', '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 09:04:04 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 09:04:04 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 09:04:04 INFO - Using env: {'DISPLAY': ':0', 09:04:04 INFO - 'HOME': '/home/cltbld', 09:04:04 INFO - 'LANG': 'en_US.UTF-8', 09:04:04 INFO - 'LANGUAGE': 'en_US:en', 09:04:04 INFO - 'LOGNAME': 'cltbld', 09:04:04 INFO - 'MAIL': '/var/mail/cltbld', 09:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:04 INFO - 'MOZ_NO_REMOTE': '1', 09:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:04 INFO - 'NO_EM_RESTART': '1', 09:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:04 INFO - 'PWD': '/builds/slave/test', 09:04:04 INFO - 'SHELL': '/bin/bash', 09:04:04 INFO - 'SHLVL': '1', 09:04:04 INFO - 'TERM': 'linux', 09:04:04 INFO - 'TMOUT': '86400', 09:04:04 INFO - 'USER': 'cltbld', 09:04:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:04 INFO - '_': '/tools/buildbot/bin/python'} 09:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:04 INFO - Downloading/unpacking psutil>=3.1.1 09:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:06 INFO - Installing collected packages: psutil 09:04:06 INFO - Running setup.py install for psutil 09:04:06 INFO - building 'psutil._psutil_linux' extension 09:04:06 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 09:04:06 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 09:04:06 INFO - building 'psutil._psutil_posix' extension 09:04:06 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 09:04:07 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 09:04:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:07 INFO - Successfully installed psutil 09:04:07 INFO - Cleaning up... 09:04:07 INFO - Return code: 0 09:04:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:04:07 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')]} 09:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:07 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')]} 09:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:07 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 0x12af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', '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 09:04:07 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 09:04:07 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 09:04:07 INFO - Using env: {'DISPLAY': ':0', 09:04:07 INFO - 'HOME': '/home/cltbld', 09:04:07 INFO - 'LANG': 'en_US.UTF-8', 09:04:07 INFO - 'LANGUAGE': 'en_US:en', 09:04:07 INFO - 'LOGNAME': 'cltbld', 09:04:07 INFO - 'MAIL': '/var/mail/cltbld', 09:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:07 INFO - 'MOZ_NO_REMOTE': '1', 09:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:07 INFO - 'NO_EM_RESTART': '1', 09:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:07 INFO - 'PWD': '/builds/slave/test', 09:04:07 INFO - 'SHELL': '/bin/bash', 09:04:07 INFO - 'SHLVL': '1', 09:04:07 INFO - 'TERM': 'linux', 09:04:07 INFO - 'TMOUT': '86400', 09:04:07 INFO - 'USER': 'cltbld', 09:04:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:07 INFO - '_': '/tools/buildbot/bin/python'} 09:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:04:09 INFO - Installing collected packages: mozsystemmonitor 09:04:09 INFO - Running setup.py install for mozsystemmonitor 09:04:09 INFO - Successfully installed mozsystemmonitor 09:04:09 INFO - Cleaning up... 09:04:09 INFO - Return code: 0 09:04:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:04:09 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')]} 09:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:09 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')]} 09:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:09 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 0x12af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', '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 09:04:09 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 09:04:09 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 09:04:09 INFO - Using env: {'DISPLAY': ':0', 09:04:09 INFO - 'HOME': '/home/cltbld', 09:04:09 INFO - 'LANG': 'en_US.UTF-8', 09:04:09 INFO - 'LANGUAGE': 'en_US:en', 09:04:09 INFO - 'LOGNAME': 'cltbld', 09:04:09 INFO - 'MAIL': '/var/mail/cltbld', 09:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:09 INFO - 'MOZ_NO_REMOTE': '1', 09:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:09 INFO - 'NO_EM_RESTART': '1', 09:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:09 INFO - 'PWD': '/builds/slave/test', 09:04:09 INFO - 'SHELL': '/bin/bash', 09:04:09 INFO - 'SHLVL': '1', 09:04:09 INFO - 'TERM': 'linux', 09:04:09 INFO - 'TMOUT': '86400', 09:04:09 INFO - 'USER': 'cltbld', 09:04:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:09 INFO - '_': '/tools/buildbot/bin/python'} 09:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:09 INFO - Downloading/unpacking jsonschema==2.5.1 09:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:12 INFO - warning: no files found matching '*.txt' 09:04:12 INFO - no previously-included directories found matching 'build' 09:04:12 INFO - no previously-included directories found matching 'dist' 09:04:12 INFO - no previously-included directories found matching '.git*' 09:04:12 INFO - Installing collected packages: jsonschema, functools32 09:04:12 INFO - Running setup.py install for functools32 09:04:12 INFO - warning: no files found matching '*.txt' 09:04:12 INFO - no previously-included directories found matching 'build' 09:04:12 INFO - no previously-included directories found matching 'dist' 09:04:12 INFO - no previously-included directories found matching '.git*' 09:04:12 INFO - Successfully installed jsonschema functools32 09:04:12 INFO - Cleaning up... 09:04:12 INFO - Return code: 0 09:04:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:12 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 0x12af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', '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 09:04:12 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 09:04:12 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 09:04:12 INFO - Using env: {'DISPLAY': ':0', 09:04:12 INFO - 'HOME': '/home/cltbld', 09:04:12 INFO - 'LANG': 'en_US.UTF-8', 09:04:12 INFO - 'LANGUAGE': 'en_US:en', 09:04:12 INFO - 'LOGNAME': 'cltbld', 09:04:12 INFO - 'MAIL': '/var/mail/cltbld', 09:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:12 INFO - 'MOZ_NO_REMOTE': '1', 09:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:12 INFO - 'NO_EM_RESTART': '1', 09:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:12 INFO - 'PWD': '/builds/slave/test', 09:04:12 INFO - 'SHELL': '/bin/bash', 09:04:12 INFO - 'SHLVL': '1', 09:04:12 INFO - 'TERM': 'linux', 09:04:12 INFO - 'TMOUT': '86400', 09:04:12 INFO - 'USER': 'cltbld', 09:04:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:12 INFO - '_': '/tools/buildbot/bin/python'} 09:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:04:12 INFO - Cleaning up... 09:04:12 INFO - Return code: 0 09:04:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:12 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 0x12af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', '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 09:04:12 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 09:04:12 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 09:04:12 INFO - Using env: {'DISPLAY': ':0', 09:04:12 INFO - 'HOME': '/home/cltbld', 09:04:12 INFO - 'LANG': 'en_US.UTF-8', 09:04:12 INFO - 'LANGUAGE': 'en_US:en', 09:04:12 INFO - 'LOGNAME': 'cltbld', 09:04:12 INFO - 'MAIL': '/var/mail/cltbld', 09:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:12 INFO - 'MOZ_NO_REMOTE': '1', 09:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:12 INFO - 'NO_EM_RESTART': '1', 09:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:12 INFO - 'PWD': '/builds/slave/test', 09:04:12 INFO - 'SHELL': '/bin/bash', 09:04:12 INFO - 'SHLVL': '1', 09:04:12 INFO - 'TERM': 'linux', 09:04:12 INFO - 'TMOUT': '86400', 09:04:12 INFO - 'USER': 'cltbld', 09:04:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:12 INFO - '_': '/tools/buildbot/bin/python'} 09:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:12 INFO - Downloading/unpacking blobuploader==1.2.4 09:04:12 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 09:04:12 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 09:04:12 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 09:04:12 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 09:04:12 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 09:04:12 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 09:04:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:14 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 09:04:14 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 09:04:14 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 09:04:14 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 09:04:14 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 09:04:14 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 09:04:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:04:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:15 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 09:04:15 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 09:04:15 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 09:04:15 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 09:04:15 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 09:04:15 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 09:04:15 INFO - Downloading docopt-0.6.1.tar.gz 09:04:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:15 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:15 INFO - Running setup.py install for blobuploader 09:04:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:04:15 INFO - Running setup.py install for requests 09:04:16 INFO - Running setup.py install for docopt 09:04:16 INFO - Successfully installed blobuploader requests docopt 09:04:16 INFO - Cleaning up... 09:04:16 INFO - Return code: 0 09:04:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:16 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 0x12af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', '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 09:04:16 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 09:04:16 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 09:04:16 INFO - Using env: {'DISPLAY': ':0', 09:04:16 INFO - 'HOME': '/home/cltbld', 09:04:16 INFO - 'LANG': 'en_US.UTF-8', 09:04:16 INFO - 'LANGUAGE': 'en_US:en', 09:04:16 INFO - 'LOGNAME': 'cltbld', 09:04:16 INFO - 'MAIL': '/var/mail/cltbld', 09:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:16 INFO - 'MOZ_NO_REMOTE': '1', 09:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:16 INFO - 'NO_EM_RESTART': '1', 09:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:16 INFO - 'PWD': '/builds/slave/test', 09:04:16 INFO - 'SHELL': '/bin/bash', 09:04:16 INFO - 'SHLVL': '1', 09:04:16 INFO - 'TERM': 'linux', 09:04:16 INFO - 'TMOUT': '86400', 09:04:16 INFO - 'USER': 'cltbld', 09:04:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:16 INFO - '_': '/tools/buildbot/bin/python'} 09:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:16 INFO - Running setup.py (path:/tmp/pip-NTwiuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:16 INFO - Running setup.py (path:/tmp/pip-umkn22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:16 INFO - Running setup.py (path:/tmp/pip-SeL4n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:16 INFO - Running setup.py (path:/tmp/pip-WYWBO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:16 INFO - Running setup.py (path:/tmp/pip-VnUKB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:16 INFO - Running setup.py (path:/tmp/pip-RBk19m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:16 INFO - Running setup.py (path:/tmp/pip-V2eEeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:16 INFO - Running setup.py (path:/tmp/pip-X202rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:17 INFO - Running setup.py (path:/tmp/pip-P8gR5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:17 INFO - Running setup.py (path:/tmp/pip-hHKVab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:17 INFO - Running setup.py (path:/tmp/pip-zWlSB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:17 INFO - Running setup.py (path:/tmp/pip-IhVqzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:17 INFO - Running setup.py (path:/tmp/pip-SE5wk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:17 INFO - Running setup.py (path:/tmp/pip-rfBKxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:17 INFO - Running setup.py (path:/tmp/pip-QNou1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:17 INFO - Running setup.py (path:/tmp/pip-MW5UkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:17 INFO - Running setup.py (path:/tmp/pip-SsRZwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:17 INFO - Running setup.py install for manifestparser 09:04:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:04:17 INFO - Running setup.py install for mozcrash 09:04:17 INFO - Running setup.py install for mozdebug 09:04:17 INFO - Running setup.py install for mozdevice 09:04:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:04:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:04:18 INFO - Running setup.py install for mozfile 09:04:18 INFO - Running setup.py install for mozhttpd 09:04:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:04:18 INFO - Running setup.py install for mozinfo 09:04:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:04:18 INFO - Running setup.py install for mozInstall 09:04:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:04:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:04:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:04:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:04:18 INFO - Running setup.py install for mozleak 09:04:18 INFO - Running setup.py install for mozlog 09:04:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:04:18 INFO - Running setup.py install for moznetwork 09:04:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:04:18 INFO - Running setup.py install for mozprocess 09:04:18 INFO - Running setup.py install for mozprofile 09:04:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:04:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:04:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:04:19 INFO - Running setup.py install for mozrunner 09:04:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:04:19 INFO - Running setup.py install for mozscreenshot 09:04:19 INFO - Running setup.py install for moztest 09:04:19 INFO - Running setup.py install for mozversion 09:04:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:04:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:04:19 INFO - Cleaning up... 09:04:19 INFO - Return code: 0 09:04:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:19 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 0x12af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', '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 09:04:19 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 09:04:19 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 09:04:19 INFO - Using env: {'DISPLAY': ':0', 09:04:19 INFO - 'HOME': '/home/cltbld', 09:04:19 INFO - 'LANG': 'en_US.UTF-8', 09:04:19 INFO - 'LANGUAGE': 'en_US:en', 09:04:19 INFO - 'LOGNAME': 'cltbld', 09:04:19 INFO - 'MAIL': '/var/mail/cltbld', 09:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:19 INFO - 'MOZ_NO_REMOTE': '1', 09:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:19 INFO - 'NO_EM_RESTART': '1', 09:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:19 INFO - 'PWD': '/builds/slave/test', 09:04:19 INFO - 'SHELL': '/bin/bash', 09:04:19 INFO - 'SHLVL': '1', 09:04:19 INFO - 'TERM': 'linux', 09:04:19 INFO - 'TMOUT': '86400', 09:04:19 INFO - 'USER': 'cltbld', 09:04:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:19 INFO - '_': '/tools/buildbot/bin/python'} 09:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:19 INFO - Running setup.py (path:/tmp/pip-XGA93J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:19 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)) 09:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:19 INFO - Running setup.py (path:/tmp/pip-N2VrGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:19 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)) 09:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:19 INFO - Running setup.py (path:/tmp/pip-MobZkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:19 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)) 09:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:19 INFO - Running setup.py (path:/tmp/pip-afY7vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:19 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)) 09:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:19 INFO - Running setup.py (path:/tmp/pip-7TEO_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:20 INFO - Running setup.py (path:/tmp/pip-jVJ9Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:20 INFO - Running setup.py (path:/tmp/pip-Tx82hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:20 INFO - Running setup.py (path:/tmp/pip-OttIE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:20 INFO - Running setup.py (path:/tmp/pip-EbQ0tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:20 INFO - Running setup.py (path:/tmp/pip-dMcczA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:20 INFO - Running setup.py (path:/tmp/pip-fOq665-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:20 INFO - Running setup.py (path:/tmp/pip-qKfmYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:20 INFO - Running setup.py (path:/tmp/pip-R4J_t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:20 INFO - Running setup.py (path:/tmp/pip-tMO31m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:20 INFO - Running setup.py (path:/tmp/pip-yO7OQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:20 INFO - Running setup.py (path:/tmp/pip-nD0pH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:20 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)) 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:20 INFO - Running setup.py (path:/tmp/pip-iAQutr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:20 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)) 09:04:20 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)) 09:04:20 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)) 09:04:20 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)) 09:04:20 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)) 09:04:20 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)) 09:04:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:22 INFO - Downloading blessings-1.6.tar.gz 09:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:04:22 INFO - Installing collected packages: blessings 09:04:22 INFO - Running setup.py install for blessings 09:04:23 INFO - Successfully installed blessings 09:04:23 INFO - Cleaning up... 09:04:23 INFO - Return code: 0 09:04:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:04:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:23 INFO - Reading from file tmpfile_stdout 09:04:23 INFO - Current package versions: 09:04:23 INFO - argparse == 1.2.1 09:04:23 INFO - blessings == 1.6 09:04:23 INFO - blobuploader == 1.2.4 09:04:23 INFO - docopt == 0.6.1 09:04:23 INFO - functools32 == 3.2.3-2 09:04:23 INFO - jsonschema == 2.5.1 09:04:23 INFO - manifestparser == 1.1 09:04:23 INFO - mozInstall == 1.12 09:04:23 INFO - mozcrash == 1.0 09:04:23 INFO - mozdebug == 0.1 09:04:23 INFO - mozdevice == 0.49 09:04:23 INFO - mozfile == 1.2 09:04:23 INFO - mozhttpd == 0.7 09:04:23 INFO - mozinfo == 0.9 09:04:23 INFO - mozleak == 0.1 09:04:23 INFO - mozlog == 3.4 09:04:23 INFO - moznetwork == 0.27 09:04:23 INFO - mozprocess == 0.25 09:04:23 INFO - mozprofile == 0.28 09:04:23 INFO - mozrunner == 6.13 09:04:23 INFO - mozscreenshot == 0.1 09:04:23 INFO - mozsystemmonitor == 0.3 09:04:23 INFO - moztest == 0.8 09:04:23 INFO - mozversion == 1.4 09:04:23 INFO - psutil == 3.1.1 09:04:23 INFO - requests == 1.2.3 09:04:23 INFO - wsgiref == 0.1.2 09:04:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:23 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')]} 09:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:23 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')]} 09:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:23 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 0x12af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', '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 09:04:23 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 09:04:23 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 09:04:23 INFO - Using env: {'DISPLAY': ':0', 09:04:23 INFO - 'HOME': '/home/cltbld', 09:04:23 INFO - 'LANG': 'en_US.UTF-8', 09:04:23 INFO - 'LANGUAGE': 'en_US:en', 09:04:23 INFO - 'LOGNAME': 'cltbld', 09:04:23 INFO - 'MAIL': '/var/mail/cltbld', 09:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:23 INFO - 'MOZ_NO_REMOTE': '1', 09:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:23 INFO - 'NO_EM_RESTART': '1', 09:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:23 INFO - 'PWD': '/builds/slave/test', 09:04:23 INFO - 'SHELL': '/bin/bash', 09:04:23 INFO - 'SHLVL': '1', 09:04:23 INFO - 'TERM': 'linux', 09:04:23 INFO - 'TMOUT': '86400', 09:04:23 INFO - 'USER': 'cltbld', 09:04:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:23 INFO - '_': '/tools/buildbot/bin/python'} 09:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:23 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)) 09:04:23 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)) 09:04:23 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)) 09:04:23 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)) 09:04:23 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)) 09:04:23 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)) 09:04:23 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)) 09:04:23 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)) 09:04:23 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)) 09:04:23 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)) 09:04:23 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)) 09:04:23 INFO - Cleaning up... 09:04:23 INFO - Return code: 0 09:04:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:04:23 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')]} 09:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:23 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')]} 09:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:23 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 0x12af1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', '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 09:04:23 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 09:04:23 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 09:04:23 INFO - Using env: {'DISPLAY': ':0', 09:04:23 INFO - 'HOME': '/home/cltbld', 09:04:23 INFO - 'LANG': 'en_US.UTF-8', 09:04:23 INFO - 'LANGUAGE': 'en_US:en', 09:04:23 INFO - 'LOGNAME': 'cltbld', 09:04:23 INFO - 'MAIL': '/var/mail/cltbld', 09:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:23 INFO - 'MOZ_NO_REMOTE': '1', 09:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:23 INFO - 'NO_EM_RESTART': '1', 09:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:23 INFO - 'PWD': '/builds/slave/test', 09:04:23 INFO - 'SHELL': '/bin/bash', 09:04:23 INFO - 'SHLVL': '1', 09:04:23 INFO - 'TERM': 'linux', 09:04:23 INFO - 'TMOUT': '86400', 09:04:23 INFO - 'USER': 'cltbld', 09:04:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:23 INFO - '_': '/tools/buildbot/bin/python'} 09:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:04:23 INFO - Cleaning up... 09:04:23 INFO - Return code: 0 09:04:23 INFO - Running post-action listener: _resource_record_post_action 09:04:23 INFO - Running post-action listener: _start_resource_monitoring 09:04:23 INFO - Starting resource monitoring. 09:04:23 INFO - [mozharness: 2017-03-19 16:04:23.872111Z] Finished create-virtualenv step (success) 09:04:23 INFO - [mozharness: 2017-03-19 16:04:23.872584Z] Running install step. 09:04:23 INFO - Running pre-action listener: _resource_record_pre_action 09:04:23 INFO - Running main action method: install 09:04:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:24 INFO - Reading from file tmpfile_stdout 09:04:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:04:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:04:24 INFO - Reading from file tmpfile_stdout 09:04:24 INFO - Output received: 09:04:24 INFO - Usage: mozinstall [options] installer 09:04:24 INFO - Options: 09:04:24 INFO - -h, --help show this help message and exit 09:04:24 INFO - -d DEST, --destination=DEST 09:04:24 INFO - Directory to install application into. [default: 09:04:24 INFO - "/builds/slave/test"] 09:04:24 INFO - --app=APP Application being installed. [default: firefox] 09:04:24 INFO - mkdir: /builds/slave/test/build/application 09:04:24 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'] 09:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:04:40 INFO - Reading from file tmpfile_stdout 09:04:40 INFO - Output received: 09:04:40 INFO - /builds/slave/test/build/application/firefox/firefox 09:04:40 INFO - Running post-action listener: _resource_record_post_action 09:04:40 INFO - [mozharness: 2017-03-19 16:04:40.725404Z] Finished install step (success) 09:04:40 INFO - [mozharness: 2017-03-19 16:04:40.725679Z] Running run-tests step. 09:04:40 INFO - Running pre-action listener: _resource_record_pre_action 09:04:40 INFO - Running main action method: run_tests 09:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:04:40 INFO - Python 2.7.3 09:04:40 INFO - Return code: 0 09:04:40 INFO - grabbing minidump binary from tooltool 09:04: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')]} 09:04:40 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 0x154a290>, '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 0x154ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154b040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:04:40 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 09:04:40 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 09:04:40 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 09:04:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:04:40 INFO - Return code: 0 09:04:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:04:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:04:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:04:40 INFO - ENV: RUST_BACKTRACE is now 1 09:04:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:04:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:04:40 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/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:04:40 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/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 09:04:40 INFO - Using env: {'DISPLAY': ':0', 09:04:40 INFO - 'HOME': '/home/cltbld', 09:04:40 INFO - 'LANG': 'en_US.UTF-8', 09:04:40 INFO - 'LANGUAGE': 'en_US:en', 09:04:40 INFO - 'LOGNAME': 'cltbld', 09:04:40 INFO - 'MAIL': '/var/mail/cltbld', 09:04:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:04:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:40 INFO - 'MOZ_NO_REMOTE': '1', 09:04:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:40 INFO - 'NO_EM_RESTART': '1', 09:04:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:40 INFO - 'PWD': '/builds/slave/test', 09:04:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:04:40 INFO - 'RUST_BACKTRACE': '1', 09:04:40 INFO - 'SHELL': '/bin/bash', 09:04:40 INFO - 'SHLVL': '1', 09:04:40 INFO - 'TERM': 'linux', 09:04:40 INFO - 'TMOUT': '86400', 09:04:40 INFO - 'USER': 'cltbld', 09:04:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824', 09:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:40 INFO - '_': '/tools/buildbot/bin/python'} 09:04:40 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/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:04:41 INFO - mozversion application_buildid: 20170319150902 09:04:41 INFO - mozversion application_changeset: 6a72a11138b9b41a02455a3cb32a8994a7f41934 09:04:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:04:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:04:41 INFO - mozversion application_name: Firefox 09:04:41 INFO - mozversion application_remotingname: firefox-dev 09:04:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:04:41 INFO - mozversion application_vendor: Mozilla 09:04:41 INFO - mozversion application_version: 54.0a2 09:04:41 INFO - mozversion platform_buildid: 20170319150902 09:04:41 INFO - mozversion platform_changeset: 6a72a11138b9b41a02455a3cb32a8994a7f41934 09:04:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:04:41 INFO - mozversion platform_version: 54.0a2 09:04:41 INFO - using testdate: 1489939481 09:04:41 INFO - actual date: 1489939481 09:04:41 INFO - starting webserver on 'localhost:47684' 09:04:41 INFO - SUITE-START | Running 2 tests 09:04:41 INFO - TEST-START | dromaeo_css 09:04:41 INFO - operating with platform_type : linux_ 09:04:41 INFO - Initialising browser for dromaeo_css test... 09:04:41 INFO - TEST-INFO | started process 3663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4rQYrK/profile http://localhost:47684/getInfo.html) 09:04:45 INFO - PROCESS | 3663 | __metrics Screen width/height:1600/1200 09:04:45 INFO - PROCESS | 3663 | colorDepth:24 09:04:45 INFO - PROCESS | 3663 | Browser inner width/height: 1024/697 09:04:45 INFO - PROCESS | 3663 | __metrics 09:04:46 INFO - PROCESS | 3663 | 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" 09:04:46 INFO - PROCESS | 3663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:46 INFO - PROCESS | 3663 | console.error: PushService: 09:04:46 INFO - PROCESS | 3663 | stateChangeProcessEnqueue: Error transitioning state 09:04:46 INFO - PROCESS | 3663 | UnknownError 09:04:47 INFO - TEST-INFO | 3663: exit 0 09:04:47 INFO - Browser initialized. 09:04:47 INFO - Running cycle 1/1 for dromaeo_css test... 09:04:47 INFO - TEST-INFO | started process 3754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4rQYrK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:59 INFO - PROCESS | 3754 | RSS: Main: 138969088 09:04:59 INFO - PROCESS | 3754 | 09:08:00 INFO - PROCESS | 3754 | Cycle 1(1): loaded http://localhost:47684/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47684/tests/dromaeo/cssquery-ext.html) 09:08:01 INFO - PROCESS | 3754 | RSS: Main: 250277888 09:08:01 INFO - PROCESS | 3754 | 09:09:48 INFO - PROCESS | 3754 | ************************* 09:09:48 INFO - PROCESS | 3754 | A coding exception was thrown and uncaught in a Task. 09:09:48 INFO - PROCESS | 3754 | 09:09:48 ERROR - PROCESS | 3754 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:09:48 INFO - PROCESS | 3754 | Full stack: 09:09:48 INFO - PROCESS | 3754 | ************************* 09:11:04 INFO - PROCESS | 3754 | Cycle 1(1): loaded http://localhost:47684/tests/dromaeo/cssquery-ext.html (next: http://localhost:47684/tests/dromaeo/cssquery-jquery.html) 09:11:04 INFO - PROCESS | 3754 | RSS: Main: 222990336 09:11:04 INFO - PROCESS | 3754 | 09:14:06 INFO - PROCESS | 3754 | Cycle 1(1): loaded http://localhost:47684/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47684/tests/dromaeo/cssquery-mootools.html) 09:14:07 INFO - PROCESS | 3754 | RSS: Main: 199589888 09:14:07 INFO - PROCESS | 3754 | 09:17:09 INFO - PROCESS | 3754 | Cycle 1(1): loaded http://localhost:47684/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47684/tests/dromaeo/cssquery-prototype.html) 09:17:09 INFO - PROCESS | 3754 | RSS: Main: 172302336 09:17:09 INFO - PROCESS | 3754 | 09:20:12 INFO - PROCESS | 3754 | Cycle 1(1): loaded http://localhost:47684/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47684/tests/dromaeo/cssquery-yui.html) 09:20:13 INFO - PROCESS | 3754 | RSS: Main: 176799744 09:20:13 INFO - PROCESS | 3754 | 09:23:15 INFO - PROCESS | 3754 | Cycle 1(1): loaded http://localhost:47684/tests/dromaeo/cssquery-yui.html (next: http://localhost:47684/tests/dromaeo/cssquery-dojo.html) 09:23:15 INFO - PROCESS | 3754 | RSS: Main: 259682304 09:23:15 INFO - PROCESS | 3754 | 09:23:15 INFO - PROCESS | 3754 | __start_tp_report 09:23:15 INFO - PROCESS | 3754 | _x_x_mozilla_page_load 09:23:15 INFO - PROCESS | 3754 | _x_x_mozilla_page_load_details 09:23:15 INFO - PROCESS | 3754 | |i|pagename|runs| 09:23:15 INFO - PROCESS | 3754 | |0;dojo.html;3381.6449272826353;3413.6245013048574;3427.897163085107;3445.19038026064;3473.8784142555;5795.536357091433;5865.530757539397;5873.471387575118;5879.441453061963;5896;5872.471477567018;5882.088276317167;5907.02534081876;5911.142884281777;5925.61483503572;5334.893302133955;5358.785648574072;5364.088105022156;5419.051665958461;5423.593230507708;5213;5263.4999675031;5293.285406470116;5422.674639521621;5431.348238211401;5379.865503362427;5397.973010134944;5409.6213265071465;5420.268263784398;5433.8369848904595;5386.515213630752;5396.352437707481;5413.675179489243;5416.350037995466;5421.83734487964;5186.688798672092;5290.0477913975465;5317.574594032468;5345.893082138375;5414.91877621836;5655.26481557399;5745.856353591152;5755.482006619382;5757.568182386296;5765.279340082489;6228.28374736902;6260.499160067184;6268.310485846553;6279.6860156992425;6286.46565041972;6300.873982520324;6304.338044505353;6325.114483972247;6329.6202227866015;6331.7783877564525;5586.385497595261;5662.6036177467595;5816.447437493389;5860.238169037998;5861.413858614104;6413.711382987777;6431.6462594556815;6438.903416448757;6445.51658625605;6453.064305675744;6199.039148931833;6201.782937597162;6203;6217.844553886099;6218.31598524162;6029.577929544977;6213.502919766408;6240.469560087444;6284.968575157186;6294.748210071546;6135.140800782589;6135.294441139237;6166.4758495527485;6186.752529898844;6202.844928876814;6082.361352058058;6108.083787431832;6153.84615384619;6172.074188871616;6282.968585157137;4707.411573553306;4731.077439899255;4748.667593268438;4813.181759100961;4828.95171048292;4261.339492378686;4263.59495847894;4264.87205383839;4279.507856596469;4331.047169622678;6011.789587364421;6011.909821352683;6012.909806352908;6014.6391216527145;6041.939580604226;6115.149072927094;6136.427173609184;6201.193844800147;6244.656543890039;6321.715522801485;6029.577929544977;6031.185789918392;6031.758729650853;6036.3360030396625;6052.273727152769;5314.4951229633125;5319.989202051598;5349.679019258857;5351.732413379315;5352.973235133877;6302.5588208826775;6330.240371155307;6506.772262970868;6510.609363438209;6581.901271480931;6187.195664563578;6203.4416902479;6205.689715514297;6211.192544969125;6213.03697926822;6501.739930402731;6515.641639709862;6521.576097553644;6524.478041756743;6531.216254049545;6022.66875321844;6115.7247923844425;6179.443850053517;6182.783602573888;6200.038993955944;6163.876722465436;6189.35011823752;6217.285012223652;6320.367963203643;6337.588056776295;6177.876442471215;6180.505559555315;6189.288231853395;6191.597546159485;6192.690365481798;6121;6177.7837775677635;6199.442050215503;6199.907001395073;6202.81391558254;5957.582969192115;5971.522278217819;6035.849103772441;6052.364501727431;6056;6119.8776024478375;6151.661658608819;6155.722992465439;6163.753449862134;6164.7842325518395;5898.174255604305;5929.02171141774;6027.427394397525;6032.065029920369;6061.6666083365835 09:23:15 INFO - PROCESS | 3754 | |1;ext.html;784.544963920926;837.1753822484851;853.8719192121183;903.5798353765498;918.912703293187;31189.376212475738;43298.783506082465;44003.89990250245;44044;44050.999999999956;40499.39250911239;40695.186096278056;40728.79635601818;45488;45702.57230707694;7589.468737188399;9194.080591940787;9312.534373281344;9320.72037838866;9338;7683.270089341504;10535.209859260547;10755.892441075568;10758.300710453796;10759.408232547246;10960.342379457219;10969.341839489656;10987.340759554452;10987.835182472269;11006.119510439186;10879.83680244797;10899.1280697544;10918.50866710996;10931.234813563055;10931.398773067478;10642.201834862339;10707.089897358655;10707.625233116882;10709.46452677363;10709.625163119332;41288.58711412877;41464;41527;41552;41607.167856643;4174.227767862955;4182.100848317596;4227.894302642428;4302.978485107555;4343.283358245885;27657.44685106307;27725.722742772516;28398.29004274889;28720.281992950135;29048.41903161925;3787.16682329887;3801.923961520754;3812.4662547243406;3812.5234345706785;3863.2466668999555;230645;231427;231815;231983.9999999983;232366.9999999983;53660;53733;53782.462175378525;53798;53883.19175212375;55276.72361638166;55820;55858.720706396205;55864;56271;16475.258613362428;16771.2452939618;16795.91602041982;16878.409255675993;16883.409080682362;11164.106871450265;11431.942840285745;14723.852761472463;14725.852741472663;14730.852691473163;13051.28217948003;13298.202107873558;13350.265735384648;13425.530106446422;13439.664008399868;5517.393086760453;5519.936435278379;5548.91676624851;5576.525995290446;5598.720063996784;1173.636172786439;1186.4838795123976;1208.353530860985;1212.9090318226167;1213.9089568282413;29157.315644178176;29352.706472935424;29600.259993500335;29789.851050744608;30069.097927062223;1244.4275633208645;1245.0413181850106;1264.4626033935724;1274.439246731435;1298.8311519502404;15573.143477108868;15740.92129539345;15756.92121539385;15760.842391575938;15990.76013859793;288730;288931;290131;290246;291176;56700.43299567034;56870.146947795816;56951.43048569544;57060.144097838565;57312.71343643338;1512.7957725706888;1517.6888737808722;1528.0755143138463;1532.318118437307;1536.1244090868097;27322.5901611472;28591.714082859737;29007.41985160327;29146.41707165887;29152.27119322034;24552.631710524714;45724.314135287335;46571;46952.29571556361;47184.29223561718;331896;333356;334066;334565;335170;24310.149144780557;24590;24592.631110533;30235.848820755757;30398.848005760716;38615;38888.80555597204;42277.78861105675;42411.787941060094;42443.36334954917;34354.96935091951;34487.31025379529;34605.30789384249;34722.47916281207;34736.82631586927;32355;32665.34669306648;32716;32950.34099318048;33114.33771324608;34862.47706284357;35350;35393.46909796304;35594.64405355913;35686.64313356833;28518.42963140767;29805.5529167067;31078.00972061971;31280.061598152093;31288;24692;25172;25215.243542693748;25291.49417011686;25370.365740856625 09:23:15 INFO - PROCESS | 3754 | |2;jquery.html;463.31892118585665;474.19150348655546;479.67142507382465;482.315112540193;488.6359662051771;21044.473888152803;21301.893490532566;21500.247491337806;21500.677489837646;21537.56924861502;22421.663675044845;22808.65787013196;22892.198773042946;22955.42611434715;23107.537849243006;6659.167604049494;6682.5656332338485;6775.32246775321;6787.76242831501;6795.7961261162;6718.160229971254;6830.180378354579;7305.159906610755;7571.31858132768;7639;7241.312075352859;7780.066392032964;7789.260020298063;7791.571463569501;7792.142864284924;7260.528065675714;7346.926530734731;7353.338199562038;7356.080489938758;7357.521761085539;7136.892946605805;7507.099148102263;7526.134494533144;7548.509346892434;7559.886601700979;24156.39609009771;24488.632670509956;24615.138470153637;26043.348916277057;26158.476830463285;2796.930076748077;2945.0870230228697;2963.7184467475554;2968.257935516121;3077.584526088972;15664.530064098095;15859.60350991223;15969.84030159695;16041.518754437386;17230;2146.5706858628337;2235.094786611409;2238.9888050559807;2273.238465114189;2290.4388424835856;113087.43456282748;119602;120062.39968800187;120416;120806;15789.842101579066;16234.918825405797;17122.914385427994;17707.291708331522;18113.18490667923;30377;30408.391832163234;30448;30453.69546304553;30514;9711.125998660154;9902.009799020041;10007.049330313608;10060.861633245095;10226.744331391776;8321.167883211752;8343.541105239148;8523.701670441505;8561.52911589856;8615.39692221551;8806.91193088061;9056.818863622691;9123.178913897782;9310.441373517611;9343.785307909928;3621.2214373909737;3726.552813662378;3783.6783873370523;3823.9426408603895;3872.668187513436;909.790748127921;914.4376208631777;919.3426699909596;927.8515437529962;929.5863340813409;19725.013749312762;21099.894500527706;21102.155913763276;21358.78641213599;21586.89206553957;926.7266156483853;926.8702381666437;929.7675581104724;933.7712260496222;938.9248860091176;10877.0754485868;11193.10455163585;11349.375784331942;11518.769624607461;11690.415479226005;527827;579374;595041;609949;620696;114046;114107.42946285216;115672.2163891802;117075;117631;1276.2980360801523;1291.460797771911;1301.225770666452;1309.8886594639562;1315.5395611535887;17802.643947120727;18072.638547229246;18373;18502.074896255403;18683;50031.49968500269;50303.49696502988;50666.74666626643;51358.743206285224;51377.48622513877;59911.700441499255;60336.396636033074;61865;62247.37752622416;67503.3249667497;11842.52629894829;12261.325627090595;12451;12724.491020359083;12768.808467872803;13665.521706740217;13679.179249245077;13725.176489410267;13729.588112356645;13846.792298115737;10865.891341086804;11461.942690286494;11544.653660390202;11589.6523104307;11625.360605166798;12053.57812476559;12235.449404776984;12361.134720569475;12519.248845069325;12522.874771252535;11182.944085279521;11697.23967942081;12258.064516129174;12373.814392783936;12388.752224955631;12012.219205751948;12314.777137072277;12353.073519485895;12411.441485133371;12471.376431178587;11382.886171138183;11842.348670823187;12367.69080772988;12582.18215815969;12725.55460558876 09:23:15 INFO - PROCESS | 3754 | |3;mootools.html;1441.041707264669;1538.884308876065;1569.9843001569984;1580.0677600215874;1598.7442009278518;9521.476318802463;11353.772924541505;11599.30404175749;11634.767304653902;11641.417929103553;11771.646850594474;11858.881411185885;11863.110266729987;11869.821952670716;11871.762564748722;1979.4160722586798;2380.238323736405;2418.5888398972215;2418.661387405765;2426.793722533578;2058.3927741316274;2224.810891074261;2289.416198869286;2304.758000409958;2306.5271619318;2314.4445333120016;2333.7899589036983;2338.1465764995824;2342.437814924423;2347.1315613223132;2268.5803126421665;2290.3815969688258;2309.6304591265402;2310.7342655594653;2313.1788215183537;2220.811231045363;2227.354067320475;2227.365200917731;2231.4979129695853;2258.7515373308925;11695.35675537845;11708.180427370087;11744.530218791238;11744.765104697859;11783.116266280063;5666.348369937427;5829.096490044008;5836.9124463133085;5841.591088623798;5843.065109582446;3137.7176054155007;3182.6658200888805;3237.2392487765355;3255.023492952105;3262.2986057997646;1147.1797664669718;1173.2256710570982;1192.3322939154102;1221.7617564574912;1261.2306493039239;17743.911280443645;17753.55616109595;17859.553511162325;17860.732089018675;17879.642407151914;4476.597106260452;4509.413776209138;4623.144718227139;4631.560001799824;4716.834910778106;14949.103053816805;15024.474143404928;15027.774583381259;15030.248487575578;15033.022853514487;5920.171176035358;5923.7926672566255;5928.525717942641;5935.792247271324;5938.020226662638;5307.310049693515;5309.41596424393;5356.437574054746;5401.3518377794135;5438.646487978269;4112.832374532776;4164.570267160164;4170.061736109351;4209.284421648327;4221.2190744712325;1111.6720567432626;1114.6321713834416;1118.9664310070712;1126.7577470843808;1132.5016992523263;1029.583018877356;1062.2988827374052;1063.3194755356578;1073.1254027967182;1073.5169173871789;7144.428445724329;7178.928210717826;7228.096487939008;7261.8547629047125;7287.781366559012;1027.9691609251734;1039.5789705169418;1052.3054783842626;1053.5733028123623;1070.8072546941626;4581.885452863705;4600.470945841204;4606.170889239969;4614.884627884263;4650.395448591661;14298.85701142996;14809.185494797674;15009.774853377208;15073.773893391608;15079.54761357161;14774.18741969202;14784.782282657687;14804;14965.251737413086;14969.550913472613;10555.366677999345;10605.946970265253;10644.733881652866;10754.354738715701;10770.730731731614;7377.0409846719585;7447.143578488543;7450.776476705708;7588.506747061423;7610.581418022062;12791.616251512469;13563.38964746569;13758.449662013407;13796.586102416542;13910;13809.654758631115;13835.515756948862;13983.300834958009;14029.859701403264;14130.50543230982;9589.760255993657;9914.30599858003;9924.553395097093;9964.302498825302;10191.082802547806;11016.834747478633;11195;11400.429978500875;11404.885951140383;11548.769024619629;9624.51877406141;9627.9037209627;9733.221342292458;9841.114299713061;9977.551010204703;9308;9346.906530934604;9349.53252337394;9412.435253884789;9538.28462865274;8589.828203436022;8769.649214031368;8769.780755481164;8775.166359195866;8782.385233033627;6513.837154071186;6535.183102112236;6578.703958321791;6588.472922166119;6652.866942661023;6456.741730330734;6687.063811066358;6692.59844409337;6703.262641109376;6823.317668233137 09:23:15 INFO - PROCESS | 3754 | |4;prototype.html;408.2284482328398;428.4686988134713;433.932740425234;433.93490976353564;439.46604875076775;5213.244079608455;5220.74702071503;5251.973740131303;5253.789848406064;5262.0797505858145;4848.272759086139;5127.435982041972;5130.101492656656;5132.28148059272;5170.353705786777;4360.302351623741;4371.562843715635;4377.190219809329;4379.4525684289465;4392.253316936112;4411.073674528353;4421.557844215568;4457.799399027052;4466.73199608023;4488.0799436115685;4355.823927539563;4465.620422264112;4476.418065651461;4476.709013914102;4484.932726009112;4357.978210108945;4388.188185185719;4402.207602631525;4416.807461985262;4469.374287599739;4121.8969525762095;4123.3196522573735;4147.3778933159965;4149.792510374469;4161.3978618231895;5048.899022019539;5056.721880296583;5070.569001634865;5094.337736094284;5102.69383836971;4935.519344196762;5080.720560369178;5082.390113186404;5118.129917913926;5157.813702848328;5450.075945319364;5451.727413629303;5461.781528738846;5467.699276539789;5468.945310546923;4545.840640754677;4548.408706868119;4588.655850811169;4596.310553416981;4599.954000459986;5456.881339325429;5468.835934921959;5507.339119305669;5518.227448157261;5690.317161940552;4718.386609740712;4732.24906784485;4734.171519983989;4751.3348131261655;4753.120672675497;4733.171694953369;4749.35883655702;4756.714597124114;4787.736674482867;4789.353437285922;4945.184044632595;5024.84925452237;5048.444671086178;5071.055720672315;5105.438401775802;5418;5467.644603100785;5475.479829416199;5478.890422191534;5492.945070549324;1630.290823491785;1638.680457310813;1649.7030534503904;1654.247317470548;1657.7927759030122;1234.5679012345786;1286.3182513267982;1292.140726416941;1302.4724986380531;1306.5035286591224;5331;5350.839474815762;5351.785928562814;5368.973155134199;5369.624126311199;5573.41479144692;5602.663840169603;5606.943930560642;5618.943810561924;5622.943770562324;5164.8192313268855;5283.339582552181;5291.841244762663;5336.519713225828;5339.665083729068;2921.9123426297247;2922.839243841609;2934.9706502935123;2939.4855900217376;2962.8000659732843;5576.358718747315;5767.798127065616;5769.451902069297;5823.330317013598;5837.153612726216;5673.290838645169;5692.288463942007;5700.572457065737;5700.866871518117;5747;5765.654060756284;5800;5808.709564521757;5822.729135637105;5878.882422351615;5362.276092727432;5557.416471270459;5578.330600327987;5628.086450606814;5631.958087753778;5350.545203657733;5537.089704052096;5581.162825576196;5582.581306401955;5598.944010559842;5692.43075692444;5695.943040569707;5708.686022268815;5731.971340143273;5735.54115670737;4592.5177856325945;4730.810767569259;4740.834070807505;4747.976260118678;4748.240281554935;5464.28964234647;5656.773729050792;5665.235193249024;5700.657960522382;5711.457906365175;5502.889942201054;5519.503244707996;5523.4200408956485;5523.502884740393;5568.192612071146;5470.425605311385;5485.122380419114;5501.4223506532835;5515.310586176728;5549.223108764695;5344.706041167773;5512.236084453097;5542.307211598551;5546.611737178358;5546.639468434539;5550.611457197957;5568.830545585311;5577.52591029767;5577.6653400796085;5578.3584887738425;5169.224616307584;5412.810551630674;5429.185622156708;5439.374471935778;5450.482204190595 09:23:15 INFO - PROCESS | 3754 | |5;yui.html;670.6847781542673;794.285143370966;807.7778610882007;809.9878501822471;854.1501206299731;15087.773683394758;15790.763138552917;15952;16879.1560421979;17309.653806923852;17648.82351176491;18202.5449363766;18348.633027339445;18540.629187416245;18802.811971880277;874.9606267717936;893.6648756716231;896.1173244354305;896.3680605173337;897.4704924094783;852.1393392673414;872.2280781508379;873.7160422862563;881.6341218394359;882.0297672560197;928.4522131942152;930.1907340613642;930.502181332987;930.5486838883136;930.9022552631977;925.028719844161;925.9444433334022;926.333040211047;926.5552534783308;926.7914719188162;683.9213490448562;685.3078390825302;686.4954258619911;686.7630667419783;686.8351595617066;15954.441594544136;16159.676806463805;16267.837321626868;16365.754513682305;16385.426510072208;16091.275892584861;16451.83548164515;16603.58869496094;16642.83357166425;16831.495055148243;12562.371881405985;12702.809457858048;12803.679908002281;12929.03032272574;12974.286414247212;3355.8825441109443;3368.932621347584;3388.3053973935284;3398.677125673057;3403.1662242750435;68719.65640171767;69034.3096569033;69220.65389673019;86689;88192.55903720505;12521.499140034479;12725.809112863315;12758.10693251482;12827.743445131046;12889.291088990009;23163.88418057899;23274.3017709469;23350.416239593807;23375;23572.528549428916;8187.222213889671;8194.877076843852;8289.751307460785;8362.080171181165;8579.828403431897;4763.833265835679;4767.833125840579;4833.661643684908;4850.83022094225;4950.8267210647455;3448.137965508623;3540.592831824373;3546.0957455848593;3546.2730140321173;3547.5210846535388;618.5979113576211;622.9190205273286;655.1777519213452;660.7885476647426;664.9966750166315;799.4883274704194;821;825.9050209226016;841.3395484544603;847.8643417053365;10832.78334433307;11081.556737730562;11159.27464714791;11568.942155289169;11700.180987330805;748.8127968007998;757.9431542634325;765.7434759355567;765.9272369124924;774.6088225446226;4918.9508104919205;5264.315638966987;5269.920951185735;5276.630635855453;5277.894442111136;81913;82990.58504707438;83169;85254.57372713096;87366;45195.774021129684;61069.38930610637;62772.372276277565;72046.63976680083;73625;67376.6631166841;68240.3175968234;68360.65819670969;68487;68991.96512052324;11704.414779260833;12515.687107822378;12657.612041063507;12681.112322137362;12853.678658033625;46052.539474606165;46310.768446157555;46630.13479460784;47489.76255118702;47603.5239647613;54097.45902540924;55253.44746552483;55411;56643.71678141583;56813.715931420076;12234.75530489403;12332.32172230536;12433.440495177558;12575.371231438574;12827.42276597574;16195.271212795687;16272.918635406748;16537.66924661524;17526.912365438093;17548.473545793648;14698.77951830702;14712.779308310597;14923;15017.32422040989;15177.544673659808;15390.84609153939;15404.383824647337;15571.065736055873;15682.607934801721;15704.60738481547;15442.691146176789;15723.764143537628;15733.370665173265;15836.604084897508;16182.919085404968;11227.438628068727;11331.490082946122;11374.260673056226;11567.88432115668;11619.76760464769;10903.945480272549;11023.944880275869;11132.554697811996;11256.21206515536;11340.886591133984 09:23:15 INFO - PROCESS | 3754 | __end_tp_report 09:23:15 INFO - PROCESS | 3754 | __start_cc_report 09:23:15 INFO - PROCESS | 3754 | _x_x_mozilla_cycle_collect,1126 09:23:15 INFO - PROCESS | 3754 | __end_cc_report 09:23:15 INFO - PROCESS | 3754 | __startTimestamp1489940595749__endTimestamp 09:23:15 INFO - PROCESS | 3754 | 09:23:15 INFO - PROCESS | 3754 | ------- Summary: start ------- 09:23:15 INFO - PROCESS | 3754 | Number of tests: 6 09:23:15 INFO - PROCESS | 3754 | 09:23:15 INFO - PROCESS | 3754 | [#0] dojo.html Cycles:165 Average:5818.17 Median:6041.94 stddev:651.65 (10.8%) stddev-sans-first:624.98 09:23:15 INFO - PROCESS | 3754 | Values: 3381.6 3413.6 3427.9 3445.2 3473.9 5795.5 5865.5 5873.5 5879.4 5896.0 5872.5 5882.1 5907.0 5911.1 5925.6 5334.9 5358.8 5364.1 5419.1 5423.6 5213.0 5263.5 5293.3 5422.7 5431.3 5379.9 5398.0 5409.6 5420.3 5433.8 5386.5 5396.4 5413.7 5416.4 5421.8 5186.7 5290.0 5317.6 5345.9 5414.9 5655.3 5745.9 5755.5 5757.6 5765.3 6228.3 6260.5 6268.3 6279.7 6286.5 6300.9 6304.3 6325.1 6329.6 6331.8 5586.4 5662.6 5816.4 5860.2 5861.4 6413.7 6431.6 6438.9 6445.5 6453.1 6199.0 6201.8 6203.0 6217.8 6218.3 6029.6 6213.5 6240.5 6285.0 6294.7 6135.1 6135.3 6166.5 6186.8 6202.8 6082.4 6108.1 6153.8 6172.1 6283.0 4707.4 4731.1 4748.7 4813.2 4829.0 4261.3 4263.6 4264.9 4279.5 4331.0 6011.8 6011.9 6012.9 6014.6 6041.9 6115.1 6136.4 6201.2 6244.7 6321.7 6029.6 6031.2 6031.8 6036.3 6052.3 5314.5 5320.0 5349.7 5351.7 5353.0 6302.6 6330.2 6506.8 6510.6 6581.9 6187.2 6203.4 6205.7 6211.2 6213.0 6501.7 6515.6 6521.6 6524.5 6531.2 6022.7 6115.7 6179.4 6182.8 6200.0 6163.9 6189.4 6217.3 6320.4 6337.6 6177.9 6180.5 6189.3 6191.6 6192.7 6121.0 6177.8 6199.4 6199.9 6202.8 5957.6 5971.5 6035.8 6052.4 6056.0 6119.9 6151.7 6155.7 6163.8 6164.8 5898.2 5929.0 6027.4 6032.1 6061.7 09:23:15 INFO - PROCESS | 3754 | 09:23:15 INFO - PROCESS | 3754 | [#1] ext.html Cycles:180 Average:45315.34 Median:30317.35 stddev:75310.10 (248.4%) stddev-sans-first:75447.15 09:23:15 INFO - PROCESS | 3754 | Values: 784.5 837.2 853.9 903.6 918.9 31189.4 43298.8 44003.9 44044.0 44051.0 40499.4 40695.2 40728.8 45488.0 45702.6 7589.5 9194.1 9312.5 9320.7 9338.0 7683.3 10535.2 10755.9 10758.3 10759.4 10960.3 10969.3 10987.3 10987.8 11006.1 10879.8 10899.1 10918.5 10931.2 10931.4 10642.2 10707.1 10707.6 10709.5 10709.6 41288.6 41464.0 41527.0 41552.0 41607.2 4174.2 4182.1 4227.9 4303.0 4343.3 27657.4 27725.7 28398.3 28720.3 29048.4 3787.2 3801.9 3812.5 3812.5 3863.2 230645.0 231427.0 231815.0 231984.0 232367.0 53660.0 53733.0 53782.5 53798.0 53883.2 55276.7 55820.0 55858.7 55864.0 56271.0 16475.3 16771.2 16795.9 16878.4 16883.4 11164.1 11431.9 14723.9 14725.9 14730.9 13051.3 13298.2 13350.3 13425.5 13439.7 5517.4 5519.9 5548.9 5576.5 5598.7 1173.6 1186.5 1208.4 1212.9 1213.9 29157.3 29352.7 29600.3 29789.9 30069.1 1244.4 1245.0 1264.5 1274.4 1298.8 15573.1 15740.9 15756.9 15760.8 15990.8 288730.0 288931.0 290131.0 290246.0 291176.0 56700.4 56870.1 56951.4 57060.1 57312.7 1512.8 1517.7 1528.1 1532.3 1536.1 27322.6 28591.7 29007.4 29146.4 29152.3 24552.6 45724.3 46571.0 46952.3 47184.3 331896.0 333356.0 334066.0 334565.0 335170.0 24310.1 24590.0 24592.6 30235.8 30398.8 38615.0 38888.8 42277.8 42411.8 42443.4 34355.0 34487.3 34605.3 34722.5 34736.8 32355.0 32665.3 32716.0 32950.3 33114.3 34862.5 35350.0 35393.5 35594.6 35686.6 28518.4 29805.6 31078.0 31280.1 31288.0 24692.0 25172.0 25215.2 25291.5 25370.4 09:23:15 INFO - PROCESS | 3754 | 09:23:15 INFO - PROCESS | 3754 | [#2] jquery.html Cycles:180 Average:35573.13 Median:12622.93 stddev:97334.47 (771.1%) stddev-sans-first:97571.82 09:23:15 INFO - PROCESS | 3754 | Values: 463.3 474.2 479.7 482.3 488.6 21044.5 21301.9 21500.2 21500.7 21537.6 22421.7 22808.7 22892.2 22955.4 23107.5 6659.2 6682.6 6775.3 6787.8 6795.8 6718.2 6830.2 7305.2 7571.3 7639.0 7241.3 7780.1 7789.3 7791.6 7792.1 7260.5 7346.9 7353.3 7356.1 7357.5 7136.9 7507.1 7526.1 7548.5 7559.9 24156.4 24488.6 24615.1 26043.3 26158.5 2796.9 2945.1 2963.7 2968.3 3077.6 15664.5 15859.6 15969.8 16041.5 17230.0 2146.6 2235.1 2239.0 2273.2 2290.4 113087.4 119602.0 120062.4 120416.0 120806.0 15789.8 16234.9 17122.9 17707.3 18113.2 30377.0 30408.4 30448.0 30453.7 30514.0 9711.1 9902.0 10007.0 10060.9 10226.7 8321.2 8343.5 8523.7 8561.5 8615.4 8806.9 9056.8 9123.2 9310.4 9343.8 3621.2 3726.6 3783.7 3823.9 3872.7 909.8 914.4 919.3 927.9 929.6 19725.0 21099.9 21102.2 21358.8 21586.9 926.7 926.9 929.8 933.8 938.9 10877.1 11193.1 11349.4 11518.8 11690.4 527827.0 579374.0 595041.0 609949.0 620696.0 114046.0 114107.4 115672.2 117075.0 117631.0 1276.3 1291.5 1301.2 1309.9 1315.5 17802.6 18072.6 18373.0 18502.1 18683.0 50031.5 50303.5 50666.7 51358.7 51377.5 59911.7 60336.4 61865.0 62247.4 67503.3 11842.5 12261.3 12451.0 12724.5 12768.8 13665.5 13679.2 13725.2 13729.6 13846.8 10865.9 11461.9 11544.7 11589.7 11625.4 12053.6 12235.4 12361.1 12519.2 12522.9 11182.9 11697.2 12258.1 12373.8 12388.8 12012.2 12314.8 12353.1 12411.4 12471.4 11382.9 11842.3 12367.7 12582.2 12725.6 09:23:15 INFO - PROCESS | 3754 | 09:23:15 INFO - PROCESS | 3754 | [#3] mootools.html Cycles:180 Average:7323.30 Median:2297.57 stddev:4824.03 (210.0%) stddev-sans-first:4817.32 09:23:15 INFO - PROCESS | 3754 | Values: 1441.0 1538.9 1570.0 1580.1 1598.7 9521.5 11353.8 11599.3 11634.8 11641.4 11771.6 11858.9 11863.1 11869.8 11871.8 1979.4 2380.2 2418.6 2418.7 2426.8 2058.4 2224.8 2289.4 2304.8 2306.5 2314.4 2333.8 2338.1 2342.4 2347.1 2268.6 2290.4 2309.6 2310.7 2313.2 2220.8 2227.4 2227.4 2231.5 2258.8 11695.4 11708.2 11744.5 11744.8 11783.1 5666.3 5829.1 5836.9 5841.6 5843.1 3137.7 3182.7 3237.2 3255.0 3262.3 1147.2 1173.2 1192.3 1221.8 1261.2 17743.9 17753.6 17859.6 17860.7 17879.6 4476.6 4509.4 4623.1 4631.6 4716.8 14949.1 15024.5 15027.8 15030.2 15033.0 5920.2 5923.8 5928.5 5935.8 5938.0 5307.3 5309.4 5356.4 5401.4 5438.6 4112.8 4164.6 4170.1 4209.3 4221.2 1111.7 1114.6 1119.0 1126.8 1132.5 1029.6 1062.3 1063.3 1073.1 1073.5 7144.4 7178.9 7228.1 7261.9 7287.8 1028.0 1039.6 1052.3 1053.6 1070.8 4581.9 4600.5 4606.2 4614.9 4650.4 14298.9 14809.2 15009.8 15073.8 15079.5 14774.2 14784.8 14804.0 14965.3 14969.6 10555.4 10605.9 10644.7 10754.4 10770.7 7377.0 7447.1 7450.8 7588.5 7610.6 12791.6 13563.4 13758.4 13796.6 13910.0 13809.7 13835.5 13983.3 14029.9 14130.5 9589.8 9914.3 9924.6 9964.3 10191.1 11016.8 11195.0 11400.4 11404.9 11548.8 9624.5 9627.9 9733.2 9841.1 9977.6 9308.0 9346.9 9349.5 9412.4 9538.3 8589.8 8769.6 8769.8 8775.2 8782.4 6513.8 6535.2 6578.7 6588.5 6652.9 6456.7 6687.1 6692.6 6703.3 6823.3 09:23:15 INFO - PROCESS | 3754 | 09:23:15 INFO - PROCESS | 3754 | [#4] prototype.html Cycles:180 Average:4786.28 Median:5257.93 stddev:1261.56 (24.0%) stddev-sans-first:1221.55 09:23:15 INFO - PROCESS | 3754 | Values: 408.2 428.5 433.9 433.9 439.5 5213.2 5220.7 5252.0 5253.8 5262.1 4848.3 5127.4 5130.1 5132.3 5170.4 4360.3 4371.6 4377.2 4379.5 4392.3 4411.1 4421.6 4457.8 4466.7 4488.1 4355.8 4465.6 4476.4 4476.7 4484.9 4358.0 4388.2 4402.2 4416.8 4469.4 4121.9 4123.3 4147.4 4149.8 4161.4 5048.9 5056.7 5070.6 5094.3 5102.7 4935.5 5080.7 5082.4 5118.1 5157.8 5450.1 5451.7 5461.8 5467.7 5468.9 4545.8 4548.4 4588.7 4596.3 4600.0 5456.9 5468.8 5507.3 5518.2 5690.3 4718.4 4732.2 4734.2 4751.3 4753.1 4733.2 4749.4 4756.7 4787.7 4789.4 4945.2 5024.8 5048.4 5071.1 5105.4 5418.0 5467.6 5475.5 5478.9 5492.9 1630.3 1638.7 1649.7 1654.2 1657.8 1234.6 1286.3 1292.1 1302.5 1306.5 5331.0 5350.8 5351.8 5369.0 5369.6 5573.4 5602.7 5606.9 5618.9 5622.9 5164.8 5283.3 5291.8 5336.5 5339.7 2921.9 2922.8 2935.0 2939.5 2962.8 5576.4 5767.8 5769.5 5823.3 5837.2 5673.3 5692.3 5700.6 5700.9 5747.0 5765.7 5800.0 5808.7 5822.7 5878.9 5362.3 5557.4 5578.3 5628.1 5632.0 5350.5 5537.1 5581.2 5582.6 5598.9 5692.4 5695.9 5708.7 5732.0 5735.5 4592.5 4730.8 4740.8 4748.0 4748.2 5464.3 5656.8 5665.2 5700.7 5711.5 5502.9 5519.5 5523.4 5523.5 5568.2 5470.4 5485.1 5501.4 5515.3 5549.2 5344.7 5512.2 5542.3 5546.6 5546.6 5550.6 5568.8 5577.5 5577.7 5578.4 5169.2 5412.8 5429.2 5439.4 5450.5 09:23:15 INFO - PROCESS | 3754 | 09:23:15 INFO - PROCESS | 3754 | [#5] yui.html Cycles:180 Average:18466.45 Median:45624.16 stddev:22784.60 (49.9%) stddev-sans-first:22809.33 09:23:15 INFO - PROCESS | 3754 | Values: 670.7 794.3 807.8 810.0 854.2 15087.8 15790.8 15952.0 16879.2 17309.7 17648.8 18202.5 18348.6 18540.6 18802.8 875.0 893.7 896.1 896.4 897.5 852.1 872.2 873.7 881.6 882.0 928.5 930.2 930.5 930.5 930.9 925.0 925.9 926.3 926.6 926.8 683.9 685.3 686.5 686.8 686.8 15954.4 16159.7 16267.8 16365.8 16385.4 16091.3 16451.8 16603.6 16642.8 16831.5 12562.4 12702.8 12803.7 12929.0 12974.3 3355.9 3368.9 3388.3 3398.7 3403.2 68719.7 69034.3 69220.7 86689.0 88192.6 12521.5 12725.8 12758.1 12827.7 12889.3 23163.9 23274.3 23350.4 23375.0 23572.5 8187.2 8194.9 8289.8 8362.1 8579.8 4763.8 4767.8 4833.7 4850.8 4950.8 3448.1 3540.6 3546.1 3546.3 3547.5 618.6 622.9 655.2 660.8 665.0 799.5 821.0 825.9 841.3 847.9 10832.8 11081.6 11159.3 11568.9 11700.2 748.8 757.9 765.7 765.9 774.6 4919.0 5264.3 5269.9 5276.6 5277.9 81913.0 82990.6 83169.0 85254.6 87366.0 45195.8 61069.4 62772.4 72046.6 73625.0 67376.7 68240.3 68360.7 68487.0 68992.0 11704.4 12515.7 12657.6 12681.1 12853.7 46052.5 46310.8 46630.1 47489.8 47603.5 54097.5 55253.4 55411.0 56643.7 56813.7 12234.8 12332.3 12433.4 12575.4 12827.4 16195.3 16272.9 16537.7 17526.9 17548.5 14698.8 14712.8 14923.0 15017.3 15177.5 15390.8 15404.4 15571.1 15682.6 15704.6 15442.7 15723.8 15733.4 15836.6 16182.9 11227.4 11331.5 11374.3 11567.9 11619.8 10903.9 11023.9 11132.6 11256.2 11340.9 09:23:15 INFO - PROCESS | 3754 | -------- Summary: end -------- 09:23:15 INFO - PROCESS | 3754 | 09:23:16 INFO - TEST-INFO | 3754: exit 0 09:23:16 INFO - TEST-OK | dromaeo_css | took 1115592ms 09:23:16 INFO - TEST-START | kraken 09:23:16 INFO - operating with platform_type : linux_ 09:23:16 INFO - Initialising browser for kraken test... 09:23:16 INFO - TEST-INFO | started process 4086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9d6sxT/profile http://localhost:47684/getInfo.html) 09:23:20 INFO - PROCESS | 4086 | __metrics Screen width/height:1600/1200 09:23:20 INFO - PROCESS | 4086 | colorDepth:24 09:23:20 INFO - PROCESS | 4086 | Browser inner width/height: 1024/697 09:23:20 INFO - PROCESS | 4086 | __metrics 09:23:21 INFO - PROCESS | 4086 | 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" 09:23:21 INFO - PROCESS | 4086 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:23:22 INFO - TEST-INFO | 4086: exit 0 09:23:22 INFO - Browser initialized. 09:23:22 INFO - Running cycle 1/1 for kraken test... 09:23:22 INFO - TEST-INFO | started process 4178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9d6sxT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:34 INFO - PROCESS | 4178 | RSS: Main: 139812864 09:23:34 INFO - PROCESS | 4178 | 09:23:37 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47684/tests/kraken/driver.html?testName=audio-beat-detection) 09:23:37 INFO - PROCESS | 4178 | RSS: Main: 182980608 09:23:37 INFO - PROCESS | 4178 | 09:23:40 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47684/tests/kraken/driver.html?testName=audio-dft) 09:23:41 INFO - PROCESS | 4178 | RSS: Main: 174178304 09:23:41 INFO - PROCESS | 4178 | 09:23:43 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47684/tests/kraken/driver.html?testName=audio-fft) 09:23:44 INFO - PROCESS | 4178 | RSS: Main: 265646080 09:23:44 INFO - PROCESS | 4178 | 09:23:46 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47684/tests/kraken/driver.html?testName=audio-oscillator) 09:23:47 INFO - PROCESS | 4178 | RSS: Main: 171794432 09:23:47 INFO - PROCESS | 4178 | 09:23:49 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47684/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:23:49 INFO - PROCESS | 4178 | RSS: Main: 174895104 09:23:49 INFO - PROCESS | 4178 | 09:23:52 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47684/tests/kraken/driver.html?testName=imaging-darkroom) 09:23:53 INFO - PROCESS | 4178 | RSS: Main: 213704704 09:23:53 INFO - PROCESS | 4178 | 09:23:56 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47684/tests/kraken/driver.html?testName=imaging-desaturate) 09:23:57 INFO - PROCESS | 4178 | RSS: Main: 211689472 09:23:57 INFO - PROCESS | 4178 | 09:24:00 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47684/tests/kraken/driver.html?testName=json-parse-financial) 09:24:00 INFO - PROCESS | 4178 | RSS: Main: 210259968 09:24:00 INFO - PROCESS | 4178 | 09:24:02 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47684/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:02 INFO - PROCESS | 4178 | RSS: Main: 172548096 09:24:02 INFO - PROCESS | 4178 | 09:24:04 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47684/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:05 INFO - PROCESS | 4178 | RSS: Main: 180002816 09:24:05 INFO - PROCESS | 4178 | 09:24:07 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47684/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:07 INFO - PROCESS | 4178 | RSS: Main: 189964288 09:24:07 INFO - PROCESS | 4178 | 09:24:10 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:10 INFO - PROCESS | 4178 | RSS: Main: 198578176 09:24:10 INFO - PROCESS | 4178 | 09:24:13 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:14 INFO - PROCESS | 4178 | RSS: Main: 194723840 09:24:14 INFO - PROCESS | 4178 | 09:24:15 INFO - PROCESS | 4178 | Cycle 1(1): loaded http://localhost:47684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47684/tests/kraken/driver.html?testName=ai-astar) 09:24:16 INFO - PROCESS | 4178 | RSS: Main: 244314112 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | __start_tp_report 09:24:16 INFO - PROCESS | 4178 | _x_x_mozilla_page_load 09:24:16 INFO - PROCESS | 4178 | _x_x_mozilla_page_load_details 09:24:16 INFO - PROCESS | 4178 | |i|pagename|runs| 09:24:16 INFO - PROCESS | 4178 | |0;ai-astar;104;113;113;113;114;114;112;113;113;113 09:24:16 INFO - PROCESS | 4178 | |1;audio-beat-detection;142;121;121;153;118;120;116;116;131;117 09:24:16 INFO - PROCESS | 4178 | |2;audio-dft;161;162;161;161;160;160;161;162;161;160 09:24:16 INFO - PROCESS | 4178 | |3;audio-fft;75;76;76;114;75;76;78;76;97;76 09:24:16 INFO - PROCESS | 4178 | |4;audio-oscillator;82;82;113;83;81;81;108;82;83;106 09:24:16 INFO - PROCESS | 4178 | |5;imaging-gaussian-blur;113;113;114;113;113;113;114;113;113;113 09:24:16 INFO - PROCESS | 4178 | |6;imaging-darkroom;146;146;146;147;146;147;146;147;146;145 09:24:16 INFO - PROCESS | 4178 | |7;imaging-desaturate;94;94;94;94;94;94;94;101;94;93 09:24:16 INFO - PROCESS | 4178 | |8;json-parse-financial;54;54;55;54;53;54;53;53;54;54 09:24:16 INFO - PROCESS | 4178 | |9;json-stringify-tinderbox;54;53;54;53;52;53;53;53;53;53 09:24:16 INFO - PROCESS | 4178 | |10;stanford-crypto-aes;75;79;75;79;79;84;83;81;80;80 09:24:16 INFO - PROCESS | 4178 | |11;stanford-crypto-ccm;120;120;121;126;120;123;118;125;171;120 09:24:16 INFO - PROCESS | 4178 | |12;stanford-crypto-pbkdf2;159;167;157;163;160;160;159;161;162;160 09:24:16 INFO - PROCESS | 4178 | |13;stanford-crypto-sha256-iterative;59;60;60;60;60;61;61;60;64;59 09:24:16 INFO - PROCESS | 4178 | __end_tp_report 09:24:16 INFO - PROCESS | 4178 | __start_cc_report 09:24:16 INFO - PROCESS | 4178 | _x_x_mozilla_cycle_collect,1673 09:24:16 INFO - PROCESS | 4178 | __end_cc_report 09:24:16 INFO - PROCESS | 4178 | __startTimestamp1489940656089__endTimestamp 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | ------- Summary: start ------- 09:24:16 INFO - PROCESS | 4178 | Number of tests: 14 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:0.60 09:24:16 INFO - PROCESS | 4178 | Values: 104.0 113.0 113.0 113.0 114.0 114.0 112.0 113.0 113.0 113.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:121.00 stddev:12.64 (10.4%) stddev-sans-first:11.92 09:24:16 INFO - PROCESS | 4178 | Values: 142.0 121.0 121.0 153.0 118.0 120.0 116.0 116.0 131.0 117.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:24:16 INFO - PROCESS | 4178 | Values: 161.0 162.0 161.0 161.0 160.0 160.0 161.0 162.0 161.0 160.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.09 (17.2%) stddev-sans-first:13.65 09:24:16 INFO - PROCESS | 4178 | Values: 75.0 76.0 76.0 114.0 75.0 76.0 78.0 76.0 97.0 76.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.00 stddev:13.17 (16.1%) stddev-sans-first:13.64 09:24:16 INFO - PROCESS | 4178 | Values: 82.0 82.0 113.0 83.0 81.0 81.0 108.0 82.0 83.0 106.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:24:16 INFO - PROCESS | 4178 | Values: 113.0 113.0 114.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:24:16 INFO - PROCESS | 4178 | Values: 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 145.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:2.27 (2.4%) stddev-sans-first:2.40 09:24:16 INFO - PROCESS | 4178 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 101.0 94.0 93.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 09:24:16 INFO - PROCESS | 4178 | Values: 54.0 54.0 55.0 54.0 53.0 54.0 53.0 53.0 54.0 54.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#9] json-stringify-tinderbox Cycles:10 Average:53.10 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 09:24:16 INFO - PROCESS | 4178 | Values: 54.0 53.0 54.0 53.0 52.0 53.0 53.0 53.0 53.0 53.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:80.00 stddev:2.92 (3.6%) stddev-sans-first:2.60 09:24:16 INFO - PROCESS | 4178 | Values: 75.0 79.0 75.0 79.0 79.0 84.0 83.0 81.0 80.0 80.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:122.00 stddev:15.87 (13.0%) stddev-sans-first:16.66 09:24:16 INFO - PROCESS | 4178 | Values: 120.0 120.0 121.0 126.0 120.0 123.0 118.0 125.0 171.0 120.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:160.50 stddev:2.74 (1.7%) stddev-sans-first:2.83 09:24:16 INFO - PROCESS | 4178 | Values: 159.0 167.0 157.0 163.0 160.0 160.0 159.0 161.0 162.0 160.0 09:24:16 INFO - PROCESS | 4178 | 09:24:16 INFO - PROCESS | 4178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.00 stddev:1.43 (2.4%) stddev-sans-first:1.42 09:24:16 INFO - PROCESS | 4178 | Values: 59.0 60.0 60.0 60.0 60.0 61.0 61.0 60.0 64.0 59.0 09:24:16 INFO - PROCESS | 4178 | -------- Summary: end -------- 09:24:16 INFO - PROCESS | 4178 | 09:24:17 INFO - TEST-INFO | 4178: exit 0 09:24:17 INFO - TEST-OK | kraken | took 60586ms 09:24:17 INFO - SUITE-END | took 1176s 09:24:17 INFO - Completed test suite (00:19:36) 09:24:17 INFO - javascript benchmark 09:24:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7839.1053123258, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3381.6449272826353, 3413.6245013048574, 3427.897163085107, 3445.19038026064, 3473.8784142555, 5795.536357091433, 5865.530757539397, 5873.471387575118, 5879.441453061963, 5896.0, 5872.471477567018, 5882.088276317167, 5907.02534081876, 5911.142884281777, 5925.61483503572, 5334.893302133955, 5358.785648574072, 5364.088105022156, 5419.051665958461, 5423.593230507708, 5213.0, 5263.4999675031, 5293.285406470116, 5422.674639521621, 5431.348238211401, 5379.865503362427, 5397.973010134944, 5409.6213265071465, 5420.268263784398, 5433.8369848904595, 5386.515213630752, 5396.352437707481, 5413.675179489243, 5416.350037995466, 5421.83734487964, 5186.688798672092, 5290.0477913975465, 5317.574594032468, 5345.893082138375, 5414.91877621836, 5655.26481557399, 5745.856353591152, 5755.482006619382, 5757.568182386296, 5765.279340082489, 6228.28374736902, 6260.499160067184, 6268.310485846553, 6279.6860156992425, 6286.46565041972, 6300.873982520324, 6304.338044505353, 6325.114483972247, 6329.6202227866015, 6331.7783877564525, 5586.385497595261, 5662.6036177467595, 5816.447437493389, 5860.238169037998, 5861.413858614104, 6413.711382987777, 6431.6462594556815, 6438.903416448757, 6445.51658625605, 6453.064305675744, 6199.039148931833, 6201.782937597162, 6203.0, 6217.844553886099, 6218.31598524162, 6029.577929544977, 6213.502919766408, 6240.469560087444, 6284.968575157186, 6294.748210071546, 6135.140800782589, 6135.294441139237, 6166.4758495527485, 6186.752529898844, 6202.844928876814, 6082.361352058058, 6108.083787431832, 6153.84615384619, 6172.074188871616, 6282.968585157137, 4707.411573553306, 4731.077439899255, 4748.667593268438, 4813.181759100961, 4828.95171048292, 4261.339492378686, 4263.59495847894, 4264.87205383839, 4279.507856596469, 4331.047169622678, 6011.789587364421, 6011.909821352683, 6012.909806352908, 6014.6391216527145, 6041.939580604226, 6115.149072927094, 6136.427173609184, 6201.193844800147, 6244.656543890039, 6321.715522801485, 6029.577929544977, 6031.185789918392, 6031.758729650853, 6036.3360030396625, 6052.273727152769, 5314.4951229633125, 5319.989202051598, 5349.679019258857, 5351.732413379315, 5352.973235133877, 6302.5588208826775, 6330.240371155307, 6506.772262970868, 6510.609363438209, 6581.901271480931, 6187.195664563578, 6203.4416902479, 6205.689715514297, 6211.192544969125, 6213.03697926822, 6501.739930402731, 6515.641639709862, 6521.576097553644, 6524.478041756743, 6531.216254049545, 6022.66875321844, 6115.7247923844425, 6179.443850053517, 6182.783602573888, 6200.038993955944, 6163.876722465436, 6189.35011823752, 6217.285012223652, 6320.367963203643, 6337.588056776295, 6177.876442471215, 6180.505559555315, 6189.288231853395, 6191.597546159485, 6192.690365481798, 6121.0, 6177.7837775677635, 6199.442050215503, 6199.907001395073, 6202.81391558254, 5957.582969192115, 5971.522278217819, 6035.849103772441, 6052.364501727431, 6056.0, 6119.8776024478375, 6151.661658608819, 6155.722992465439, 6163.753449862134, 6164.7842325518395, 5898.174255604305, 5929.02171141774, 6027.427394397525, 6032.065029920369, 6061.6666083365835], "value": 5774.845055803117, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.544963920926, 837.1753822484851, 853.8719192121183, 903.5798353765498, 918.912703293187, 31189.376212475738, 43298.783506082465, 44003.89990250245, 44044.0, 44050.999999999956, 40499.39250911239, 40695.186096278056, 40728.79635601818, 45488.0, 45702.57230707694, 7589.468737188399, 9194.080591940787, 9312.534373281344, 9320.72037838866, 9338.0, 7683.270089341504, 10535.209859260547, 10755.892441075568, 10758.300710453796, 10759.408232547246, 10960.342379457219, 10969.341839489656, 10987.340759554452, 10987.835182472269, 11006.119510439186, 10879.83680244797, 10899.1280697544, 10918.50866710996, 10931.234813563055, 10931.398773067478, 10642.201834862339, 10707.089897358655, 10707.625233116882, 10709.46452677363, 10709.625163119332, 41288.58711412877, 41464.0, 41527.0, 41552.0, 41607.167856643, 4174.227767862955, 4182.100848317596, 4227.894302642428, 4302.978485107555, 4343.283358245885, 27657.44685106307, 27725.722742772516, 28398.29004274889, 28720.281992950135, 29048.41903161925, 3787.16682329887, 3801.923961520754, 3812.4662547243406, 3812.5234345706785, 3863.2466668999555, 230645.0, 231427.0, 231815.0, 231983.9999999983, 232366.9999999983, 53660.0, 53733.0, 53782.462175378525, 53798.0, 53883.19175212375, 55276.72361638166, 55820.0, 55858.720706396205, 55864.0, 56271.0, 16475.258613362428, 16771.2452939618, 16795.91602041982, 16878.409255675993, 16883.409080682362, 11164.106871450265, 11431.942840285745, 14723.852761472463, 14725.852741472663, 14730.852691473163, 13051.28217948003, 13298.202107873558, 13350.265735384648, 13425.530106446422, 13439.664008399868, 5517.393086760453, 5519.936435278379, 5548.91676624851, 5576.525995290446, 5598.720063996784, 1173.636172786439, 1186.4838795123976, 1208.353530860985, 1212.9090318226167, 1213.9089568282413, 29157.315644178176, 29352.706472935424, 29600.259993500335, 29789.851050744608, 30069.097927062223, 1244.4275633208645, 1245.0413181850106, 1264.4626033935724, 1274.439246731435, 1298.8311519502404, 15573.143477108868, 15740.92129539345, 15756.92121539385, 15760.842391575938, 15990.76013859793, 288730.0, 288931.0, 290131.0, 290246.0, 291176.0, 56700.43299567034, 56870.146947795816, 56951.43048569544, 57060.144097838565, 57312.71343643338, 1512.7957725706888, 1517.6888737808722, 1528.0755143138463, 1532.318118437307, 1536.1244090868097, 27322.5901611472, 28591.714082859737, 29007.41985160327, 29146.41707165887, 29152.27119322034, 24552.631710524714, 45724.314135287335, 46571.0, 46952.29571556361, 47184.29223561718, 331896.0, 333356.0, 334066.0, 334565.0, 335170.0, 24310.149144780557, 24590.0, 24592.631110533, 30235.848820755757, 30398.848005760716, 38615.0, 38888.80555597204, 42277.78861105675, 42411.787941060094, 42443.36334954917, 34354.96935091951, 34487.31025379529, 34605.30789384249, 34722.47916281207, 34736.82631586927, 32355.0, 32665.34669306648, 32716.0, 32950.34099318048, 33114.33771324608, 34862.47706284357, 35350.0, 35393.46909796304, 35594.64405355913, 35686.64313356833, 28518.42963140767, 29805.5529167067, 31078.00972061971, 31280.061598152093, 31288.0, 24692.0, 25172.0, 25215.243542693748, 25291.49417011686, 25370.365740856625], "value": 18920.474593128052, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.31892118585665, 474.19150348655546, 479.67142507382465, 482.315112540193, 488.6359662051771, 21044.473888152803, 21301.893490532566, 21500.247491337806, 21500.677489837646, 21537.56924861502, 22421.663675044845, 22808.65787013196, 22892.198773042946, 22955.42611434715, 23107.537849243006, 6659.167604049494, 6682.5656332338485, 6775.32246775321, 6787.76242831501, 6795.7961261162, 6718.160229971254, 6830.180378354579, 7305.159906610755, 7571.31858132768, 7639.0, 7241.312075352859, 7780.066392032964, 7789.260020298063, 7791.571463569501, 7792.142864284924, 7260.528065675714, 7346.926530734731, 7353.338199562038, 7356.080489938758, 7357.521761085539, 7136.892946605805, 7507.099148102263, 7526.134494533144, 7548.509346892434, 7559.886601700979, 24156.39609009771, 24488.632670509956, 24615.138470153637, 26043.348916277057, 26158.476830463285, 2796.930076748077, 2945.0870230228697, 2963.7184467475554, 2968.257935516121, 3077.584526088972, 15664.530064098095, 15859.60350991223, 15969.84030159695, 16041.518754437386, 17230.0, 2146.5706858628337, 2235.094786611409, 2238.9888050559807, 2273.238465114189, 2290.4388424835856, 113087.43456282748, 119602.0, 120062.39968800187, 120416.0, 120806.0, 15789.842101579066, 16234.918825405797, 17122.914385427994, 17707.291708331522, 18113.18490667923, 30377.0, 30408.391832163234, 30448.0, 30453.69546304553, 30514.0, 9711.125998660154, 9902.009799020041, 10007.049330313608, 10060.861633245095, 10226.744331391776, 8321.167883211752, 8343.541105239148, 8523.701670441505, 8561.52911589856, 8615.39692221551, 8806.91193088061, 9056.818863622691, 9123.178913897782, 9310.441373517611, 9343.785307909928, 3621.2214373909737, 3726.552813662378, 3783.6783873370523, 3823.9426408603895, 3872.668187513436, 909.790748127921, 914.4376208631777, 919.3426699909596, 927.8515437529962, 929.5863340813409, 19725.013749312762, 21099.894500527706, 21102.155913763276, 21358.78641213599, 21586.89206553957, 926.7266156483853, 926.8702381666437, 929.7675581104724, 933.7712260496222, 938.9248860091176, 10877.0754485868, 11193.10455163585, 11349.375784331942, 11518.769624607461, 11690.415479226005, 527827.0, 579374.0, 595041.0, 609949.0, 620696.0, 114046.0, 114107.42946285216, 115672.2163891802, 117075.0, 117631.0, 1276.2980360801523, 1291.460797771911, 1301.225770666452, 1309.8886594639562, 1315.5395611535887, 17802.643947120727, 18072.638547229246, 18373.0, 18502.074896255403, 18683.0, 50031.49968500269, 50303.49696502988, 50666.74666626643, 51358.743206285224, 51377.48622513877, 59911.700441499255, 60336.396636033074, 61865.0, 62247.37752622416, 67503.3249667497, 11842.52629894829, 12261.325627090595, 12451.0, 12724.491020359083, 12768.808467872803, 13665.521706740217, 13679.179249245077, 13725.176489410267, 13729.588112356645, 13846.792298115737, 10865.891341086804, 11461.942690286494, 11544.653660390202, 11589.6523104307, 11625.360605166798, 12053.57812476559, 12235.449404776984, 12361.134720569475, 12519.248845069325, 12522.874771252535, 11182.944085279521, 11697.23967942081, 12258.064516129174, 12373.814392783936, 12388.752224955631, 12012.219205751948, 12314.777137072277, 12353.073519485895, 12411.441485133371, 12471.376431178587, 11382.886171138183, 11842.348670823187, 12367.69080772988, 12582.18215815969, 12725.55460558876], "value": 11372.120953080985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.041707264669, 1538.884308876065, 1569.9843001569984, 1580.0677600215874, 1598.7442009278518, 9521.476318802463, 11353.772924541505, 11599.30404175749, 11634.767304653902, 11641.417929103553, 11771.646850594474, 11858.881411185885, 11863.110266729987, 11869.821952670716, 11871.762564748722, 1979.4160722586798, 2380.238323736405, 2418.5888398972215, 2418.661387405765, 2426.793722533578, 2058.3927741316274, 2224.810891074261, 2289.416198869286, 2304.758000409958, 2306.5271619318, 2314.4445333120016, 2333.7899589036983, 2338.1465764995824, 2342.437814924423, 2347.1315613223132, 2268.5803126421665, 2290.3815969688258, 2309.6304591265402, 2310.7342655594653, 2313.1788215183537, 2220.811231045363, 2227.354067320475, 2227.365200917731, 2231.4979129695853, 2258.7515373308925, 11695.35675537845, 11708.180427370087, 11744.530218791238, 11744.765104697859, 11783.116266280063, 5666.348369937427, 5829.096490044008, 5836.9124463133085, 5841.591088623798, 5843.065109582446, 3137.7176054155007, 3182.6658200888805, 3237.2392487765355, 3255.023492952105, 3262.2986057997646, 1147.1797664669718, 1173.2256710570982, 1192.3322939154102, 1221.7617564574912, 1261.2306493039239, 17743.911280443645, 17753.55616109595, 17859.553511162325, 17860.732089018675, 17879.642407151914, 4476.597106260452, 4509.413776209138, 4623.144718227139, 4631.560001799824, 4716.834910778106, 14949.103053816805, 15024.474143404928, 15027.774583381259, 15030.248487575578, 15033.022853514487, 5920.171176035358, 5923.7926672566255, 5928.525717942641, 5935.792247271324, 5938.020226662638, 5307.310049693515, 5309.41596424393, 5356.437574054746, 5401.3518377794135, 5438.646487978269, 4112.832374532776, 4164.570267160164, 4170.061736109351, 4209.284421648327, 4221.2190744712325, 1111.6720567432626, 1114.6321713834416, 1118.9664310070712, 1126.7577470843808, 1132.5016992523263, 1029.583018877356, 1062.2988827374052, 1063.3194755356578, 1073.1254027967182, 1073.5169173871789, 7144.428445724329, 7178.928210717826, 7228.096487939008, 7261.8547629047125, 7287.781366559012, 1027.9691609251734, 1039.5789705169418, 1052.3054783842626, 1053.5733028123623, 1070.8072546941626, 4581.885452863705, 4600.470945841204, 4606.170889239969, 4614.884627884263, 4650.395448591661, 14298.85701142996, 14809.185494797674, 15009.774853377208, 15073.773893391608, 15079.54761357161, 14774.18741969202, 14784.782282657687, 14804.0, 14965.251737413086, 14969.550913472613, 10555.366677999345, 10605.946970265253, 10644.733881652866, 10754.354738715701, 10770.730731731614, 7377.0409846719585, 7447.143578488543, 7450.776476705708, 7588.506747061423, 7610.581418022062, 12791.616251512469, 13563.38964746569, 13758.449662013407, 13796.586102416542, 13910.0, 13809.654758631115, 13835.515756948862, 13983.300834958009, 14029.859701403264, 14130.50543230982, 9589.760255993657, 9914.30599858003, 9924.553395097093, 9964.302498825302, 10191.082802547806, 11016.834747478633, 11195.0, 11400.429978500875, 11404.885951140383, 11548.769024619629, 9624.51877406141, 9627.9037209627, 9733.221342292458, 9841.114299713061, 9977.551010204703, 9308.0, 9346.906530934604, 9349.53252337394, 9412.435253884789, 9538.28462865274, 8589.828203436022, 8769.649214031368, 8769.780755481164, 8775.166359195866, 8782.385233033627, 6513.837154071186, 6535.183102112236, 6578.703958321791, 6588.472922166119, 6652.866942661023, 6456.741730330734, 6687.063811066358, 6692.59844409337, 6703.262641109376, 6823.317668233137], "value": 5437.814390245983, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.2284482328398, 428.4686988134713, 433.932740425234, 433.93490976353564, 439.46604875076775, 5213.244079608455, 5220.74702071503, 5251.973740131303, 5253.789848406064, 5262.0797505858145, 4848.272759086139, 5127.435982041972, 5130.101492656656, 5132.28148059272, 5170.353705786777, 4360.302351623741, 4371.562843715635, 4377.190219809329, 4379.4525684289465, 4392.253316936112, 4411.073674528353, 4421.557844215568, 4457.799399027052, 4466.73199608023, 4488.0799436115685, 4355.823927539563, 4465.620422264112, 4476.418065651461, 4476.709013914102, 4484.932726009112, 4357.978210108945, 4388.188185185719, 4402.207602631525, 4416.807461985262, 4469.374287599739, 4121.8969525762095, 4123.3196522573735, 4147.3778933159965, 4149.792510374469, 4161.3978618231895, 5048.899022019539, 5056.721880296583, 5070.569001634865, 5094.337736094284, 5102.69383836971, 4935.519344196762, 5080.720560369178, 5082.390113186404, 5118.129917913926, 5157.813702848328, 5450.075945319364, 5451.727413629303, 5461.781528738846, 5467.699276539789, 5468.945310546923, 4545.840640754677, 4548.408706868119, 4588.655850811169, 4596.310553416981, 4599.954000459986, 5456.881339325429, 5468.835934921959, 5507.339119305669, 5518.227448157261, 5690.317161940552, 4718.386609740712, 4732.24906784485, 4734.171519983989, 4751.3348131261655, 4753.120672675497, 4733.171694953369, 4749.35883655702, 4756.714597124114, 4787.736674482867, 4789.353437285922, 4945.184044632595, 5024.84925452237, 5048.444671086178, 5071.055720672315, 5105.438401775802, 5418.0, 5467.644603100785, 5475.479829416199, 5478.890422191534, 5492.945070549324, 1630.290823491785, 1638.680457310813, 1649.7030534503904, 1654.247317470548, 1657.7927759030122, 1234.5679012345786, 1286.3182513267982, 1292.140726416941, 1302.4724986380531, 1306.5035286591224, 5331.0, 5350.839474815762, 5351.785928562814, 5368.973155134199, 5369.624126311199, 5573.41479144692, 5602.663840169603, 5606.943930560642, 5618.943810561924, 5622.943770562324, 5164.8192313268855, 5283.339582552181, 5291.841244762663, 5336.519713225828, 5339.665083729068, 2921.9123426297247, 2922.839243841609, 2934.9706502935123, 2939.4855900217376, 2962.8000659732843, 5576.358718747315, 5767.798127065616, 5769.451902069297, 5823.330317013598, 5837.153612726216, 5673.290838645169, 5692.288463942007, 5700.572457065737, 5700.866871518117, 5747.0, 5765.654060756284, 5800.0, 5808.709564521757, 5822.729135637105, 5878.882422351615, 5362.276092727432, 5557.416471270459, 5578.330600327987, 5628.086450606814, 5631.958087753778, 5350.545203657733, 5537.089704052096, 5581.162825576196, 5582.581306401955, 5598.944010559842, 5692.43075692444, 5695.943040569707, 5708.686022268815, 5731.971340143273, 5735.54115670737, 4592.5177856325945, 4730.810767569259, 4740.834070807505, 4747.976260118678, 4748.240281554935, 5464.28964234647, 5656.773729050792, 5665.235193249024, 5700.657960522382, 5711.457906365175, 5502.889942201054, 5519.503244707996, 5523.4200408956485, 5523.502884740393, 5568.192612071146, 5470.425605311385, 5485.122380419114, 5501.4223506532835, 5515.310586176728, 5549.223108764695, 5344.706041167773, 5512.236084453097, 5542.307211598551, 5546.611737178358, 5546.639468434539, 5550.611457197957, 5568.830545585311, 5577.52591029767, 5577.6653400796085, 5578.3584887738425, 5169.224616307584, 5412.810551630674, 5429.185622156708, 5439.374471935778, 5450.482204190595], "value": 4422.722193521617, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.6847781542673, 794.285143370966, 807.7778610882007, 809.9878501822471, 854.1501206299731, 15087.773683394758, 15790.763138552917, 15952.0, 16879.1560421979, 17309.653806923852, 17648.82351176491, 18202.5449363766, 18348.633027339445, 18540.629187416245, 18802.811971880277, 874.9606267717936, 893.6648756716231, 896.1173244354305, 896.3680605173337, 897.4704924094783, 852.1393392673414, 872.2280781508379, 873.7160422862563, 881.6341218394359, 882.0297672560197, 928.4522131942152, 930.1907340613642, 930.502181332987, 930.5486838883136, 930.9022552631977, 925.028719844161, 925.9444433334022, 926.333040211047, 926.5552534783308, 926.7914719188162, 683.9213490448562, 685.3078390825302, 686.4954258619911, 686.7630667419783, 686.8351595617066, 15954.441594544136, 16159.676806463805, 16267.837321626868, 16365.754513682305, 16385.426510072208, 16091.275892584861, 16451.83548164515, 16603.58869496094, 16642.83357166425, 16831.495055148243, 12562.371881405985, 12702.809457858048, 12803.679908002281, 12929.03032272574, 12974.286414247212, 3355.8825441109443, 3368.932621347584, 3388.3053973935284, 3398.677125673057, 3403.1662242750435, 68719.65640171767, 69034.3096569033, 69220.65389673019, 86689.0, 88192.55903720505, 12521.499140034479, 12725.809112863315, 12758.10693251482, 12827.743445131046, 12889.291088990009, 23163.88418057899, 23274.3017709469, 23350.416239593807, 23375.0, 23572.528549428916, 8187.222213889671, 8194.877076843852, 8289.751307460785, 8362.080171181165, 8579.828403431897, 4763.833265835679, 4767.833125840579, 4833.661643684908, 4850.83022094225, 4950.8267210647455, 3448.137965508623, 3540.592831824373, 3546.0957455848593, 3546.2730140321173, 3547.5210846535388, 618.5979113576211, 622.9190205273286, 655.1777519213452, 660.7885476647426, 664.9966750166315, 799.4883274704194, 821.0, 825.9050209226016, 841.3395484544603, 847.8643417053365, 10832.78334433307, 11081.556737730562, 11159.27464714791, 11568.942155289169, 11700.180987330805, 748.8127968007998, 757.9431542634325, 765.7434759355567, 765.9272369124924, 774.6088225446226, 4918.9508104919205, 5264.315638966987, 5269.920951185735, 5276.630635855453, 5277.894442111136, 81913.0, 82990.58504707438, 83169.0, 85254.57372713096, 87366.0, 45195.774021129684, 61069.38930610637, 62772.372276277565, 72046.63976680083, 73625.0, 67376.6631166841, 68240.3175968234, 68360.65819670969, 68487.0, 68991.96512052324, 11704.414779260833, 12515.687107822378, 12657.612041063507, 12681.112322137362, 12853.678658033625, 46052.539474606165, 46310.768446157555, 46630.13479460784, 47489.76255118702, 47603.5239647613, 54097.45902540924, 55253.44746552483, 55411.0, 56643.71678141583, 56813.715931420076, 12234.75530489403, 12332.32172230536, 12433.440495177558, 12575.371231438574, 12827.42276597574, 16195.271212795687, 16272.918635406748, 16537.66924661524, 17526.912365438093, 17548.473545793648, 14698.77951830702, 14712.779308310597, 14923.0, 15017.32422040989, 15177.544673659808, 15390.84609153939, 15404.383824647337, 15571.065736055873, 15682.607934801721, 15704.60738481547, 15442.691146176789, 15723.764143537628, 15733.370665173265, 15836.604084897508, 16182.919085404968, 11227.438628068727, 11331.490082946122, 11374.260673056226, 11567.88432115668, 11619.76760464769, 10903.945480272549, 11023.944880275869, 11132.554697811996, 11256.21206515536, 11340.886591133984], "value": 7764.852249645242, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 113.0, 114.0, 114.0, 112.0, 113.0, 113.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 121.0, 121.0, 153.0, 118.0, 120.0, 116.0, 116.0, 131.0, 117.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 75.0, 76.0, 78.0, 76.0, 97.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 83.0, 81.0, 81.0, 108.0, 82.0, 83.0, 106.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 101.0, 94.0, 93.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 53.0, 54.0, 53.0, 53.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 75.0, 79.0, 79.0, 84.0, 83.0, 81.0, 80.0, 80.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 121.0, 126.0, 120.0, 123.0, 118.0, 125.0, 171.0, 120.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 167.0, 157.0, 163.0, 160.0, 160.0, 159.0, 161.0, 162.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0, 64.0, 59.0], "value": 60.4, "unit": "score"}]}]} 09:24:17 INFO - Return code: 0 09:24:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:24:17 ERROR - # TBPL SUCCESS # 09:24:17 INFO - Running post-action listener: _resource_record_post_action 09:24:17 INFO - [mozharness: 2017-03-19 16:24:17.390366Z] Finished run-tests step (success) 09:24:17 INFO - Running post-run listener: _resource_record_post_run 09:24:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 364187648; Read time: 168; Write time: 318916 09:24:17 INFO - TinderboxPrint: CPU usage
13.1% 09:24:17 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 09:24:17 INFO - TinderboxPrint: I/O write bytes / time
364,187,648 / 318,916 09:24:17 INFO - TinderboxPrint: CPU idle
8,271.3 (86.9%) 09:24:17 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 09:24:17 INFO - TinderboxPrint: Swap in / out
0 / 0 09:24:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110960640; Read time: 0; Write time: 151260 09:24:17 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 253227008; Read time: 168; Write time: 167656 09:24:18 INFO - Running post-run listener: _upload_blobber_files 09:24:18 INFO - Blob upload gear active. 09:24:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:24:18 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 09:24:18 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'] 09:24:18 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 09:24:18 INFO - (blobuploader) - INFO - Open directory for files ... 09:24:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:24:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:24:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:19 INFO - (blobuploader) - INFO - Done attempting. 09:24:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:24:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:24:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:20 INFO - (blobuploader) - INFO - Done attempting. 09:24:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:24:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:23 INFO - (blobuploader) - INFO - Done attempting. 09:24:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:24:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:23 INFO - (blobuploader) - INFO - Done attempting. 09:24:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:24:23 INFO - Return code: 0 09:24:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:24:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:24:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1d8998713b90d7dc6cc891e3b8e07824c34f30fb3c31b926b310dd560b27c4938aa16f66f4778e743f4772df19233ee4142976d4c8f066433163a050c9ee894", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc40675e547e55f5b71bc77cb88b0714d7a25c607ae5816793f5516fd0297e7395450ad285ac29f1014cb9158d2c13f3f37e0f6a83f94c4d84262b8f774b7294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9c5c1b68efc1f8ab67c8e53befddb069f26b40dcb4a5437f1c74ce6c746cb2ecdf99d8a11f13eb787aa112313504017754bab56324c50771dc213bcb2a56a1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42efae14958e1014660a28a2a21305e8085ac88280a1212df280b4e5593c6cf387c60cd9c9f1e5dc748fd0fdff3bc24c678228fa19169aab6227233c76432cc9"} 09:24:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:24:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:24:23 INFO - Contents: 09:24:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1d8998713b90d7dc6cc891e3b8e07824c34f30fb3c31b926b310dd560b27c4938aa16f66f4778e743f4772df19233ee4142976d4c8f066433163a050c9ee894", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc40675e547e55f5b71bc77cb88b0714d7a25c607ae5816793f5516fd0297e7395450ad285ac29f1014cb9158d2c13f3f37e0f6a83f94c4d84262b8f774b7294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9c5c1b68efc1f8ab67c8e53befddb069f26b40dcb4a5437f1c74ce6c746cb2ecdf99d8a11f13eb787aa112313504017754bab56324c50771dc213bcb2a56a1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42efae14958e1014660a28a2a21305e8085ac88280a1212df280b4e5593c6cf387c60cd9c9f1e5dc748fd0fdff3bc24c678228fa19169aab6227233c76432cc9"} 09:24:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:24:23 INFO - Copying logs to upload dir... 09:24:23 INFO - mkdir: /builds/slave/test/build/upload/logs 09:24:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.739732 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-19 09:24:21.694401) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-19 09:24:21.697697) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824 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/b1d8998713b90d7dc6cc891e3b8e07824c34f30fb3c31b926b310dd560b27c4938aa16f66f4778e743f4772df19233ee4142976d4c8f066433163a050c9ee894", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc40675e547e55f5b71bc77cb88b0714d7a25c607ae5816793f5516fd0297e7395450ad285ac29f1014cb9158d2c13f3f37e0f6a83f94c4d84262b8f774b7294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9c5c1b68efc1f8ab67c8e53befddb069f26b40dcb4a5437f1c74ce6c746cb2ecdf99d8a11f13eb787aa112313504017754bab56324c50771dc213bcb2a56a1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42efae14958e1014660a28a2a21305e8085ac88280a1212df280b4e5593c6cf387c60cd9c9f1e5dc748fd0fdff3bc24c678228fa19169aab6227233c76432cc9"} build_url:https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/P8MLHpSRRHK0mVz6ssH0uA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1d8998713b90d7dc6cc891e3b8e07824c34f30fb3c31b926b310dd560b27c4938aa16f66f4778e743f4772df19233ee4142976d4c8f066433163a050c9ee894", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc40675e547e55f5b71bc77cb88b0714d7a25c607ae5816793f5516fd0297e7395450ad285ac29f1014cb9158d2c13f3f37e0f6a83f94c4d84262b8f774b7294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9c5c1b68efc1f8ab67c8e53befddb069f26b40dcb4a5437f1c74ce6c746cb2ecdf99d8a11f13eb787aa112313504017754bab56324c50771dc213bcb2a56a1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42efae14958e1014660a28a2a21305e8085ac88280a1212df280b4e5593c6cf387c60cd9c9f1e5dc748fd0fdff3bc24c678228fa19169aab6227233c76432cc9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-19 09:24:21.723428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:24:21.723747) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489932474.319277-1196511824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:24:21.806257) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-19 09:24:21.806594) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-19 09:24:21.806972) ========= ========= Total master_lag: 0.21 =========