builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-089 starttime: 1491765621.87 results: success (0) revision: f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:21.870101) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:21.870601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:21.870905) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:21.914647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:21.915150) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-09 12:20:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.9M=0s 2017-04-09 12:20:22 (40.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159633 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:22.114010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:22.114364) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019493 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:22.193159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:22.193495) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae --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=8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-09 12:20:22,945 truncating revision to first 12 chars 2017-04-09 12:20:22,945 Setting DEBUG logging. 2017-04-09 12:20:22,945 attempt 1/10 2017-04-09 12:20:22,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f51bf8ee1e7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-09 12:20:23,269 unpacking tar archive at: mozilla-central-f51bf8ee1e7b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693888 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:22.999441) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:22.999749) ========= script_repo_revision: f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:23.000216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:23.000504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 12:20:23.015803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-09 12:20:23.016118) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:20:23 INFO - MultiFileLogger online at 20170409 12:20:23 in /builds/slave/test 12:20:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:20:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:20:23 INFO - {'append_to_log': False, 12:20:23 INFO - 'base_work_dir': '/builds/slave/test', 12:20:23 INFO - 'blob_upload_branch': 'Firefox', 12:20:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:20:23 INFO - 'branch': 'Firefox', 12:20:23 INFO - 'buildbot_json_path': 'buildprops.json', 12:20:23 INFO - 'config_files': ('talos/linux_config.py',), 12:20:23 INFO - 'default_actions': ('clobber', 12:20:23 INFO - 'read-buildbot-config', 12:20:23 INFO - 'download-and-extract', 12:20:23 INFO - 'populate-webroot', 12:20:23 INFO - 'create-virtualenv', 12:20:23 INFO - 'install', 12:20:23 INFO - 'run-tests'), 12:20:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:20:23 INFO - 'download_minidump_stackwalk': True, 12:20:23 INFO - 'download_symbols': 'ondemand', 12:20:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:20:23 INFO - 'tooltool.py': '/tools/tooltool.py', 12:20:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:20:23 INFO - '/tools/misc-python/virtualenv.py')}, 12:20:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:20:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:20:23 INFO - 'gecko_profile': False, 12:20:23 INFO - 'gecko_profile_interval': 0, 12:20:23 INFO - 'installer_path': 'installer.exe', 12:20:23 INFO - 'log_level': 'info', 12:20:23 INFO - 'log_name': 'talos', 12:20:23 INFO - 'log_to_console': True, 12:20:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:20:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:20:23 INFO - 'opt_config_files': (), 12:20:23 INFO - 'pip_index': False, 12:20:23 INFO - 'suite': 'dromaeojs', 12:20:23 INFO - 'system_bits': '32', 12:20:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:20:23 INFO - 'title': 'talos-linux64-ix-089', 12:20:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:20:23 INFO - 'use_talos_json': True, 12:20:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:20:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:20:23 INFO - 'work_dir': 'build'} 12:20:23 INFO - [mozharness: 2017-04-09 19:20:23.767265Z] Running clobber step. 12:20:23 INFO - Running pre-action listener: _resource_record_pre_action 12:20:23 INFO - Running main action method: clobber 12:20:23 INFO - rmtree: /builds/slave/test/build 12:20:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:20:24 INFO - Running post-action listener: _resource_record_post_action 12:20:24 INFO - [mozharness: 2017-04-09 19:20:24.699846Z] Finished clobber step (success) 12:20:24 INFO - [mozharness: 2017-04-09 19:20:24.699947Z] Running read-buildbot-config step. 12:20:24 INFO - Running pre-action listener: _resource_record_pre_action 12:20:24 INFO - Running main action method: read_buildbot_config 12:20:24 INFO - Using buildbot properties: 12:20:24 INFO - { 12:20:24 INFO - "project": "", 12:20:24 INFO - "product": "firefox", 12:20:24 INFO - "who": "archaeopteryx@coole-files.de", 12:20:24 INFO - "installer_path": "public/build/target.tar.bz2", 12:20:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:20:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:20:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 12:20:24 INFO - "stage_platform": "linux64-pgo", 12:20:24 INFO - "basedir": "/builds/slave/test", 12:20:24 INFO - "buildnumber": 124, 12:20:24 INFO - "platform": "ubuntu64_hw", 12:20:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:20:24 INFO - "slavebuilddir": "test", 12:20:24 INFO - "taskId": "H1B47HpeR1uSPIsC0GrtRg", 12:20:24 INFO - "branch": "mozilla-central", 12:20:24 INFO - "script_repo_revision": "production", 12:20:24 INFO - "revision": "f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae", 12:20:24 INFO - "slavename": "talos-linux64-ix-089", 12:20:24 INFO - "repo_path": "mozilla-central" 12:20:24 INFO - } 12:20:24 INFO - Finding installer, test and symbols from parent task. 12:20:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H1B47HpeR1uSPIsC0GrtRg'}, attempt #1 12:20:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H1B47HpeR1uSPIsC0GrtRg'}, attempt #1 12:20:25 INFO - Task dependencies: e8ZVVexxShq1swI3DCjFWA 12:20:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA'}, attempt #1 12:20:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.tar.bz2 12:20:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/test_packages.json 12:20:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.crashreporter-symbols.zip 12:20:26 INFO - Running post-action listener: _resource_record_post_action 12:20:26 INFO - [mozharness: 2017-04-09 19:20:26.103216Z] Finished read-buildbot-config step (success) 12:20:26 INFO - [mozharness: 2017-04-09 19:20:26.103435Z] Running download-and-extract step. 12:20:26 INFO - Running pre-action listener: _resource_record_pre_action 12:20:26 INFO - Running main action method: download_and_extract 12:20:26 INFO - mkdir: /builds/slave/test/build/tests 12:20:26 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')]} 12:20:26 INFO - trying https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.test_packages.json 12:20:26 INFO - Downloading https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:20:26 INFO - Downloaded 986 bytes. 12:20:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:20:26 INFO - Using the following test package requirements: 12:20:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:20:26 INFO - u'common': [u'target.common.tests.zip'], 12:20:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:20:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:20:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:20:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:20:26 INFO - u'mozbase': [u'target.common.tests.zip'], 12:20:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:20:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:20:26 INFO - u'web-platform': [u'target.common.tests.zip', 12:20:26 INFO - u'target.web-platform.tests.zip'], 12:20:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:20:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:20:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.common.tests.zip 12:20:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:20:26 INFO - Fetch https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.common.tests.zip into memory 12:20:27 INFO - Expected file size: 60365973 12:20:27 INFO - Obtained file size: 60365973 12:20:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:20:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.common.tests.zip 12:20:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:20:37 INFO - Fetch https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.common.tests.zip into memory 12:20:38 INFO - Expected file size: 60365973 12:20:38 INFO - Obtained file size: 60365973 12:20:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.talos.tests.zip 12:20:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:20:49 INFO - Fetch https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.talos.tests.zip into memory 12:20:50 INFO - Expected file size: 14404129 12:20:50 INFO - Obtained file size: 14404129 12:20:50 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')]} 12:20:50 INFO - trying https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.tar.bz2 12:20:50 INFO - Downloading https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:20:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:20:51 INFO - Downloaded 63394720 bytes. 12:20:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.tar.bz2 12:20:51 INFO - mkdir: /builds/slave/test/properties 12:20:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:20:51 INFO - Writing to file /builds/slave/test/properties/build_url 12:20:51 INFO - Contents: 12:20:51 INFO - build_url:https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.tar.bz2 12:20:51 INFO - Running post-action listener: _resource_record_post_action 12:20:51 INFO - Running post-action listener: set_extra_try_arguments 12:20:51 INFO - [mozharness: 2017-04-09 19:20:51.705278Z] Finished download-and-extract step (success) 12:20:51 INFO - [mozharness: 2017-04-09 19:20:51.705375Z] Running populate-webroot step. 12:20:51 INFO - Running pre-action listener: _resource_record_pre_action 12:20:51 INFO - Running main action method: populate_webroot 12:20:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:20:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:20:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:20:51 INFO - '--tppagecycles', 12:20:51 INFO - '7'], 12:20:51 INFO - 'tests': ['tsvgm']}}, 12:20:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:20:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:20:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:20:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:20:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:20:51 INFO - 'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:20:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:20:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:20:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:20:51 INFO - 'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['damp', 'tps']}, 12:20:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:20:51 INFO - 'tests': ['damp', 'tps']}, 12:20:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['dromaeo_dom']}, 12:20:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:20:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['basic_compositor_video']}, 12:20:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:20:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['a11yr', 12:20:51 INFO - 'ts_paint', 12:20:51 INFO - 'tpaint', 12:20:51 INFO - 'sessionrestore', 12:20:51 INFO - 'sessionrestore_no_auto_restore', 12:20:51 INFO - 'tabpaint']}, 12:20:51 INFO - 'other-e10s': {'tests': ['a11yr', 12:20:51 INFO - 'ts_paint', 12:20:51 INFO - 'tpaint', 12:20:51 INFO - 'sessionrestore', 12:20:51 INFO - 'sessionrestore_no_auto_restore', 12:20:51 INFO - 'tabpaint']}, 12:20:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:20:51 INFO - 'ts_paint', 12:20:51 INFO - 'tpaint', 12:20:51 INFO - 'sessionrestore', 12:20:51 INFO - 'sessionrestore_no_auto_restore', 12:20:51 INFO - 'tabpaint']}, 12:20:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:20:51 INFO - 'ts_paint', 12:20:51 INFO - 'tpaint', 12:20:51 INFO - 'sessionrestore', 12:20:51 INFO - 'sessionrestore_no_auto_restore', 12:20:51 INFO - 'tabpaint']}, 12:20:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['a11yr', 12:20:51 INFO - 'ts_paint', 12:20:51 INFO - 'tpaint', 12:20:51 INFO - 'sessionrestore', 12:20:51 INFO - 'sessionrestore_no_auto_restore', 12:20:51 INFO - 'tabpaint']}, 12:20:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['a11yr', 12:20:51 INFO - 'ts_paint', 12:20:51 INFO - 'tpaint', 12:20:51 INFO - 'sessionrestore', 12:20:51 INFO - 'sessionrestore_no_auto_restore', 12:20:51 INFO - 'tabpaint']}, 12:20:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['tsvgx', 12:20:51 INFO - 'tsvgr_opacity', 12:20:51 INFO - 'tart', 12:20:51 INFO - 'tscrollx', 12:20:51 INFO - 'cart', 12:20:51 INFO - 'tsvg_static']}, 12:20:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:20:51 INFO - 'tsvgr_opacity', 12:20:51 INFO - 'tart', 12:20:51 INFO - 'tscrollx', 12:20:51 INFO - 'cart', 12:20:51 INFO - 'tsvg_static']}, 12:20:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:20:51 INFO - 'talos_options': ['--disable-e10s'], 12:20:51 INFO - 'tests': ['tp5o']}, 12:20:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:20:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:20:51 INFO - 'talos_options': ['--disable-e10s', 12:20:51 INFO - '--xperf_path', 12:20:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:20:51 INFO - 'tests': ['tp5n']}, 12:20:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:20:51 INFO - 'talos_options': ['--xperf_path', 12:20:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:20:51 INFO - 'tests': ['tp5n']}}, 12:20:51 INFO - 'talos.zip': {'path': '', 12:20:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:20:51 INFO - Running post-action listener: _resource_record_post_action 12:20:51 INFO - [mozharness: 2017-04-09 19:20:51.718442Z] Finished populate-webroot step (success) 12:20:51 INFO - [mozharness: 2017-04-09 19:20:51.718533Z] Running create-virtualenv step. 12:20:51 INFO - Running pre-action listener: _resource_record_pre_action 12:20:51 INFO - Running main action method: create_virtualenv 12:20:51 INFO - Creating virtualenv /builds/slave/test/build/venv 12:20:51 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 12:20:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:20:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:20:51 INFO - Using real prefix '/usr' 12:20:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:20:52 INFO - Installing distribute.............................................................................................................................................................................................done. 12:20:54 INFO - Installing pip.................done. 12:20:54 INFO - Return code: 0 12:20:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:20:54 INFO - Reading from file tmpfile_stdout 12:20:54 INFO - Output received: 12:20:54 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) 12:20:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:54 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 0x194e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', '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 12:20:54 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 12:20:54 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 12:20:54 INFO - Using env: {'DISPLAY': ':0', 12:20:54 INFO - 'HOME': '/home/cltbld', 12:20:54 INFO - 'LANG': 'en_US.UTF-8', 12:20:54 INFO - 'LANGUAGE': 'en_US:en', 12:20:54 INFO - 'LOGNAME': 'cltbld', 12:20:54 INFO - 'MAIL': '/var/mail/cltbld', 12:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:54 INFO - 'MOZ_NO_REMOTE': '1', 12:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:54 INFO - 'NO_EM_RESTART': '1', 12:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:54 INFO - 'PWD': '/builds/slave/test', 12:20:54 INFO - 'SHELL': '/bin/bash', 12:20:54 INFO - 'SHLVL': '1', 12:20:54 INFO - 'TERM': 'linux', 12:20:54 INFO - 'TMOUT': '86400', 12:20:54 INFO - 'USER': 'cltbld', 12:20:54 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:54 INFO - '_': '/tools/buildbot/bin/python'} 12:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:54 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 12:20:54 INFO - Cleaning up... 12:20:54 INFO - Return code: 0 12:20:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:54 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 0x194e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', '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 12:20:54 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 12:20:54 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 12:20:54 INFO - Using env: {'DISPLAY': ':0', 12:20:54 INFO - 'HOME': '/home/cltbld', 12:20:54 INFO - 'LANG': 'en_US.UTF-8', 12:20:54 INFO - 'LANGUAGE': 'en_US:en', 12:20:54 INFO - 'LOGNAME': 'cltbld', 12:20:54 INFO - 'MAIL': '/var/mail/cltbld', 12:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:54 INFO - 'MOZ_NO_REMOTE': '1', 12:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:54 INFO - 'NO_EM_RESTART': '1', 12:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:54 INFO - 'PWD': '/builds/slave/test', 12:20:54 INFO - 'SHELL': '/bin/bash', 12:20:54 INFO - 'SHLVL': '1', 12:20:54 INFO - 'TERM': 'linux', 12:20:54 INFO - 'TMOUT': '86400', 12:20:54 INFO - 'USER': 'cltbld', 12:20:54 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:54 INFO - '_': '/tools/buildbot/bin/python'} 12:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:54 INFO - Downloading/unpacking psutil>=3.1.1 12:20:54 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 12:20:54 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 12:20:54 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 12:20:54 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 12:20:54 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 12:20:54 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 12:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:20:57 INFO - Installing collected packages: psutil 12:20:57 INFO - Running setup.py install for psutil 12:20:57 INFO - building 'psutil._psutil_linux' extension 12:20:57 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 12:20:57 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 12:20:57 INFO - building 'psutil._psutil_posix' extension 12:20:57 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 12:20:57 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 12:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:20:57 INFO - Successfully installed psutil 12:20:57 INFO - Cleaning up... 12:20:57 INFO - Return code: 0 12:20:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:20:57 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')]} 12:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:57 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')]} 12:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:57 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 0x194e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', '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 12:20:57 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 12:20:57 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 12:20:57 INFO - Using env: {'DISPLAY': ':0', 12:20:57 INFO - 'HOME': '/home/cltbld', 12:20:57 INFO - 'LANG': 'en_US.UTF-8', 12:20:57 INFO - 'LANGUAGE': 'en_US:en', 12:20:57 INFO - 'LOGNAME': 'cltbld', 12:20:57 INFO - 'MAIL': '/var/mail/cltbld', 12:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:57 INFO - 'MOZ_NO_REMOTE': '1', 12:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:57 INFO - 'NO_EM_RESTART': '1', 12:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:57 INFO - 'PWD': '/builds/slave/test', 12:20:57 INFO - 'SHELL': '/bin/bash', 12:20:57 INFO - 'SHLVL': '1', 12:20:57 INFO - 'TERM': 'linux', 12:20:57 INFO - 'TMOUT': '86400', 12:20:57 INFO - 'USER': 'cltbld', 12:20:57 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:57 INFO - '_': '/tools/buildbot/bin/python'} 12:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:20:59 INFO - Installing collected packages: mozsystemmonitor 12:20:59 INFO - Running setup.py install for mozsystemmonitor 12:20:59 INFO - Successfully installed mozsystemmonitor 12:20:59 INFO - Cleaning up... 12:21:00 INFO - Return code: 0 12:21:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x194e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', '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 12:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:21:00 INFO - Using env: {'DISPLAY': ':0', 12:21:00 INFO - 'HOME': '/home/cltbld', 12:21:00 INFO - 'LANG': 'en_US.UTF-8', 12:21:00 INFO - 'LANGUAGE': 'en_US:en', 12:21:00 INFO - 'LOGNAME': 'cltbld', 12:21:00 INFO - 'MAIL': '/var/mail/cltbld', 12:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:00 INFO - 'MOZ_NO_REMOTE': '1', 12:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:00 INFO - 'NO_EM_RESTART': '1', 12:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:00 INFO - 'PWD': '/builds/slave/test', 12:21:00 INFO - 'SHELL': '/bin/bash', 12:21:00 INFO - 'SHLVL': '1', 12:21:00 INFO - 'TERM': 'linux', 12:21:00 INFO - 'TMOUT': '86400', 12:21:00 INFO - 'USER': 'cltbld', 12:21:00 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:00 INFO - '_': '/tools/buildbot/bin/python'} 12:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:00 INFO - Downloading/unpacking jsonschema==2.5.1 12:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:21:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:21:02 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 12:21:02 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 12:21:02 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 12:21:02 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 12:21:02 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 12:21:02 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 12:21:02 INFO - Downloading functools32-3.2.3-2.tar.gz 12:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:21:02 INFO - warning: no files found matching '*.txt' 12:21:02 INFO - no previously-included directories found matching 'build' 12:21:02 INFO - no previously-included directories found matching 'dist' 12:21:02 INFO - no previously-included directories found matching '.git*' 12:21:02 INFO - Installing collected packages: jsonschema, functools32 12:21:02 INFO - Running setup.py install for functools32 12:21:02 INFO - warning: no files found matching '*.txt' 12:21:02 INFO - no previously-included directories found matching 'build' 12:21:02 INFO - no previously-included directories found matching 'dist' 12:21:02 INFO - no previously-included directories found matching '.git*' 12:21:02 INFO - Successfully installed jsonschema functools32 12:21:02 INFO - Cleaning up... 12:21:02 INFO - Return code: 0 12:21:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:21:02 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')]} 12:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:02 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')]} 12:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:02 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 0x194e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', '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 12:21:02 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 12:21:02 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 12:21:02 INFO - Using env: {'DISPLAY': ':0', 12:21:02 INFO - 'HOME': '/home/cltbld', 12:21:02 INFO - 'LANG': 'en_US.UTF-8', 12:21:02 INFO - 'LANGUAGE': 'en_US:en', 12:21:02 INFO - 'LOGNAME': 'cltbld', 12:21:02 INFO - 'MAIL': '/var/mail/cltbld', 12:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:02 INFO - 'MOZ_NO_REMOTE': '1', 12:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:02 INFO - 'NO_EM_RESTART': '1', 12:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:02 INFO - 'PWD': '/builds/slave/test', 12:21:02 INFO - 'SHELL': '/bin/bash', 12:21:02 INFO - 'SHLVL': '1', 12:21:02 INFO - 'TERM': 'linux', 12:21:02 INFO - 'TMOUT': '86400', 12:21:02 INFO - 'USER': 'cltbld', 12:21:02 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:02 INFO - '_': '/tools/buildbot/bin/python'} 12:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:21:02 INFO - Cleaning up... 12:21:02 INFO - Return code: 0 12:21:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:21:02 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')]} 12:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x194e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', '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 12:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:21:03 INFO - Using env: {'DISPLAY': ':0', 12:21:03 INFO - 'HOME': '/home/cltbld', 12:21:03 INFO - 'LANG': 'en_US.UTF-8', 12:21:03 INFO - 'LANGUAGE': 'en_US:en', 12:21:03 INFO - 'LOGNAME': 'cltbld', 12:21:03 INFO - 'MAIL': '/var/mail/cltbld', 12:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:03 INFO - 'MOZ_NO_REMOTE': '1', 12:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:03 INFO - 'NO_EM_RESTART': '1', 12:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:03 INFO - 'PWD': '/builds/slave/test', 12:21:03 INFO - 'SHELL': '/bin/bash', 12:21:03 INFO - 'SHLVL': '1', 12:21:03 INFO - 'TERM': 'linux', 12:21:03 INFO - 'TMOUT': '86400', 12:21:03 INFO - 'USER': 'cltbld', 12:21:03 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:03 INFO - '_': '/tools/buildbot/bin/python'} 12:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:03 INFO - Downloading/unpacking blobuploader==1.2.4 12:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:05 INFO - Downloading blobuploader-1.2.4.tar.gz 12:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:21:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:21:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:05 INFO - Downloading docopt-0.6.1.tar.gz 12:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:21:06 INFO - Installing collected packages: blobuploader, requests, docopt 12:21:06 INFO - Running setup.py install for blobuploader 12:21:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:21:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:21:06 INFO - Running setup.py install for requests 12:21:06 INFO - Running setup.py install for docopt 12:21:06 INFO - Successfully installed blobuploader requests docopt 12:21:06 INFO - Cleaning up... 12:21:06 INFO - Return code: 0 12:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:06 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')]} 12:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:06 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')]} 12:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:06 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 0x194e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', '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 12:21:06 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 12:21:06 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 12:21:06 INFO - Using env: {'DISPLAY': ':0', 12:21:06 INFO - 'HOME': '/home/cltbld', 12:21:06 INFO - 'LANG': 'en_US.UTF-8', 12:21:06 INFO - 'LANGUAGE': 'en_US:en', 12:21:06 INFO - 'LOGNAME': 'cltbld', 12:21:06 INFO - 'MAIL': '/var/mail/cltbld', 12:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:06 INFO - 'MOZ_NO_REMOTE': '1', 12:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:06 INFO - 'NO_EM_RESTART': '1', 12:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:06 INFO - 'PWD': '/builds/slave/test', 12:21:06 INFO - 'SHELL': '/bin/bash', 12:21:06 INFO - 'SHLVL': '1', 12:21:06 INFO - 'TERM': 'linux', 12:21:06 INFO - 'TMOUT': '86400', 12:21:06 INFO - 'USER': 'cltbld', 12:21:06 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:06 INFO - '_': '/tools/buildbot/bin/python'} 12:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:06 INFO - Running setup.py (path:/tmp/pip-OB0VhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:06 INFO - Running setup.py (path:/tmp/pip-Nt8ldh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:06 INFO - Running setup.py (path:/tmp/pip-6hpk7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:07 INFO - Running setup.py (path:/tmp/pip-2Jxs1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:07 INFO - Running setup.py (path:/tmp/pip-CBhbOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:07 INFO - Running setup.py (path:/tmp/pip-VUhnJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:07 INFO - Running setup.py (path:/tmp/pip-xB6urB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:07 INFO - Running setup.py (path:/tmp/pip-TZzoya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:07 INFO - Running setup.py (path:/tmp/pip-ky78or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:07 INFO - Running setup.py (path:/tmp/pip-nvT9G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:07 INFO - Running setup.py (path:/tmp/pip-kG1Ait-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:07 INFO - Running setup.py (path:/tmp/pip-TRduvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:07 INFO - Running setup.py (path:/tmp/pip-QHM2iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:07 INFO - Running setup.py (path:/tmp/pip-2eOqHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:07 INFO - Running setup.py (path:/tmp/pip-5yY_gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:07 INFO - Running setup.py (path:/tmp/pip-2SY8bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:08 INFO - Running setup.py (path:/tmp/pip-6qKhTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:21:08 INFO - Running setup.py install for manifestparser 12:21:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:21:08 INFO - Running setup.py install for mozcrash 12:21:08 INFO - Running setup.py install for mozdebug 12:21:08 INFO - Running setup.py install for mozdevice 12:21:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:21:08 INFO - Running setup.py install for mozfile 12:21:08 INFO - Running setup.py install for mozhttpd 12:21:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:21:08 INFO - Running setup.py install for mozinfo 12:21:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:21:08 INFO - Running setup.py install for mozInstall 12:21:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:21:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:21:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:21:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:21:08 INFO - Running setup.py install for mozleak 12:21:08 INFO - Running setup.py install for mozlog 12:21:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:21:09 INFO - Running setup.py install for moznetwork 12:21:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:21:09 INFO - Running setup.py install for mozprocess 12:21:09 INFO - Running setup.py install for mozprofile 12:21:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:21:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:21:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:21:09 INFO - Running setup.py install for mozrunner 12:21:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:21:09 INFO - Running setup.py install for mozscreenshot 12:21:09 INFO - Running setup.py install for moztest 12:21:09 INFO - Running setup.py install for mozversion 12:21:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:21:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:21:09 INFO - Cleaning up... 12:21:09 INFO - Return code: 0 12:21:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21: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')]} 12:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21: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')]} 12:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:09 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 0x194e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', '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 12:21:09 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 12:21:09 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 12:21:09 INFO - Using env: {'DISPLAY': ':0', 12:21:09 INFO - 'HOME': '/home/cltbld', 12:21:09 INFO - 'LANG': 'en_US.UTF-8', 12:21:09 INFO - 'LANGUAGE': 'en_US:en', 12:21:09 INFO - 'LOGNAME': 'cltbld', 12:21:09 INFO - 'MAIL': '/var/mail/cltbld', 12:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:09 INFO - 'MOZ_NO_REMOTE': '1', 12:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:09 INFO - 'NO_EM_RESTART': '1', 12:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:09 INFO - 'PWD': '/builds/slave/test', 12:21:09 INFO - 'SHELL': '/bin/bash', 12:21:09 INFO - 'SHLVL': '1', 12:21:09 INFO - 'TERM': 'linux', 12:21:09 INFO - 'TMOUT': '86400', 12:21:09 INFO - 'USER': 'cltbld', 12:21:09 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:09 INFO - '_': '/tools/buildbot/bin/python'} 12:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:10 INFO - Running setup.py (path:/tmp/pip-0zyKZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:10 INFO - Running setup.py (path:/tmp/pip-nFBBl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:10 INFO - Running setup.py (path:/tmp/pip-l87321-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:10 INFO - Running setup.py (path:/tmp/pip-1Q8NCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:10 INFO - Running setup.py (path:/tmp/pip-5G4BXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:10 INFO - Running setup.py (path:/tmp/pip-rskQBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:10 INFO - Running setup.py (path:/tmp/pip-feHwEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:10 INFO - Running setup.py (path:/tmp/pip-WN5UAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:10 INFO - Running setup.py (path:/tmp/pip-xjNEdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:10 INFO - Running setup.py (path:/tmp/pip-dfYiqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:10 INFO - Running setup.py (path:/tmp/pip-weUIQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:10 INFO - Running setup.py (path:/tmp/pip-lADVTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:10 INFO - Running setup.py (path:/tmp/pip-XUeCii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:10 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)) 12:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:10 INFO - Running setup.py (path:/tmp/pip-b91PJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:11 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)) 12:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:11 INFO - Running setup.py (path:/tmp/pip-30AdmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:11 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)) 12:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:11 INFO - Running setup.py (path:/tmp/pip-hi_W1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:11 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)) 12:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:11 INFO - Running setup.py (path:/tmp/pip-i8il9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:11 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)) 12:21:11 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)) 12:21:11 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)) 12:21:11 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)) 12:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:21:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21: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 12:21:13 INFO - Downloading blessings-1.6.tar.gz 12:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:21:13 INFO - Installing collected packages: blessings 12:21:13 INFO - Running setup.py install for blessings 12:21:13 INFO - Successfully installed blessings 12:21:13 INFO - Cleaning up... 12:21:13 INFO - Return code: 0 12:21:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:13 INFO - Reading from file tmpfile_stdout 12:21:13 INFO - Current package versions: 12:21:13 INFO - argparse == 1.2.1 12:21:13 INFO - blessings == 1.6 12:21:13 INFO - blobuploader == 1.2.4 12:21:13 INFO - docopt == 0.6.1 12:21:13 INFO - functools32 == 3.2.3-2 12:21:13 INFO - jsonschema == 2.5.1 12:21:13 INFO - manifestparser == 1.1 12:21:13 INFO - mozInstall == 1.12 12:21:13 INFO - mozcrash == 1.0 12:21:13 INFO - mozdebug == 0.1 12:21:13 INFO - mozdevice == 0.50 12:21:13 INFO - mozfile == 1.2 12:21:13 INFO - mozhttpd == 0.7 12:21:13 INFO - mozinfo == 0.9 12:21:13 INFO - mozleak == 0.1 12:21:13 INFO - mozlog == 3.4 12:21:13 INFO - moznetwork == 0.27 12:21:13 INFO - mozprocess == 0.25 12:21:13 INFO - mozprofile == 0.28 12:21:13 INFO - mozrunner == 6.13 12:21:13 INFO - mozscreenshot == 0.1 12:21:13 INFO - mozsystemmonitor == 0.3 12:21:13 INFO - moztest == 0.8 12:21:13 INFO - mozversion == 1.4 12:21:13 INFO - psutil == 3.1.1 12:21:13 INFO - requests == 1.2.3 12:21:13 INFO - wsgiref == 0.1.2 12:21:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:13 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')]} 12:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:13 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')]} 12:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:13 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 0x194e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', '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 12:21:13 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 12:21:13 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 12:21:13 INFO - Using env: {'DISPLAY': ':0', 12:21:13 INFO - 'HOME': '/home/cltbld', 12:21:13 INFO - 'LANG': 'en_US.UTF-8', 12:21:13 INFO - 'LANGUAGE': 'en_US:en', 12:21:13 INFO - 'LOGNAME': 'cltbld', 12:21:13 INFO - 'MAIL': '/var/mail/cltbld', 12:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:13 INFO - 'MOZ_NO_REMOTE': '1', 12:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:13 INFO - 'NO_EM_RESTART': '1', 12:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:13 INFO - 'PWD': '/builds/slave/test', 12:21:13 INFO - 'SHELL': '/bin/bash', 12:21:13 INFO - 'SHLVL': '1', 12:21:13 INFO - 'TERM': 'linux', 12:21:13 INFO - 'TMOUT': '86400', 12:21:13 INFO - 'USER': 'cltbld', 12:21:13 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:13 INFO - '_': '/tools/buildbot/bin/python'} 12:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:13 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)) 12:21:13 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)) 12:21:13 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)) 12:21:13 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)) 12:21:13 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)) 12:21:13 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)) 12:21:13 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)) 12:21:13 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)) 12:21:13 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)) 12:21:13 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)) 12:21:13 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)) 12:21:13 INFO - Cleaning up... 12:21:13 INFO - Return code: 0 12:21:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:21:13 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')]} 12:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:13 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')]} 12:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:13 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 0x194e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bec310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', '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 12:21:13 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 12:21:13 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 12:21:13 INFO - Using env: {'DISPLAY': ':0', 12:21:13 INFO - 'HOME': '/home/cltbld', 12:21:13 INFO - 'LANG': 'en_US.UTF-8', 12:21:13 INFO - 'LANGUAGE': 'en_US:en', 12:21:13 INFO - 'LOGNAME': 'cltbld', 12:21:13 INFO - 'MAIL': '/var/mail/cltbld', 12:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:13 INFO - 'MOZ_NO_REMOTE': '1', 12:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:13 INFO - 'NO_EM_RESTART': '1', 12:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:13 INFO - 'PWD': '/builds/slave/test', 12:21:13 INFO - 'SHELL': '/bin/bash', 12:21:13 INFO - 'SHLVL': '1', 12:21:13 INFO - 'TERM': 'linux', 12:21:13 INFO - 'TMOUT': '86400', 12:21:13 INFO - 'USER': 'cltbld', 12:21:13 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:13 INFO - '_': '/tools/buildbot/bin/python'} 12:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:21:14 INFO - Cleaning up... 12:21:14 INFO - Return code: 0 12:21:14 INFO - Running post-action listener: _resource_record_post_action 12:21:14 INFO - Running post-action listener: _start_resource_monitoring 12:21:14 INFO - Starting resource monitoring. 12:21:14 INFO - [mozharness: 2017-04-09 19:21:14.220481Z] Finished create-virtualenv step (success) 12:21:14 INFO - [mozharness: 2017-04-09 19:21:14.220953Z] Running install step. 12:21:14 INFO - Running pre-action listener: _resource_record_pre_action 12:21:14 INFO - Running main action method: install 12:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:14 INFO - Reading from file tmpfile_stdout 12:21:14 INFO - Detecting whether we're running mozinstall >=1.0... 12:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:21:14 INFO - Reading from file tmpfile_stdout 12:21:14 INFO - Output received: 12:21:14 INFO - Usage: mozinstall [options] installer 12:21:14 INFO - Options: 12:21:14 INFO - -h, --help show this help message and exit 12:21:14 INFO - -d DEST, --destination=DEST 12:21:14 INFO - Directory to install application into. [default: 12:21:14 INFO - "/builds/slave/test"] 12:21:14 INFO - --app=APP Application being installed. [default: firefox] 12:21:14 INFO - mkdir: /builds/slave/test/build/application 12:21:14 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'] 12:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:21:30 INFO - Reading from file tmpfile_stdout 12:21:30 INFO - Output received: 12:21:30 INFO - /builds/slave/test/build/application/firefox/firefox 12:21:30 INFO - Running post-action listener: _resource_record_post_action 12:21:30 INFO - [mozharness: 2017-04-09 19:21:30.600988Z] Finished install step (success) 12:21:30 INFO - [mozharness: 2017-04-09 19:21:30.601260Z] Running run-tests step. 12:21:30 INFO - Running pre-action listener: _resource_record_pre_action 12:21:30 INFO - Running main action method: run_tests 12:21:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:21:30 INFO - Python 2.7.3 12:21:30 INFO - Return code: 0 12:21:30 INFO - grabbing minidump binary from tooltool 12:21:30 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')]} 12:21:30 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 0x1be9400>, '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 0x1bea3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bea840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:21:30 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 12:21:30 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 12:21:30 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 12:21:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:21:30 INFO - Return code: 0 12:21:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:21:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:21:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:21:30 INFO - ENV: RUST_BACKTRACE is now 1 12:21:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:21:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:21:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 12:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 12:21:30 INFO - Using env: {'DISPLAY': ':0', 12:21:30 INFO - 'HOME': '/home/cltbld', 12:21:30 INFO - 'LANG': 'en_US.UTF-8', 12:21:30 INFO - 'LANGUAGE': 'en_US:en', 12:21:30 INFO - 'LOGNAME': 'cltbld', 12:21:30 INFO - 'MAIL': '/var/mail/cltbld', 12:21:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:21:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:30 INFO - 'MOZ_NO_REMOTE': '1', 12:21:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:21:30 INFO - 'NO_EM_RESTART': '1', 12:21:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:30 INFO - 'PWD': '/builds/slave/test', 12:21:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:21:30 INFO - 'RUST_BACKTRACE': '1', 12:21:30 INFO - 'SHELL': '/bin/bash', 12:21:30 INFO - 'SHLVL': '1', 12:21:30 INFO - 'TERM': 'linux', 12:21:30 INFO - 'TMOUT': '86400', 12:21:30 INFO - 'USER': 'cltbld', 12:21:30 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691', 12:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:30 INFO - '_': '/tools/buildbot/bin/python'} 12:21:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 12:21:30 INFO - mozversion application_buildid: 20170409182913 12:21:30 INFO - mozversion application_changeset: f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae 12:21:30 INFO - mozversion application_display_name: Nightly 12:21:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:21:30 INFO - mozversion application_name: Firefox 12:21:30 INFO - mozversion application_remotingname: firefox 12:21:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:21:30 INFO - mozversion application_vendor: Mozilla 12:21:30 INFO - mozversion application_version: 55.0a1 12:21:30 INFO - mozversion platform_buildid: 20170409182913 12:21:30 INFO - mozversion platform_changeset: f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae 12:21:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:21:30 INFO - mozversion platform_version: 55.0a1 12:21:30 INFO - using testdate: 1491765690 12:21:30 INFO - actual date: 1491765690 12:21:30 INFO - starting webserver on 'localhost:43780' 12:21:30 INFO - SUITE-START | Running 2 tests 12:21:30 INFO - TEST-START | dromaeo_css 12:21:30 INFO - operating with platform_type : linux_ 12:21:30 INFO - Initialising browser for dromaeo_css test... 12:21:30 INFO - TEST-INFO | started process 11802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps7M4Em/profile http://localhost:43780/getInfo.html) 12:21:34 INFO - PID 11802 | __metrics Screen width/height:1600/1200 12:21:34 INFO - PID 11802 | colorDepth:24 12:21:34 INFO - PID 11802 | Browser inner width/height: 1024/697 12:21:34 INFO - PID 11802 | __metrics 12:21:36 INFO - PID 11802 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:21:36 INFO - PID 11802 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:21:37 INFO - TEST-INFO | 11802: exit 0 12:21:37 INFO - Browser initialized. 12:21:37 INFO - Running cycle 1/1 for dromaeo_css test... 12:21:37 INFO - TEST-INFO | started process 11896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps7M4Em/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:21:49 INFO - PID 11896 | RSS: Main: 149463040 12:21:49 INFO - PID 11896 | 12:24:51 INFO - PID 11896 | Cycle 1(1): loaded http://localhost:43780/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43780/tests/dromaeo/cssquery-ext.html) 12:24:53 INFO - PID 11896 | RSS: Main: 284954624 12:24:53 INFO - PID 11896 | 12:26:39 INFO - PID 11896 | ************************* 12:26:39 INFO - PID 11896 | A coding exception was thrown and uncaught in a Task. 12:26:39 INFO - PID 11896 | 12:26:39 ERROR - PID 11896 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:26:39 INFO - PID 11896 | Full stack: 12:26:39 INFO - PID 11896 | ************************* 12:26:39 INFO - PID 11896 | ************************* 12:26:39 INFO - PID 11896 | A coding exception was thrown and uncaught in a Task. 12:26:39 INFO - PID 11896 | 12:26:39 ERROR - PID 11896 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:26:39 INFO - PID 11896 | Full stack: 12:26:39 INFO - PID 11896 | ************************* 12:26:39 INFO - PID 11896 | ************************* 12:26:39 INFO - PID 11896 | A coding exception was thrown and uncaught in a Task. 12:26:39 INFO - PID 11896 | 12:26:39 ERROR - PID 11896 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:26:39 INFO - PID 11896 | Full stack: 12:26:39 INFO - PID 11896 | ************************* 12:26:39 INFO - PID 11896 | ************************* 12:26:39 INFO - PID 11896 | A coding exception was thrown and uncaught in a Task. 12:26:39 INFO - PID 11896 | 12:26:39 ERROR - PID 11896 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:26:39 INFO - PID 11896 | Full stack: 12:26:39 INFO - PID 11896 | ************************* 12:27:55 INFO - PID 11896 | Cycle 1(1): loaded http://localhost:43780/tests/dromaeo/cssquery-ext.html (next: http://localhost:43780/tests/dromaeo/cssquery-jquery.html) 12:27:55 INFO - PID 11896 | RSS: Main: 222531584 12:27:55 INFO - PID 11896 | 12:30:57 INFO - PID 11896 | Cycle 1(1): loaded http://localhost:43780/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43780/tests/dromaeo/cssquery-mootools.html) 12:30:58 INFO - PID 11896 | RSS: Main: 221093888 12:30:58 INFO - PID 11896 | 12:34:00 INFO - PID 11896 | Cycle 1(1): loaded http://localhost:43780/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43780/tests/dromaeo/cssquery-prototype.html) 12:34:00 INFO - PID 11896 | RSS: Main: 196227072 12:34:00 INFO - PID 11896 | 12:37:03 INFO - PID 11896 | Cycle 1(1): loaded http://localhost:43780/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43780/tests/dromaeo/cssquery-yui.html) 12:37:04 INFO - PID 11896 | RSS: Main: 181993472 12:37:04 INFO - PID 11896 | 12:40:06 INFO - PID 11896 | Cycle 1(1): loaded http://localhost:43780/tests/dromaeo/cssquery-yui.html (next: http://localhost:43780/tests/dromaeo/cssquery-dojo.html) 12:40:06 INFO - PID 11896 | RSS: Main: 267038720 12:40:06 INFO - PID 11896 | 12:40:06 INFO - PID 11896 | __start_tp_report 12:40:06 INFO - PID 11896 | _x_x_mozilla_page_load 12:40:06 INFO - PID 11896 | _x_x_mozilla_page_load_details 12:40:06 INFO - PID 11896 | |i|pagename|runs| 12:40:06 INFO - PID 11896 | |0;dojo.html;3296.175956010997;3379.0707555422255;3394.5587073680417;3410.693037626613;3432.22774875653;5788.71056447177;5889.2932848058235;5913.674747888865;5917.881642367155;5955.553333499988;5830.737616807243;5851.180834683137;5897.616654917428;5908.497777688891;5978.641281523101;5100.795968161269;5183.015227106856;5191.325127733389;5247.685138891678;5279.812042290473;5292;5304.469553044684;5306.602004849632;5307.336582927134;5352.197170424448;5124.359455068116;5180.274761533351;5187.19598462239;5226.346706661668;5234.241035049935;5187.766550505236;5208.427073021964;5240.685558866442;5280.049591073605;5284.788608455658;5150.0472412603785;5205.063088644042;5217.060929032773;5224.843254702365;5254.7635356409055;5718.828435146952;5768.826935191909;5862.062070068811;5868.530517558585;5882.558808089368;6276.058591211309;6300.086487459293;6345.8413539661415;6352.364763523657;6372.458341041017;6431.614103153825;6434.646094464802;6438.806835794933;6440.838979025515;6441.903371449432;5904.911426328608;5908.113782932509;5952.761889524414;5954.07711804671;5964.761409543613;6299.6850157491945;6400.103985442041;6416.582922110048;6503.674816259168;6565.179352580927;6276.027215781562;6284.340144284875;6292.968535157295;6294.842628934313;6298.874022519524;6218.00511918091;6340.207474065742;6383.553151279459;6397.328280530571;6406.103145559626;6118.7505600971335;6210.658413787285;6363.745450182034;6383.39357761012;6400.039994000844;6262.12330273762;6330.4619107375465;6366.522510811707;6366.649834259068;6366.713497892606;4862.95137048632;4863.9513604864205;4864.80540778372;4872.561469467765;4902.681325713817;4247.256730072225;4282.914341713211;4290.184864875664;4317.093410383792;4317.762523061199;5789.218455508537;5879.764809407661;5890.764369425175;5961;5963.463288304073;6439.967800161063;6465.353464653497;6479.935200648028;6481.967590162113;6485.870282594322;5961.046232602849;5965.55258355625;5974.253218347707;5976.133460648181;5980.970095149583;5333.200019996954;5353.0899747043095;5409.864753381118;5459.071957767189;5489.862753431116;6706.765263215764;6734.898976515454;6742.4943129266485;6747.392734653905;6754.6284954327;6222.097795819672;6297.1813664223355;6311.274203466476;6416.871662566629;6475.158229430144;6605.735770569316;6629.900551491635;6689.498287628545;6701.497387696039;6706.027625994301;6134.938650613437;6172.660503672161;6215.782447614311;6225.968870155621;6314.116023756769;6392.296847346695;6411.358864113551;6418.711157997808;6436.452901503425;6437.098806167234;6239.532035097477;6246.312905580292;6251.34360892118;6253.656048917172;6253.687315634291;6054.878902422015;6096.738354098782;6127.433875357673;6165.537584681257;6236.095766113797;6193.256809182927;6213.689315534296;6215.595986260879;6220.813375598739;6221;6183.443490085914;6185.505159587132;6222.719977600928;6241.344658810941;6245.6252624842655;5958.791442299499;6014.398560143951;6091.451769340781;6093.29927058394;6097.75608975636 12:40:06 INFO - PID 11896 | |1;ext.html;764.9388048956084;813.6338647608576;846.0904527632795;1146.1346683254146;1169.906407487401;31304.21739456515;38619.61380386199;39252.60747392525;39475;39510.209795804105;40084;40540.59459405405;40563;40612.79693601535;40627.18745625093;6040.939590604082;7911.960440197805;8084.919150808505;8100.270975612194;8110.351171906263;6160.630362178284;7807.687692492322;8008.199180082003;8056.677732890677;8070.7578772636625;8105.1489593592705;8148.75553733386;8150.65514190158;8151.144129866368;8152.75541733746;8073.798155046112;8136.877946830802;8144.144864789171;8146.796330091735;8210.876836847452;7978.601069946538;8023.518588884685;8024.358051355877;8029;8030.397720170952;38827;38980;39056;39077;39143.80428097841;3498.2129020970333;3522.2603253316834;3529.0471572675233;3529.770564913298;3534.32847758925;29819;29847.62742706312;29975.850120749474;30002;30002.69997300021;3980.0646847990697;4005.8998525036814;4009.3985902114623;4012.017055821313;4014.759114453142;192287;192359;192458;194328;195076.02461987743;48623;48863;48943;48995;49061;50141.49858501368;50222.74888625534;50415.49584504108;50562.724677389604;50563;14843.109413435228;14946.850531494763;14954.551363458895;14965.625859353604;14967.101973881601;10480.895191047992;10713.517891694892;12022.158448908493;12135.089868259916;12143.27140371563;12522.248665080124;12736.490540378281;12781.16922400041;12877.678058048436;12901.935490322488;5272.736363181825;5300.840974770763;5304.92042619361;5380.677159370451;5437.564994800407;1091.3015669971226;1100.6973082402244;1121.7363919478917;1121.8429419881222;1124.651358078998;25809.8709506455;26266.474670506865;26535.86732066366;26732.59901101485;26784.33039173997;1197.1918954705538;1203.18784820246;1205.7046023724245;1233.907456940733;1234.7283597608691;13394.665133371744;13744;13783.104098233583;13861.514846980308;14017.229052402216;245431;247354;247812;248638;248749;52124.739376302874;52176.739116304176;52253.216201757;52499.47500524946;52622.21066684003;1477.7561702319213;1492.6566889615233;1500.8799296056288;1519.30050327453;1527.1447989126125;24007.27978160658;25050.498990020464;25232.62151067772;25550;25849;38632.42051369175;38666;38808.2238355237;38890.4166437498;39009.80495097506;226359;228489;229020;229081;229332;29009.7099029007;29636.703632964258;33407.49888751719;33538.66461335453;33658.831705841316;40422.393664094474;40478.79760601178;40842.387364188966;41142.79428602838;41165.17669646531;30524.542131867594;30594.328680558476;30712.325617430437;30877.8456107718;30988.84505577458;30250.69749302479;30750.231244219074;30777;31053.534196986613;31249.218769530944;36297.81851090727;36342.63657363393;36427.45358819673;36432.08919776921;38983.220335593694;31517.527237091002;32028.359432810747;32077.67922320747;32719.018429447155;33047.33905321928;23110.42223944415;25866.35334116662;25936.870315648302;26623.86688066547;26629.334266643487 12:40:06 INFO - PID 11896 | |2;jquery.html;437.2304743651177;438.4431771650006;450.24359076751045;457.3026135143906;469.6289930954548;21004.789952100473;21824.672629910543;22354.664680029793;23168.652470212917;23370.415739606477;22904.312870613867;23075;23217.535649287005;23481.295561133193;23724.644130338016;5909.940900591004;5940.108983652465;6042.848928776793;6088.695565221743;6115.633062016271;5845.503132233765;5935.88128237435;6015.127806468059;6019.217501724792;6025.6083354581815;6078.787242446515;6087.4825639820665;6105.0537166739;6105.786297479589;6107.419795119479;5890.587658863903;5984.611000284967;6041.909371359433;6087.604305720136;6103.054026625858;5458.181272809071;5458.645188062803;5460.34475862895;5460.399356070869;5460.972695136499;26797;27014.45971080587;27234.863825680943;27737.16788496328;27981.860090699618;2202.2402271216406;2243.674667173251;2246.1015593762463;2246.3036458697857;2250.17868478006;17250.137493125294;18136.365227217117;18143.18355673998;18144.546386340317;18358.63282734351;2204.669299605056;2297.322289924476;2340.508493216427;2363.220137354686;2365.455945132629;107278.74482710367;109044.4547777264;109944.4502777489;110185;110701;12498.625041248777;12583.245005299712;12641.873581264254;12820.294883781482;12859.42132604035;17965.910170449326;18019.459416217534;18028.549286267687;18053.09734513269;18071.367502137364;8789.824203515895;9146.929616320673;9161.541922903962;9174.128457796498;9285.953570232106;8394.370422218359;8431.28334091609;8462.745253793033;8724.258438032839;8739.650413983369;7746.341560967381;7925.424237122958;7936.523808571505;7944.504418056037;8055.879161812578;2196.8242540596716;2207.2274703853845;2230.8996095175758;2237.216974059099;2384.7972922301797;1029.1972261635935;1060.8355704865758;1063.1494804156798;1063.3619828103076;1066.221658189526;19433.90283048604;20959.580808384053;21102.155913763276;21162.259320923695;21244;1089.096050278267;1092.2627226621998;1097.8517900083546;1098.9120870330355;1105.3147048829776;10569.418681972566;11424.543018279343;11540.422978851024;11542.422878856023;11556.537738490535;558050;559791;564758;573515;579482;85006.57496712476;89569.55215224012;94604;112034.43982780197;113819.43090284495;1152.8160540309864;1160.7794519041524;1196.0670676872228;1199.5141967503175;1207.1308657766394;19763.110660020047;19819.405417837486;19834.60330793405;20338.389848304574;20427.59144817125;46994.530054700386;47039.294410583185;47647.52053513752;47765;48453;57181.714091429276;60195.69902150636;60650.39349606624;60713;61380.69309653423;8908.688195913111;8968.955155224183;9003.279737621106;9188.678396256098;9715.611375544899;14044.78932816029;14126.78809817874;14263.286835657967;14356.21040842722;14388.35252413623;11906.702332441759;12040.75918481643;12212.206206596542;12272.877271227173;12439.564615238423;11606.70983225426;11845.644630661094;11979.401029948642;12042.397880105784;12147.878521214674;12757.936210318889;12759.681007974876;12774.936125319315;12898;13259.66850828737;9045.864312035457;9153.542322883963;9199.126083022102;9322.813543728951;9521.095495927875;11695.12286578493;11924.701882453008;12143.81784273219;12466.626001219978;12590.811137833123 12:40:06 INFO - PID 11896 | |3;mootools.html;1327.0975736499179;1393.2406838273141;1404.9999999999993;1409.415092736514;1414.7807089901069;10983.340999540023;11421.486033128509;11461.713457163574;11468.369239691814;11472.598459053936;11192.216544841864;11232.887671123286;11469.655910322683;11571.826422603668;11572.189946703735;2284.817214622826;2317.1079134533156;2317.5133222023396;2319.026009076192;2323.0939933425975;2022.130483891926;2251.1108112295633;2347.8473899196583;2379.8572085674828;2384.2847145856263;2049.7437820272467;2175.619266628342;2250.3361508355074;2258.604744169772;2261.2424837679396;2263.106073101124;2269.205777977711;2275.6245219538755;2278.065992942894;2278.1343089626002;2163.405063607505;2232.5646498932715;2257.5710614983263;2262.6832243485924;2276.4764104256114;11469.655910322703;11576.42117894102;11580.768384632345;11581.131415143813;11582.247153935052;6399.744010239585;6582.605043697394;6592.901106483407;6595.571287866273;6597.835054123638;3855.057024377844;3961.5444223914333;4121.5466298707115;4123.0516981094515;4159.480064991876;1449.4347204590217;1452.1142103316968;1463.0030009037587;1466.1862666220243;1506.276987046213;16588.83411165885;16686.082265475514;16701.832981670148;16761.41335053267;16764.32942682291;5231.895362092737;5276.34045744282;5368.677879327252;5536.640118392292;5548.944510554843;12321.630351089481;12349.814752778715;12355.62933112008;12356.25862448256;12369.505219791108;6446.065320528497;6461.998390249519;6463.579867308704;6467.644279564669;6471.320511346241;5904.143899134688;5948.405159484104;6047.546434017467;6099.725512351866;6149.016157414792;4222.59885310895;4279.828806847691;4318.294273761847;4333.739975601474;4372.628326592212;1305.7584346895856;1307.091571357916;1309.3649579953715;1317.9341032948505;1342.6173540541095;868.674247157316;884.8584226523855;904.2765787370078;905.248643625789;907.0814083160683;6416.326285740023;6441.549091563639;6486.578372405778;6544.181977252843;6575.243846957661;614.1095411653121;634.5906890055888;638.167191814677;639.0573903492311;650.6096342194645;4432.578905004019;4433.689641725113;4514.593686568224;4601.700889442242;4646.186917289461;14458.566243012727;15055.54833355001;15056.473023444127;15095.54713358601;15116.54650360491;14527.491537796126;15244.771328430083;15259.847401526065;15275.694486110215;15280.38878444872;10433.061024507831;10654.68035958907;10673.466326683634;10675.893241067646;10677.89322106769;7126.964365178141;7311.4150867929375;7415.073115860518;7425.9628701856145;7529.209433009674;13300.47291014704;13669;13708.794368084686;13800.653888839122;14000.859991399955;13790.379432925341;13970.720585588435;14106.365213565208;14261.286935652968;14273.357698903366;9356.859647105435;9682.85475717879;9683.51582420862;9711.028897110233;9724.319297649097;10851.457427128455;10981.670549883516;11228.887711122785;11325.093992480746;11335.886641133484;9150.313726470407;9152.908470915205;9285.257179425766;9338.299627527827;9574.90425095768;8663.826723465621;8679.609417576097;8733.956330218562;8781.692640757798;9013;8090.433669643304;8126.471779334324;8204.83590328178;8208.794780130545;8209.220124088202;5620.11262112749;5620.971895140498;5698.800541981011;5702.515286200553;5740.770369185353;5792.739326730391;5881.470667639933;5931.9406805931385;6246.812595622138;6326.557141000086 12:40:06 INFO - PID 11896 | |4;prototype.html;386.9378555864153;422.4959145442224;436.3868764386037;437.2653941378484;447.15264573632965;5607.018771714949;5738.626989245696;5810.24466819314;5835.503982161511;5860.648361098337;5603.775848966036;5761.769529218826;5782.681952492621;5796.116262214776;5806.158107074471;4552.521985191557;4582.450105987286;4590.173768721629;4594.862154135381;4596.97701511492;4375.278079116942;4438.4451943507065;4476.2390393632995;4486.394336764544;4584.7936842842155;4315.115401342733;4545.636349092065;4566.49768525462;4570.885727856814;4591.1965406053805;4547.840825571122;4552.112338094073;4552.931706024379;4562.315652652095;4582.289745089483;4080.510338759368;4140.751554906716;4153.8961525961795;4165.396017577435;4171.0615111599955;5684.459976302244;5687.317521897357;5691.345495268056;5692.7153642318135;5693.345265294462;5434.429384914606;5438.809641662562;5442.455754424565;5443;5451.3458384993655;5947.732352044169;6086.482648974842;6155.722992465305;6178.598391104564;6213.316535181127;4647.18674232008;4663.207254766698;4663.393758811367;4666.160091183586;4670.136024835417;6245.282547299484;6364.1408409865;6389.968050159766;6393.136926514954;6406.647634380107;4739.976300118477;4752.435673245066;4762.928556071662;4771.379720636364;4789;4584.679072464895;4638.83764068256;4864.148773964542;4873.80504779812;4876.853694389174;5235.685858848481;5336.306280183551;5343.572514198932;5346.946530534723;5352.598555108382;6106.572539922252;6131.570790044743;6164.630122192682;6180.783672571439;6182.887080325585;1636.7135751243484;1672.356142884998;1680.7814984051995;1695.3388178610353;1703.5485596316985;1172.1970450241442;1193.6777070191;1200.771853347861;1208.64949164743;1221.3038568016145;5757.568182386338;5765.990951583456;5774.624649397776;5807.94192058074;5828.912566311508;6300.30696623371;6301.96849015752;6304.464120549713;6316.273628532777;6319.146915166486;5654.46282603152;5830.62100963436;5846.970765146232;5885.676287804126;5940.673262970492;3295.3244584860045;3309.4373956427467;3321.734261259142;3329.234276116458;3337.6829201225846;6395;6536.182977127859;6581.367453018735;6592.077109204715;6618.86762264752;6456.128422662974;6458.6770661466735;6475.255345635218;6482.448991835652;6488.967555162289;6397.45621622158;6473.190851143607;6594.142761441078;6642.734290628321;6644.202695676549;6267.122602835698;6278.874422511615;6280.021793135148;6292.622442653455;6306.432421082125;6257.43683068526;6274.403931626671;6278.7488500461295;6287.245530536365;6306.495480361468;6389.329120442472;6546.8363290918105;6586.901196481961;6596.373344532261;6622.503312251504;4290.52804191545;4357.9346309806015;4482.484514280899;4496.0558282759675;4511.503734589258;6113.938860611337;6263.6241825490615;6282.528810339334;6290.874182516232;6290.968545157245;6105.8168254952425;6111.411033131329;6118.60229085108;6122.908156377569;6164.291106522807;5904.557158213065;6059.575829691879;6076.179715738495;6102.908456373247;6109.725062372293;6066.848328791815;6094.238220222473;6113.205283313318;6144.723487442986;6154.876902462015;6013.338532761305;6158.630482171084;6167.907481387872;6184.226971628546;6188.164597779242;5977.46202841729;6006.279246490449;6021.006533921854;6021.277446706424;6025.246844144482 12:40:06 INFO - PID 11896 | |5;yui.html;761.3300295739748;858.6136238692588;864.3965542819273;888.9155530224626;902.9458232506048;13779.65550861229;16086.839131608695;16767.07781072042;16783.496495105137;16796.16019199038;17905.7314140288;18112.728309075374;18539.536511587216;18636.50907927366;18659.160337784797;915.0392088307284;946.5409276500926;946.8816397950256;949.2643201518844;949.8385274503316;707.27857585263;734.306080753688;918.7840857398506;945.9195968342665;981.6515137126324;1017.3539802225566;1021.6066814276483;1022.5500779656965;1022.8465730140464;1023.1047833145997;1009.6869970309154;1010.6159659329445;1010.9241806864515;1011.4234886114917;1012.3925644613247;736.381439590741;736.8194792275873;737.0455260437745;737.623811855952;737.6643627149634;16656.916715416344;16748.58128546784;16930.153492325335;17188.914055429766;17401.303947842072;18091.909540452212;18257.63484730298;18282.542936426562;18577.53556161107;18601.255949761995;12851;13038.674033149153;13156.868431315661;13325.533606323732;13327.73344533104;3463.5324231228715;3468.4277094279414;3482.320947415255;3490.2844916791996;3492.8428220729875;92806;92889.53555232249;93166;93782;94545.52727236389;11832.645020649394;11833.467493962793;11940.104492163122;12081.275123492618;12088.999999999824;19933.103010364568;20681.379558612964;24692.753072469044;25788.871055644977;25965;8907.643694252158;9042.728718138467;9278.582463789146;9424.434533927986;9579.329446938647;4791.305260737174;4867.659263851497;4870.342503762017;4882.048000639841;4892.046051020017;4233.576642335804;4367.27939889921;4697.4832768395445;4827.541383568555;4866.659333846667;920.5535315372039;947.9336446448821;960.13108137136;961.6682244625594;962.4273557233435;723.8407550338917;725.2058995400029;741.7181471040969;757.8294883651245;763.9159692433827;10885.23803333775;11161.330320180816;11289.49197286124;11420.657380278604;11523.250988685708;723.4176487927164;735.0297607158607;737.1412304665113;743.866104101267;749.1571981520789;5128.102582048126;5131.409887862869;5241;5257.316548848702;5394.514493695508;74260.25739742533;74273.25726742664;74648.62675686696;75041.62479187569;75379;66089;66093;66397;67044.66477667679;67097;61365;61640.691796540734;62911.370886291465;62942;63043.05435418564;11070.560827092426;11984.520619175135;12002.459889305177;12030.15788894769;12185.268883866996;33374.165645859044;33811.492827607115;33875.153121171184;33961.320773584885;33981.15047123842;40430.59569404386;40955.18089638131;41168.588314116474;41172.588274116875;42004.78997604993;14720.852791471949;15528.84471155274;15839.049657020616;15841;15972.760408593647;16895.91552042232;17077;17208.913955430144;17695.292188312324;17698.469045928643;16079.67840643204;16456.42402515954;16566.585835354213;16795.74806377881;16948.322067117177;14206.644833879236;14575;14597.416103355747;14654.19401932904;14842.703145937237;13829.377678004716;14748.63128421798;15347;15380.307886144927;15497.5350739478;10412.21908356861;10537.683869483928;10931.726706832393;11012.669619911416;11402.372869492257;10914.563417463212;12890.162139460905;13446.260455675032;13467.461301547828;13828.686274803878 12:40:06 INFO - PID 11896 | __end_tp_report 12:40:06 INFO - PID 11896 | __start_cc_report 12:40:06 INFO - PID 11896 | _x_x_mozilla_cycle_collect,1333 12:40:06 INFO - PID 11896 | __end_cc_report 12:40:06 INFO - PID 11896 | __startTimestamp1491766806499__endTimestamp 12:40:06 INFO - PID 11896 | 12:40:06 INFO - PID 11896 | ------- Summary: start ------- 12:40:06 INFO - PID 11896 | Number of tests: 6 12:40:06 INFO - PID 11896 | 12:40:06 INFO - PID 11896 | [#0] dojo.html Cycles:165 Average:5870.12 Median:6118.75 stddev:710.85 (11.6%) stddev-sans-first:683.75 12:40:06 INFO - PID 11896 | Values: 3296.2 3379.1 3394.6 3410.7 3432.2 5788.7 5889.3 5913.7 5917.9 5955.6 5830.7 5851.2 5897.6 5908.5 5978.6 5100.8 5183.0 5191.3 5247.7 5279.8 5292.0 5304.5 5306.6 5307.3 5352.2 5124.4 5180.3 5187.2 5226.3 5234.2 5187.8 5208.4 5240.7 5280.0 5284.8 5150.0 5205.1 5217.1 5224.8 5254.8 5718.8 5768.8 5862.1 5868.5 5882.6 6276.1 6300.1 6345.8 6352.4 6372.5 6431.6 6434.6 6438.8 6440.8 6441.9 5904.9 5908.1 5952.8 5954.1 5964.8 6299.7 6400.1 6416.6 6503.7 6565.2 6276.0 6284.3 6293.0 6294.8 6298.9 6218.0 6340.2 6383.6 6397.3 6406.1 6118.8 6210.7 6363.7 6383.4 6400.0 6262.1 6330.5 6366.5 6366.6 6366.7 4863.0 4864.0 4864.8 4872.6 4902.7 4247.3 4282.9 4290.2 4317.1 4317.8 5789.2 5879.8 5890.8 5961.0 5963.5 6440.0 6465.4 6479.9 6482.0 6485.9 5961.0 5965.6 5974.3 5976.1 5981.0 5333.2 5353.1 5409.9 5459.1 5489.9 6706.8 6734.9 6742.5 6747.4 6754.6 6222.1 6297.2 6311.3 6416.9 6475.2 6605.7 6629.9 6689.5 6701.5 6706.0 6134.9 6172.7 6215.8 6226.0 6314.1 6392.3 6411.4 6418.7 6436.5 6437.1 6239.5 6246.3 6251.3 6253.7 6253.7 6054.9 6096.7 6127.4 6165.5 6236.1 6193.3 6213.7 6215.6 6220.8 6221.0 6183.4 6185.5 6222.7 6241.3 6245.6 5958.8 6014.4 6091.5 6093.3 6097.8 12:40:06 INFO - PID 11896 | 12:40:06 INFO - PID 11896 | [#1] ext.html Cycles:180 Average:38822.14 Median:33473.08 stddev:58214.68 (173.9%) stddev-sans-first:58307.86 12:40:06 INFO - PID 11896 | Values: 764.9 813.6 846.1 1146.1 1169.9 31304.2 38619.6 39252.6 39475.0 39510.2 40084.0 40540.6 40563.0 40612.8 40627.2 6040.9 7912.0 8084.9 8100.3 8110.4 6160.6 7807.7 8008.2 8056.7 8070.8 8105.1 8148.8 8150.7 8151.1 8152.8 8073.8 8136.9 8144.1 8146.8 8210.9 7978.6 8023.5 8024.4 8029.0 8030.4 38827.0 38980.0 39056.0 39077.0 39143.8 3498.2 3522.3 3529.0 3529.8 3534.3 29819.0 29847.6 29975.9 30002.0 30002.7 3980.1 4005.9 4009.4 4012.0 4014.8 192287.0 192359.0 192458.0 194328.0 195076.0 48623.0 48863.0 48943.0 48995.0 49061.0 50141.5 50222.7 50415.5 50562.7 50563.0 14843.1 14946.9 14954.6 14965.6 14967.1 10480.9 10713.5 12022.2 12135.1 12143.3 12522.2 12736.5 12781.2 12877.7 12901.9 5272.7 5300.8 5304.9 5380.7 5437.6 1091.3 1100.7 1121.7 1121.8 1124.7 25809.9 26266.5 26535.9 26732.6 26784.3 1197.2 1203.2 1205.7 1233.9 1234.7 13394.7 13744.0 13783.1 13861.5 14017.2 245431.0 247354.0 247812.0 248638.0 248749.0 52124.7 52176.7 52253.2 52499.5 52622.2 1477.8 1492.7 1500.9 1519.3 1527.1 24007.3 25050.5 25232.6 25550.0 25849.0 38632.4 38666.0 38808.2 38890.4 39009.8 226359.0 228489.0 229020.0 229081.0 229332.0 29009.7 29636.7 33407.5 33538.7 33658.8 40422.4 40478.8 40842.4 41142.8 41165.2 30524.5 30594.3 30712.3 30877.8 30988.8 30250.7 30750.2 30777.0 31053.5 31249.2 36297.8 36342.6 36427.5 36432.1 38983.2 31517.5 32028.4 32077.7 32719.0 33047.3 23110.4 25866.4 25936.9 26623.9 26629.3 12:40:06 INFO - PID 11896 | 12:40:06 INFO - PID 11896 | [#2] jquery.html Cycles:180 Average:33459.23 Median:12600.82 stddev:93672.53 (743.4%) stddev-sans-first:93902.49 12:40:06 INFO - PID 11896 | Values: 437.2 438.4 450.2 457.3 469.6 21004.8 21824.7 22354.7 23168.7 23370.4 22904.3 23075.0 23217.5 23481.3 23724.6 5909.9 5940.1 6042.8 6088.7 6115.6 5845.5 5935.9 6015.1 6019.2 6025.6 6078.8 6087.5 6105.1 6105.8 6107.4 5890.6 5984.6 6041.9 6087.6 6103.1 5458.2 5458.6 5460.3 5460.4 5461.0 26797.0 27014.5 27234.9 27737.2 27981.9 2202.2 2243.7 2246.1 2246.3 2250.2 17250.1 18136.4 18143.2 18144.5 18358.6 2204.7 2297.3 2340.5 2363.2 2365.5 107278.7 109044.5 109944.5 110185.0 110701.0 12498.6 12583.2 12641.9 12820.3 12859.4 17965.9 18019.5 18028.5 18053.1 18071.4 8789.8 9146.9 9161.5 9174.1 9286.0 8394.4 8431.3 8462.7 8724.3 8739.7 7746.3 7925.4 7936.5 7944.5 8055.9 2196.8 2207.2 2230.9 2237.2 2384.8 1029.2 1060.8 1063.1 1063.4 1066.2 19433.9 20959.6 21102.2 21162.3 21244.0 1089.1 1092.3 1097.9 1098.9 1105.3 10569.4 11424.5 11540.4 11542.4 11556.5 558050.0 559791.0 564758.0 573515.0 579482.0 85006.6 89569.6 94604.0 112034.4 113819.4 1152.8 1160.8 1196.1 1199.5 1207.1 19763.1 19819.4 19834.6 20338.4 20427.6 46994.5 47039.3 47647.5 47765.0 48453.0 57181.7 60195.7 60650.4 60713.0 61380.7 8908.7 8969.0 9003.3 9188.7 9715.6 14044.8 14126.8 14263.3 14356.2 14388.4 11906.7 12040.8 12212.2 12272.9 12439.6 11606.7 11845.6 11979.4 12042.4 12147.9 12757.9 12759.7 12774.9 12898.0 13259.7 9045.9 9153.5 9199.1 9322.8 9521.1 11695.1 11924.7 12143.8 12466.6 12590.8 12:40:06 INFO - PID 11896 | 12:40:06 INFO - PID 11896 | [#3] mootools.html Cycles:180 Average:7187.62 Median:2321.06 stddev:4626.21 (199.3%) stddev-sans-first:4618.23 12:40:06 INFO - PID 11896 | Values: 1327.1 1393.2 1405.0 1409.4 1414.8 10983.3 11421.5 11461.7 11468.4 11472.6 11192.2 11232.9 11469.7 11571.8 11572.2 2284.8 2317.1 2317.5 2319.0 2323.1 2022.1 2251.1 2347.8 2379.9 2384.3 2049.7 2175.6 2250.3 2258.6 2261.2 2263.1 2269.2 2275.6 2278.1 2278.1 2163.4 2232.6 2257.6 2262.7 2276.5 11469.7 11576.4 11580.8 11581.1 11582.2 6399.7 6582.6 6592.9 6595.6 6597.8 3855.1 3961.5 4121.5 4123.1 4159.5 1449.4 1452.1 1463.0 1466.2 1506.3 16588.8 16686.1 16701.8 16761.4 16764.3 5231.9 5276.3 5368.7 5536.6 5548.9 12321.6 12349.8 12355.6 12356.3 12369.5 6446.1 6462.0 6463.6 6467.6 6471.3 5904.1 5948.4 6047.5 6099.7 6149.0 4222.6 4279.8 4318.3 4333.7 4372.6 1305.8 1307.1 1309.4 1317.9 1342.6 868.7 884.9 904.3 905.2 907.1 6416.3 6441.5 6486.6 6544.2 6575.2 614.1 634.6 638.2 639.1 650.6 4432.6 4433.7 4514.6 4601.7 4646.2 14458.6 15055.5 15056.5 15095.5 15116.5 14527.5 15244.8 15259.8 15275.7 15280.4 10433.1 10654.7 10673.5 10675.9 10677.9 7127.0 7311.4 7415.1 7426.0 7529.2 13300.5 13669.0 13708.8 13800.7 14000.9 13790.4 13970.7 14106.4 14261.3 14273.4 9356.9 9682.9 9683.5 9711.0 9724.3 10851.5 10981.7 11228.9 11325.1 11335.9 9150.3 9152.9 9285.3 9338.3 9574.9 8663.8 8679.6 8734.0 8781.7 9013.0 8090.4 8126.5 8204.8 8208.8 8209.2 5620.1 5621.0 5698.8 5702.5 5740.8 5792.7 5881.5 5931.9 6246.8 6326.6 12:40:06 INFO - PID 11896 | 12:40:06 INFO - PID 11896 | [#4] prototype.html Cycles:180 Average:5206.18 Median:5807.05 stddev:1490.29 (25.7%) stddev-sans-first:1449.91 12:40:06 INFO - PID 11896 | Values: 386.9 422.5 436.4 437.3 447.2 5607.0 5738.6 5810.2 5835.5 5860.6 5603.8 5761.8 5782.7 5796.1 5806.2 4552.5 4582.5 4590.2 4594.9 4597.0 4375.3 4438.4 4476.2 4486.4 4584.8 4315.1 4545.6 4566.5 4570.9 4591.2 4547.8 4552.1 4552.9 4562.3 4582.3 4080.5 4140.8 4153.9 4165.4 4171.1 5684.5 5687.3 5691.3 5692.7 5693.3 5434.4 5438.8 5442.5 5443.0 5451.3 5947.7 6086.5 6155.7 6178.6 6213.3 4647.2 4663.2 4663.4 4666.2 4670.1 6245.3 6364.1 6390.0 6393.1 6406.6 4740.0 4752.4 4762.9 4771.4 4789.0 4584.7 4638.8 4864.1 4873.8 4876.9 5235.7 5336.3 5343.6 5346.9 5352.6 6106.6 6131.6 6164.6 6180.8 6182.9 1636.7 1672.4 1680.8 1695.3 1703.5 1172.2 1193.7 1200.8 1208.6 1221.3 5757.6 5766.0 5774.6 5807.9 5828.9 6300.3 6302.0 6304.5 6316.3 6319.1 5654.5 5830.6 5847.0 5885.7 5940.7 3295.3 3309.4 3321.7 3329.2 3337.7 6395.0 6536.2 6581.4 6592.1 6618.9 6456.1 6458.7 6475.3 6482.4 6489.0 6397.5 6473.2 6594.1 6642.7 6644.2 6267.1 6278.9 6280.0 6292.6 6306.4 6257.4 6274.4 6278.7 6287.2 6306.5 6389.3 6546.8 6586.9 6596.4 6622.5 4290.5 4357.9 4482.5 4496.1 4511.5 6113.9 6263.6 6282.5 6290.9 6291.0 6105.8 6111.4 6118.6 6122.9 6164.3 5904.6 6059.6 6076.2 6102.9 6109.7 6066.8 6094.2 6113.2 6144.7 6154.9 6013.3 6158.6 6167.9 6184.2 6188.2 5977.5 6006.3 6021.0 6021.3 6025.2 12:40:06 INFO - PID 11896 | 12:40:06 INFO - PID 11896 | [#5] yui.html Cycles:180 Average:18095.79 Median:33592.83 stddev:22272.24 (66.3%) stddev-sans-first:22296.68 12:40:06 INFO - PID 11896 | Values: 761.3 858.6 864.4 888.9 902.9 13779.7 16086.8 16767.1 16783.5 16796.2 17905.7 18112.7 18539.5 18636.5 18659.2 915.0 946.5 946.9 949.3 949.8 707.3 734.3 918.8 945.9 981.7 1017.4 1021.6 1022.6 1022.8 1023.1 1009.7 1010.6 1010.9 1011.4 1012.4 736.4 736.8 737.0 737.6 737.7 16656.9 16748.6 16930.2 17188.9 17401.3 18091.9 18257.6 18282.5 18577.5 18601.3 12851.0 13038.7 13156.9 13325.5 13327.7 3463.5 3468.4 3482.3 3490.3 3492.8 92806.0 92889.5 93166.0 93782.0 94545.5 11832.6 11833.5 11940.1 12081.3 12089.0 19933.1 20681.4 24692.8 25788.9 25965.0 8907.6 9042.7 9278.6 9424.4 9579.3 4791.3 4867.7 4870.3 4882.0 4892.0 4233.6 4367.3 4697.5 4827.5 4866.7 920.6 947.9 960.1 961.7 962.4 723.8 725.2 741.7 757.8 763.9 10885.2 11161.3 11289.5 11420.7 11523.3 723.4 735.0 737.1 743.9 749.2 5128.1 5131.4 5241.0 5257.3 5394.5 74260.3 74273.3 74648.6 75041.6 75379.0 66089.0 66093.0 66397.0 67044.7 67097.0 61365.0 61640.7 62911.4 62942.0 63043.1 11070.6 11984.5 12002.5 12030.2 12185.3 33374.2 33811.5 33875.2 33961.3 33981.2 40430.6 40955.2 41168.6 41172.6 42004.8 14720.9 15528.8 15839.0 15841.0 15972.8 16895.9 17077.0 17208.9 17695.3 17698.5 16079.7 16456.4 16566.6 16795.7 16948.3 14206.6 14575.0 14597.4 14654.2 14842.7 13829.4 14748.6 15347.0 15380.3 15497.5 10412.2 10537.7 10931.7 11012.7 11402.4 10914.6 12890.2 13446.3 13467.5 13828.7 12:40:06 INFO - PID 11896 | -------- Summary: end -------- 12:40:06 INFO - PID 11896 | 12:40:07 INFO - TEST-INFO | 11896: exit 0 12:40:07 INFO - TEST-OK | dromaeo_css | took 1116447ms 12:40:07 INFO - TEST-START | kraken 12:40:07 INFO - operating with platform_type : linux_ 12:40:07 INFO - Initialising browser for kraken test... 12:40:07 INFO - TEST-INFO | started process 12221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6iVtOb/profile http://localhost:43780/getInfo.html) 12:40:11 INFO - PID 12221 | __metrics Screen width/height:1600/1200 12:40:11 INFO - PID 12221 | colorDepth:24 12:40:11 INFO - PID 12221 | Browser inner width/height: 1024/697 12:40:11 INFO - PID 12221 | __metrics 12:40:12 INFO - PID 12221 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:40:12 INFO - PID 12221 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:40:13 INFO - TEST-INFO | 12221: exit 0 12:40:13 INFO - Browser initialized. 12:40:13 INFO - Running cycle 1/1 for kraken test... 12:40:13 INFO - TEST-INFO | started process 12315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6iVtOb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:25 INFO - PID 12315 | RSS: Main: 149790720 12:40:25 INFO - PID 12315 | 12:40:27 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43780/tests/kraken/driver.html?testName=audio-beat-detection) 12:40:28 INFO - PID 12315 | RSS: Main: 205172736 12:40:28 INFO - PID 12315 | 12:40:31 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43780/tests/kraken/driver.html?testName=audio-dft) 12:40:32 INFO - PID 12315 | RSS: Main: 184504320 12:40:32 INFO - PID 12315 | 12:40:35 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43780/tests/kraken/driver.html?testName=audio-fft) 12:40:35 INFO - PID 12315 | RSS: Main: 266072064 12:40:35 INFO - PID 12315 | 12:40:37 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43780/tests/kraken/driver.html?testName=audio-oscillator) 12:40:38 INFO - PID 12315 | RSS: Main: 176803840 12:40:38 INFO - PID 12315 | 12:40:40 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43780/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:40:41 INFO - PID 12315 | RSS: Main: 181178368 12:40:41 INFO - PID 12315 | 12:40:43 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43780/tests/kraken/driver.html?testName=imaging-darkroom) 12:40:44 INFO - PID 12315 | RSS: Main: 219750400 12:40:44 INFO - PID 12315 | 12:40:47 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43780/tests/kraken/driver.html?testName=imaging-desaturate) 12:40:48 INFO - PID 12315 | RSS: Main: 229793792 12:40:48 INFO - PID 12315 | 12:40:51 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43780/tests/kraken/driver.html?testName=json-parse-financial) 12:40:51 INFO - PID 12315 | RSS: Main: 238931968 12:40:51 INFO - PID 12315 | 12:40:53 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43780/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:40:53 INFO - PID 12315 | RSS: Main: 182562816 12:40:53 INFO - PID 12315 | 12:40:55 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43780/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:40:56 INFO - PID 12315 | RSS: Main: 190156800 12:40:56 INFO - PID 12315 | 12:40:58 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43780/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:40:58 INFO - PID 12315 | RSS: Main: 198406144 12:40:58 INFO - PID 12315 | 12:41:01 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:41:02 INFO - PID 12315 | RSS: Main: 207396864 12:41:02 INFO - PID 12315 | 12:41:05 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:41:05 INFO - PID 12315 | RSS: Main: 203776000 12:41:05 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | Cycle 1(1): loaded http://localhost:43780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43780/tests/kraken/driver.html?testName=ai-astar) 12:41:07 INFO - PID 12315 | RSS: Main: 272273408 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | __start_tp_report 12:41:07 INFO - PID 12315 | _x_x_mozilla_page_load 12:41:07 INFO - PID 12315 | _x_x_mozilla_page_load_details 12:41:07 INFO - PID 12315 | |i|pagename|runs| 12:41:07 INFO - PID 12315 | |0;ai-astar;108;109;109;109;109;110;109;108;108;110 12:41:07 INFO - PID 12315 | |1;audio-beat-detection;156;123;121;163;121;123;122;119;156;119 12:41:07 INFO - PID 12315 | |2;audio-dft;165;169;164;165;163;164;163;163;165;163 12:41:07 INFO - PID 12315 | |3;audio-fft;74;77;74;118;75;74;74;76;98;75 12:41:07 INFO - PID 12315 | |4;audio-oscillator;83;83;110;82;83;83;101;83;84;103 12:41:07 INFO - PID 12315 | |5;imaging-gaussian-blur;114;114;114;114;113;113;113;114;113;114 12:41:07 INFO - PID 12315 | |6;imaging-darkroom;147;147;148;148;148;148;148;148;149;147 12:41:07 INFO - PID 12315 | |7;imaging-desaturate;95;94;94;95;94;96;94;94;95;94 12:41:07 INFO - PID 12315 | |8;json-parse-financial;49;47;48;49;48;48;49;49;48;49 12:41:07 INFO - PID 12315 | |9;json-stringify-tinderbox;56;56;55;55;56;55;56;56;56;55 12:41:07 INFO - PID 12315 | |10;stanford-crypto-aes;85;82;86;84;83;83;84;83;84;82 12:41:07 INFO - PID 12315 | |11;stanford-crypto-ccm;134;136;135;135;126;125;126;129;174;133 12:41:07 INFO - PID 12315 | |12;stanford-crypto-pbkdf2;187;201;184;184;184;184;187;184;182;187 12:41:07 INFO - PID 12315 | |13;stanford-crypto-sha256-iterative;65;65;64;69;65;65;63;65;65;64 12:41:07 INFO - PID 12315 | __end_tp_report 12:41:07 INFO - PID 12315 | __start_cc_report 12:41:07 INFO - PID 12315 | _x_x_mozilla_cycle_collect,1717 12:41:07 INFO - PID 12315 | __end_cc_report 12:41:07 INFO - PID 12315 | __startTimestamp1491766867806__endTimestamp 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | ------- Summary: start ------- 12:41:07 INFO - PID 12315 | Number of tests: 14 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.00 stddev:0.74 (0.7%) stddev-sans-first:0.71 12:41:07 INFO - PID 12315 | Values: 108.0 109.0 109.0 109.0 109.0 110.0 109.0 108.0 108.0 110.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:123.00 stddev:18.12 (14.7%) stddev-sans-first:17.07 12:41:07 INFO - PID 12315 | Values: 156.0 123.0 121.0 163.0 121.0 123.0 122.0 119.0 156.0 119.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 12:41:07 INFO - PID 12315 | Values: 165.0 169.0 164.0 165.0 163.0 164.0 163.0 163.0 165.0 163.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:14.77 (19.7%) stddev-sans-first:15.42 12:41:07 INFO - PID 12315 | Values: 74.0 77.0 74.0 118.0 75.0 74.0 74.0 76.0 98.0 75.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:83.00 stddev:10.71 (12.9%) stddev-sans-first:11.10 12:41:07 INFO - PID 12315 | Values: 83.0 83.0 110.0 82.0 83.0 83.0 101.0 83.0 84.0 103.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:41:07 INFO - PID 12315 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 113.0 114.0 113.0 114.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 12:41:07 INFO - PID 12315 | Values: 147.0 147.0 148.0 148.0 148.0 148.0 148.0 148.0 149.0 147.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 12:41:07 INFO - PID 12315 | Values: 95.0 94.0 94.0 95.0 94.0 96.0 94.0 94.0 95.0 94.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:49.00 stddev:0.70 (1.4%) stddev-sans-first:0.71 12:41:07 INFO - PID 12315 | Values: 49.0 47.0 48.0 49.0 48.0 48.0 49.0 49.0 48.0 49.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 12:41:07 INFO - PID 12315 | Values: 56.0 56.0 55.0 55.0 56.0 55.0 56.0 56.0 56.0 55.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.26 (1.5%) stddev-sans-first:1.24 12:41:07 INFO - PID 12315 | Values: 85.0 82.0 86.0 84.0 83.0 83.0 84.0 83.0 84.0 82.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:134.50 stddev:14.24 (10.6%) stddev-sans-first:15.09 12:41:07 INFO - PID 12315 | Values: 134.0 136.0 135.0 135.0 126.0 125.0 126.0 129.0 174.0 133.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:185.50 stddev:5.40 (2.9%) stddev-sans-first:5.72 12:41:07 INFO - PID 12315 | Values: 187.0 201.0 184.0 184.0 184.0 184.0 187.0 184.0 182.0 187.0 12:41:07 INFO - PID 12315 | 12:41:07 INFO - PID 12315 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.56 (2.4%) stddev-sans-first:1.66 12:41:07 INFO - PID 12315 | Values: 65.0 65.0 64.0 69.0 65.0 65.0 63.0 65.0 65.0 64.0 12:41:07 INFO - PID 12315 | -------- Summary: end -------- 12:41:07 INFO - PID 12315 | 12:41:09 INFO - TEST-INFO | 12315: exit 0 12:41:09 INFO - TEST-OK | kraken | took 61764ms 12:41:09 INFO - SUITE-END | took 1178s 12:41:09 INFO - Completed test suite (00:19:38) 12:41:09 INFO - javascript benchmark 12:41:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7718.1058069745595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.175956010997, 3379.0707555422255, 3394.5587073680417, 3410.693037626613, 3432.22774875653, 5788.71056447177, 5889.2932848058235, 5913.674747888865, 5917.881642367155, 5955.553333499988, 5830.737616807243, 5851.180834683137, 5897.616654917428, 5908.497777688891, 5978.641281523101, 5100.795968161269, 5183.015227106856, 5191.325127733389, 5247.685138891678, 5279.812042290473, 5292.0, 5304.469553044684, 5306.602004849632, 5307.336582927134, 5352.197170424448, 5124.359455068116, 5180.274761533351, 5187.19598462239, 5226.346706661668, 5234.241035049935, 5187.766550505236, 5208.427073021964, 5240.685558866442, 5280.049591073605, 5284.788608455658, 5150.0472412603785, 5205.063088644042, 5217.060929032773, 5224.843254702365, 5254.7635356409055, 5718.828435146952, 5768.826935191909, 5862.062070068811, 5868.530517558585, 5882.558808089368, 6276.058591211309, 6300.086487459293, 6345.8413539661415, 6352.364763523657, 6372.458341041017, 6431.614103153825, 6434.646094464802, 6438.806835794933, 6440.838979025515, 6441.903371449432, 5904.911426328608, 5908.113782932509, 5952.761889524414, 5954.07711804671, 5964.761409543613, 6299.6850157491945, 6400.103985442041, 6416.582922110048, 6503.674816259168, 6565.179352580927, 6276.027215781562, 6284.340144284875, 6292.968535157295, 6294.842628934313, 6298.874022519524, 6218.00511918091, 6340.207474065742, 6383.553151279459, 6397.328280530571, 6406.103145559626, 6118.7505600971335, 6210.658413787285, 6363.745450182034, 6383.39357761012, 6400.039994000844, 6262.12330273762, 6330.4619107375465, 6366.522510811707, 6366.649834259068, 6366.713497892606, 4862.95137048632, 4863.9513604864205, 4864.80540778372, 4872.561469467765, 4902.681325713817, 4247.256730072225, 4282.914341713211, 4290.184864875664, 4317.093410383792, 4317.762523061199, 5789.218455508537, 5879.764809407661, 5890.764369425175, 5961.0, 5963.463288304073, 6439.967800161063, 6465.353464653497, 6479.935200648028, 6481.967590162113, 6485.870282594322, 5961.046232602849, 5965.55258355625, 5974.253218347707, 5976.133460648181, 5980.970095149583, 5333.200019996954, 5353.0899747043095, 5409.864753381118, 5459.071957767189, 5489.862753431116, 6706.765263215764, 6734.898976515454, 6742.4943129266485, 6747.392734653905, 6754.6284954327, 6222.097795819672, 6297.1813664223355, 6311.274203466476, 6416.871662566629, 6475.158229430144, 6605.735770569316, 6629.900551491635, 6689.498287628545, 6701.497387696039, 6706.027625994301, 6134.938650613437, 6172.660503672161, 6215.782447614311, 6225.968870155621, 6314.116023756769, 6392.296847346695, 6411.358864113551, 6418.711157997808, 6436.452901503425, 6437.098806167234, 6239.532035097477, 6246.312905580292, 6251.34360892118, 6253.656048917172, 6253.687315634291, 6054.878902422015, 6096.738354098782, 6127.433875357673, 6165.537584681257, 6236.095766113797, 6193.256809182927, 6213.689315534296, 6215.595986260879, 6220.813375598739, 6221.0, 6183.443490085914, 6185.505159587132, 6222.719977600928, 6241.344658810941, 6245.6252624842655, 5958.791442299499, 6014.398560143951, 6091.451769340781, 6093.29927058394, 6097.75608975636], "value": 5819.556519048148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.9388048956084, 813.6338647608576, 846.0904527632795, 1146.1346683254146, 1169.906407487401, 31304.21739456515, 38619.61380386199, 39252.60747392525, 39475.0, 39510.209795804105, 40084.0, 40540.59459405405, 40563.0, 40612.79693601535, 40627.18745625093, 6040.939590604082, 7911.960440197805, 8084.919150808505, 8100.270975612194, 8110.351171906263, 6160.630362178284, 7807.687692492322, 8008.199180082003, 8056.677732890677, 8070.7578772636625, 8105.1489593592705, 8148.75553733386, 8150.65514190158, 8151.144129866368, 8152.75541733746, 8073.798155046112, 8136.877946830802, 8144.144864789171, 8146.796330091735, 8210.876836847452, 7978.601069946538, 8023.518588884685, 8024.358051355877, 8029.0, 8030.397720170952, 38827.0, 38980.0, 39056.0, 39077.0, 39143.80428097841, 3498.2129020970333, 3522.2603253316834, 3529.0471572675233, 3529.770564913298, 3534.32847758925, 29819.0, 29847.62742706312, 29975.850120749474, 30002.0, 30002.69997300021, 3980.0646847990697, 4005.8998525036814, 4009.3985902114623, 4012.017055821313, 4014.759114453142, 192287.0, 192359.0, 192458.0, 194328.0, 195076.02461987743, 48623.0, 48863.0, 48943.0, 48995.0, 49061.0, 50141.49858501368, 50222.74888625534, 50415.49584504108, 50562.724677389604, 50563.0, 14843.109413435228, 14946.850531494763, 14954.551363458895, 14965.625859353604, 14967.101973881601, 10480.895191047992, 10713.517891694892, 12022.158448908493, 12135.089868259916, 12143.27140371563, 12522.248665080124, 12736.490540378281, 12781.16922400041, 12877.678058048436, 12901.935490322488, 5272.736363181825, 5300.840974770763, 5304.92042619361, 5380.677159370451, 5437.564994800407, 1091.3015669971226, 1100.6973082402244, 1121.7363919478917, 1121.8429419881222, 1124.651358078998, 25809.8709506455, 26266.474670506865, 26535.86732066366, 26732.59901101485, 26784.33039173997, 1197.1918954705538, 1203.18784820246, 1205.7046023724245, 1233.907456940733, 1234.7283597608691, 13394.665133371744, 13744.0, 13783.104098233583, 13861.514846980308, 14017.229052402216, 245431.0, 247354.0, 247812.0, 248638.0, 248749.0, 52124.739376302874, 52176.739116304176, 52253.216201757, 52499.47500524946, 52622.21066684003, 1477.7561702319213, 1492.6566889615233, 1500.8799296056288, 1519.30050327453, 1527.1447989126125, 24007.27978160658, 25050.498990020464, 25232.62151067772, 25550.0, 25849.0, 38632.42051369175, 38666.0, 38808.2238355237, 38890.4166437498, 39009.80495097506, 226359.0, 228489.0, 229020.0, 229081.0, 229332.0, 29009.7099029007, 29636.703632964258, 33407.49888751719, 33538.66461335453, 33658.831705841316, 40422.393664094474, 40478.79760601178, 40842.387364188966, 41142.79428602838, 41165.17669646531, 30524.542131867594, 30594.328680558476, 30712.325617430437, 30877.8456107718, 30988.84505577458, 30250.69749302479, 30750.231244219074, 30777.0, 31053.534196986613, 31249.218769530944, 36297.81851090727, 36342.63657363393, 36427.45358819673, 36432.08919776921, 38983.220335593694, 31517.527237091002, 32028.359432810747, 32077.67922320747, 32719.018429447155, 33047.33905321928, 23110.42223944415, 25866.35334116662, 25936.870315648302, 26623.86688066547, 26629.334266643487], "value": 17244.392712875324, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.2304743651177, 438.4431771650006, 450.24359076751045, 457.3026135143906, 469.6289930954548, 21004.789952100473, 21824.672629910543, 22354.664680029793, 23168.652470212917, 23370.415739606477, 22904.312870613867, 23075.0, 23217.535649287005, 23481.295561133193, 23724.644130338016, 5909.940900591004, 5940.108983652465, 6042.848928776793, 6088.695565221743, 6115.633062016271, 5845.503132233765, 5935.88128237435, 6015.127806468059, 6019.217501724792, 6025.6083354581815, 6078.787242446515, 6087.4825639820665, 6105.0537166739, 6105.786297479589, 6107.419795119479, 5890.587658863903, 5984.611000284967, 6041.909371359433, 6087.604305720136, 6103.054026625858, 5458.181272809071, 5458.645188062803, 5460.34475862895, 5460.399356070869, 5460.972695136499, 26797.0, 27014.45971080587, 27234.863825680943, 27737.16788496328, 27981.860090699618, 2202.2402271216406, 2243.674667173251, 2246.1015593762463, 2246.3036458697857, 2250.17868478006, 17250.137493125294, 18136.365227217117, 18143.18355673998, 18144.546386340317, 18358.63282734351, 2204.669299605056, 2297.322289924476, 2340.508493216427, 2363.220137354686, 2365.455945132629, 107278.74482710367, 109044.4547777264, 109944.4502777489, 110185.0, 110701.0, 12498.625041248777, 12583.245005299712, 12641.873581264254, 12820.294883781482, 12859.42132604035, 17965.910170449326, 18019.459416217534, 18028.549286267687, 18053.09734513269, 18071.367502137364, 8789.824203515895, 9146.929616320673, 9161.541922903962, 9174.128457796498, 9285.953570232106, 8394.370422218359, 8431.28334091609, 8462.745253793033, 8724.258438032839, 8739.650413983369, 7746.341560967381, 7925.424237122958, 7936.523808571505, 7944.504418056037, 8055.879161812578, 2196.8242540596716, 2207.2274703853845, 2230.8996095175758, 2237.216974059099, 2384.7972922301797, 1029.1972261635935, 1060.8355704865758, 1063.1494804156798, 1063.3619828103076, 1066.221658189526, 19433.90283048604, 20959.580808384053, 21102.155913763276, 21162.259320923695, 21244.0, 1089.096050278267, 1092.2627226621998, 1097.8517900083546, 1098.9120870330355, 1105.3147048829776, 10569.418681972566, 11424.543018279343, 11540.422978851024, 11542.422878856023, 11556.537738490535, 558050.0, 559791.0, 564758.0, 573515.0, 579482.0, 85006.57496712476, 89569.55215224012, 94604.0, 112034.43982780197, 113819.43090284495, 1152.8160540309864, 1160.7794519041524, 1196.0670676872228, 1199.5141967503175, 1207.1308657766394, 19763.110660020047, 19819.405417837486, 19834.60330793405, 20338.389848304574, 20427.59144817125, 46994.530054700386, 47039.294410583185, 47647.52053513752, 47765.0, 48453.0, 57181.714091429276, 60195.69902150636, 60650.39349606624, 60713.0, 61380.69309653423, 8908.688195913111, 8968.955155224183, 9003.279737621106, 9188.678396256098, 9715.611375544899, 14044.78932816029, 14126.78809817874, 14263.286835657967, 14356.21040842722, 14388.35252413623, 11906.702332441759, 12040.75918481643, 12212.206206596542, 12272.877271227173, 12439.564615238423, 11606.70983225426, 11845.644630661094, 11979.401029948642, 12042.397880105784, 12147.878521214674, 12757.936210318889, 12759.681007974876, 12774.936125319315, 12898.0, 13259.66850828737, 9045.864312035457, 9153.542322883963, 9199.126083022102, 9322.813543728951, 9521.095495927875, 11695.12286578493, 11924.701882453008, 12143.81784273219, 12466.626001219978, 12590.811137833123], "value": 10412.145062189755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.0975736499179, 1393.2406838273141, 1404.9999999999993, 1409.415092736514, 1414.7807089901069, 10983.340999540023, 11421.486033128509, 11461.713457163574, 11468.369239691814, 11472.598459053936, 11192.216544841864, 11232.887671123286, 11469.655910322683, 11571.826422603668, 11572.189946703735, 2284.817214622826, 2317.1079134533156, 2317.5133222023396, 2319.026009076192, 2323.0939933425975, 2022.130483891926, 2251.1108112295633, 2347.8473899196583, 2379.8572085674828, 2384.2847145856263, 2049.7437820272467, 2175.619266628342, 2250.3361508355074, 2258.604744169772, 2261.2424837679396, 2263.106073101124, 2269.205777977711, 2275.6245219538755, 2278.065992942894, 2278.1343089626002, 2163.405063607505, 2232.5646498932715, 2257.5710614983263, 2262.6832243485924, 2276.4764104256114, 11469.655910322703, 11576.42117894102, 11580.768384632345, 11581.131415143813, 11582.247153935052, 6399.744010239585, 6582.605043697394, 6592.901106483407, 6595.571287866273, 6597.835054123638, 3855.057024377844, 3961.5444223914333, 4121.5466298707115, 4123.0516981094515, 4159.480064991876, 1449.4347204590217, 1452.1142103316968, 1463.0030009037587, 1466.1862666220243, 1506.276987046213, 16588.83411165885, 16686.082265475514, 16701.832981670148, 16761.41335053267, 16764.32942682291, 5231.895362092737, 5276.34045744282, 5368.677879327252, 5536.640118392292, 5548.944510554843, 12321.630351089481, 12349.814752778715, 12355.62933112008, 12356.25862448256, 12369.505219791108, 6446.065320528497, 6461.998390249519, 6463.579867308704, 6467.644279564669, 6471.320511346241, 5904.143899134688, 5948.405159484104, 6047.546434017467, 6099.725512351866, 6149.016157414792, 4222.59885310895, 4279.828806847691, 4318.294273761847, 4333.739975601474, 4372.628326592212, 1305.7584346895856, 1307.091571357916, 1309.3649579953715, 1317.9341032948505, 1342.6173540541095, 868.674247157316, 884.8584226523855, 904.2765787370078, 905.248643625789, 907.0814083160683, 6416.326285740023, 6441.549091563639, 6486.578372405778, 6544.181977252843, 6575.243846957661, 614.1095411653121, 634.5906890055888, 638.167191814677, 639.0573903492311, 650.6096342194645, 4432.578905004019, 4433.689641725113, 4514.593686568224, 4601.700889442242, 4646.186917289461, 14458.566243012727, 15055.54833355001, 15056.473023444127, 15095.54713358601, 15116.54650360491, 14527.491537796126, 15244.771328430083, 15259.847401526065, 15275.694486110215, 15280.38878444872, 10433.061024507831, 10654.68035958907, 10673.466326683634, 10675.893241067646, 10677.89322106769, 7126.964365178141, 7311.4150867929375, 7415.073115860518, 7425.9628701856145, 7529.209433009674, 13300.47291014704, 13669.0, 13708.794368084686, 13800.653888839122, 14000.859991399955, 13790.379432925341, 13970.720585588435, 14106.365213565208, 14261.286935652968, 14273.357698903366, 9356.859647105435, 9682.85475717879, 9683.51582420862, 9711.028897110233, 9724.319297649097, 10851.457427128455, 10981.670549883516, 11228.887711122785, 11325.093992480746, 11335.886641133484, 9150.313726470407, 9152.908470915205, 9285.257179425766, 9338.299627527827, 9574.90425095768, 8663.826723465621, 8679.609417576097, 8733.956330218562, 8781.692640757798, 9013.0, 8090.433669643304, 8126.471779334324, 8204.83590328178, 8208.794780130545, 8209.220124088202, 5620.11262112749, 5620.971895140498, 5698.800541981011, 5702.515286200553, 5740.770369185353, 5792.739326730391, 5881.470667639933, 5931.9406805931385, 6246.812595622138, 6326.557141000086], "value": 5348.0776183073085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.9378555864153, 422.4959145442224, 436.3868764386037, 437.2653941378484, 447.15264573632965, 5607.018771714949, 5738.626989245696, 5810.24466819314, 5835.503982161511, 5860.648361098337, 5603.775848966036, 5761.769529218826, 5782.681952492621, 5796.116262214776, 5806.158107074471, 4552.521985191557, 4582.450105987286, 4590.173768721629, 4594.862154135381, 4596.97701511492, 4375.278079116942, 4438.4451943507065, 4476.2390393632995, 4486.394336764544, 4584.7936842842155, 4315.115401342733, 4545.636349092065, 4566.49768525462, 4570.885727856814, 4591.1965406053805, 4547.840825571122, 4552.112338094073, 4552.931706024379, 4562.315652652095, 4582.289745089483, 4080.510338759368, 4140.751554906716, 4153.8961525961795, 4165.396017577435, 4171.0615111599955, 5684.459976302244, 5687.317521897357, 5691.345495268056, 5692.7153642318135, 5693.345265294462, 5434.429384914606, 5438.809641662562, 5442.455754424565, 5443.0, 5451.3458384993655, 5947.732352044169, 6086.482648974842, 6155.722992465305, 6178.598391104564, 6213.316535181127, 4647.18674232008, 4663.207254766698, 4663.393758811367, 4666.160091183586, 4670.136024835417, 6245.282547299484, 6364.1408409865, 6389.968050159766, 6393.136926514954, 6406.647634380107, 4739.976300118477, 4752.435673245066, 4762.928556071662, 4771.379720636364, 4789.0, 4584.679072464895, 4638.83764068256, 4864.148773964542, 4873.80504779812, 4876.853694389174, 5235.685858848481, 5336.306280183551, 5343.572514198932, 5346.946530534723, 5352.598555108382, 6106.572539922252, 6131.570790044743, 6164.630122192682, 6180.783672571439, 6182.887080325585, 1636.7135751243484, 1672.356142884998, 1680.7814984051995, 1695.3388178610353, 1703.5485596316985, 1172.1970450241442, 1193.6777070191, 1200.771853347861, 1208.64949164743, 1221.3038568016145, 5757.568182386338, 5765.990951583456, 5774.624649397776, 5807.94192058074, 5828.912566311508, 6300.30696623371, 6301.96849015752, 6304.464120549713, 6316.273628532777, 6319.146915166486, 5654.46282603152, 5830.62100963436, 5846.970765146232, 5885.676287804126, 5940.673262970492, 3295.3244584860045, 3309.4373956427467, 3321.734261259142, 3329.234276116458, 3337.6829201225846, 6395.0, 6536.182977127859, 6581.367453018735, 6592.077109204715, 6618.86762264752, 6456.128422662974, 6458.6770661466735, 6475.255345635218, 6482.448991835652, 6488.967555162289, 6397.45621622158, 6473.190851143607, 6594.142761441078, 6642.734290628321, 6644.202695676549, 6267.122602835698, 6278.874422511615, 6280.021793135148, 6292.622442653455, 6306.432421082125, 6257.43683068526, 6274.403931626671, 6278.7488500461295, 6287.245530536365, 6306.495480361468, 6389.329120442472, 6546.8363290918105, 6586.901196481961, 6596.373344532261, 6622.503312251504, 4290.52804191545, 4357.9346309806015, 4482.484514280899, 4496.0558282759675, 4511.503734589258, 6113.938860611337, 6263.6241825490615, 6282.528810339334, 6290.874182516232, 6290.968545157245, 6105.8168254952425, 6111.411033131329, 6118.60229085108, 6122.908156377569, 6164.291106522807, 5904.557158213065, 6059.575829691879, 6076.179715738495, 6102.908456373247, 6109.725062372293, 6066.848328791815, 6094.238220222473, 6113.205283313318, 6144.723487442986, 6154.876902462015, 6013.338532761305, 6158.630482171084, 6167.907481387872, 6184.226971628546, 6188.164597779242, 5977.46202841729, 6006.279246490449, 6021.006533921854, 6021.277446706424, 6025.246844144482], "value": 4758.183675967586, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.3300295739748, 858.6136238692588, 864.3965542819273, 888.9155530224626, 902.9458232506048, 13779.65550861229, 16086.839131608695, 16767.07781072042, 16783.496495105137, 16796.16019199038, 17905.7314140288, 18112.728309075374, 18539.536511587216, 18636.50907927366, 18659.160337784797, 915.0392088307284, 946.5409276500926, 946.8816397950256, 949.2643201518844, 949.8385274503316, 707.27857585263, 734.306080753688, 918.7840857398506, 945.9195968342665, 981.6515137126324, 1017.3539802225566, 1021.6066814276483, 1022.5500779656965, 1022.8465730140464, 1023.1047833145997, 1009.6869970309154, 1010.6159659329445, 1010.9241806864515, 1011.4234886114917, 1012.3925644613247, 736.381439590741, 736.8194792275873, 737.0455260437745, 737.623811855952, 737.6643627149634, 16656.916715416344, 16748.58128546784, 16930.153492325335, 17188.914055429766, 17401.303947842072, 18091.909540452212, 18257.63484730298, 18282.542936426562, 18577.53556161107, 18601.255949761995, 12851.0, 13038.674033149153, 13156.868431315661, 13325.533606323732, 13327.73344533104, 3463.5324231228715, 3468.4277094279414, 3482.320947415255, 3490.2844916791996, 3492.8428220729875, 92806.0, 92889.53555232249, 93166.0, 93782.0, 94545.52727236389, 11832.645020649394, 11833.467493962793, 11940.104492163122, 12081.275123492618, 12088.999999999824, 19933.103010364568, 20681.379558612964, 24692.753072469044, 25788.871055644977, 25965.0, 8907.643694252158, 9042.728718138467, 9278.582463789146, 9424.434533927986, 9579.329446938647, 4791.305260737174, 4867.659263851497, 4870.342503762017, 4882.048000639841, 4892.046051020017, 4233.576642335804, 4367.27939889921, 4697.4832768395445, 4827.541383568555, 4866.659333846667, 920.5535315372039, 947.9336446448821, 960.13108137136, 961.6682244625594, 962.4273557233435, 723.8407550338917, 725.2058995400029, 741.7181471040969, 757.8294883651245, 763.9159692433827, 10885.23803333775, 11161.330320180816, 11289.49197286124, 11420.657380278604, 11523.250988685708, 723.4176487927164, 735.0297607158607, 737.1412304665113, 743.866104101267, 749.1571981520789, 5128.102582048126, 5131.409887862869, 5241.0, 5257.316548848702, 5394.514493695508, 74260.25739742533, 74273.25726742664, 74648.62675686696, 75041.62479187569, 75379.0, 66089.0, 66093.0, 66397.0, 67044.66477667679, 67097.0, 61365.0, 61640.691796540734, 62911.370886291465, 62942.0, 63043.05435418564, 11070.560827092426, 11984.520619175135, 12002.459889305177, 12030.15788894769, 12185.268883866996, 33374.165645859044, 33811.492827607115, 33875.153121171184, 33961.320773584885, 33981.15047123842, 40430.59569404386, 40955.18089638131, 41168.588314116474, 41172.588274116875, 42004.78997604993, 14720.852791471949, 15528.84471155274, 15839.049657020616, 15841.0, 15972.760408593647, 16895.91552042232, 17077.0, 17208.913955430144, 17695.292188312324, 17698.469045928643, 16079.67840643204, 16456.42402515954, 16566.585835354213, 16795.74806377881, 16948.322067117177, 14206.644833879236, 14575.0, 14597.416103355747, 14654.19401932904, 14842.703145937237, 13829.377678004716, 14748.63128421798, 15347.0, 15380.307886144927, 15497.5350739478, 10412.21908356861, 10537.683869483928, 10931.726706832393, 11012.669619911416, 11402.372869492257, 10914.563417463212, 12890.162139460905, 13446.260455675032, 13467.461301547828, 13828.686274803878], "value": 7949.072325199536, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 108.0, 108.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 121.0, 163.0, 121.0, 123.0, 122.0, 119.0, 156.0, 119.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 164.0, 165.0, 163.0, 164.0, 163.0, 163.0, 165.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 118.0, 75.0, 74.0, 74.0, 76.0, 98.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 110.0, 82.0, 83.0, 83.0, 101.0, 83.0, 84.0, 103.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 96.0, 94.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 47.0, 48.0, 49.0, 48.0, 48.0, 49.0, 49.0, 48.0, 49.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 56.0, 55.0, 56.0, 56.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 86.0, 84.0, 83.0, 83.0, 84.0, 83.0, 84.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 135.0, 135.0, 126.0, 125.0, 126.0, 129.0, 174.0, 133.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 201.0, 184.0, 184.0, 184.0, 184.0, 187.0, 184.0, 182.0, 187.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 69.0, 65.0, 65.0, 63.0, 65.0, 65.0, 64.0], "value": 65.0, "unit": "score"}]}]} 12:41:09 INFO - Return code: 0 12:41:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:41:09 ERROR - # TBPL SUCCESS # 12:41:09 INFO - Running post-action listener: _resource_record_post_action 12:41:09 INFO - [mozharness: 2017-04-09 19:41:09.643371Z] Finished run-tests step (success) 12:41:09 INFO - Running post-run listener: _resource_record_post_run 12:41:09 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 363872256; Read time: 176; Write time: 214236 12:41:09 INFO - TinderboxPrint: CPU usage
13.0% 12:41:09 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 176 12:41:09 INFO - TinderboxPrint: I/O write bytes / time
363,872,256 / 214,236 12:41:09 INFO - TinderboxPrint: CPU idle
8,301.3 (87.0%) 12:41:09 INFO - TinderboxPrint: CPU user
1,188.4 (12.5%) 12:41:09 INFO - TinderboxPrint: Swap in / out
0 / 0 12:41:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108498944; Read time: 52; Write time: 69556 12:41:09 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255373312; Read time: 124; Write time: 144680 12:41:10 INFO - Running post-run listener: _upload_blobber_files 12:41:10 INFO - Blob upload gear active. 12:41:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:41:10 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 12:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:41:10 INFO - (blobuploader) - INFO - Open directory for files ... 12:41:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:41:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:11 INFO - (blobuploader) - INFO - Done attempting. 12:41:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:12 INFO - (blobuploader) - INFO - Done attempting. 12:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:41:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:13 INFO - (blobuploader) - INFO - Done attempting. 12:41:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:41:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:41:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:16 INFO - (blobuploader) - INFO - Done attempting. 12:41:16 INFO - (blobuploader) - INFO - Iteration through files over. 12:41:16 INFO - Return code: 0 12:41:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:41:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:41:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/536123a30a8c1a53dbad0d753633e7623969c68162c4e9bd8d01078fd9460264479cf50969f4825c8abfb2aa2de7daa163d2749eb8f3a475d3bdc16829566fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41db76b18e9db2a2538df0eb3901fec342e85ef1bb233a5b64f5ea9fe9364ceff354d46709fff21e817ef01ff0050a4e2701aa53147a6d2fad5775220f409608", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0246756423c7966fd570be798de6f7b7e7aed6961a7a9682cccf72adf8fd3e8f42200e8ffb1cb12344e05ca007424792263674458b159e0d07487fa71b75ef08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dd8f4406a28eb79cbf29159a5a3787374bfebb2c44c6312d73e79860ef2b0fcc4b3456d21848db5550b1b508a26885c0b0d89d86bf60e550ed383569b328e6f"} 12:41:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:41:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:41:16 INFO - Contents: 12:41:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/536123a30a8c1a53dbad0d753633e7623969c68162c4e9bd8d01078fd9460264479cf50969f4825c8abfb2aa2de7daa163d2749eb8f3a475d3bdc16829566fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41db76b18e9db2a2538df0eb3901fec342e85ef1bb233a5b64f5ea9fe9364ceff354d46709fff21e817ef01ff0050a4e2701aa53147a6d2fad5775220f409608", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0246756423c7966fd570be798de6f7b7e7aed6961a7a9682cccf72adf8fd3e8f42200e8ffb1cb12344e05ca007424792263674458b159e0d07487fa71b75ef08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dd8f4406a28eb79cbf29159a5a3787374bfebb2c44c6312d73e79860ef2b0fcc4b3456d21848db5550b1b508a26885c0b0d89d86bf60e550ed383569b328e6f"} 12:41:16 INFO - Running post-run listener: copy_logs_to_upload_dir 12:41:16 INFO - Copying logs to upload dir... 12:41:16 INFO - mkdir: /builds/slave/test/build/upload/logs 12:41:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.539441 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-09 12:41:15.574144) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 12:41:15.577919) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/536123a30a8c1a53dbad0d753633e7623969c68162c4e9bd8d01078fd9460264479cf50969f4825c8abfb2aa2de7daa163d2749eb8f3a475d3bdc16829566fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41db76b18e9db2a2538df0eb3901fec342e85ef1bb233a5b64f5ea9fe9364ceff354d46709fff21e817ef01ff0050a4e2701aa53147a6d2fad5775220f409608", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0246756423c7966fd570be798de6f7b7e7aed6961a7a9682cccf72adf8fd3e8f42200e8ffb1cb12344e05ca007424792263674458b159e0d07487fa71b75ef08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dd8f4406a28eb79cbf29159a5a3787374bfebb2c44c6312d73e79860ef2b0fcc4b3456d21848db5550b1b508a26885c0b0d89d86bf60e550ed383569b328e6f"} build_url:https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/e8ZVVexxShq1swI3DCjFWA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/536123a30a8c1a53dbad0d753633e7623969c68162c4e9bd8d01078fd9460264479cf50969f4825c8abfb2aa2de7daa163d2749eb8f3a475d3bdc16829566fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41db76b18e9db2a2538df0eb3901fec342e85ef1bb233a5b64f5ea9fe9364ceff354d46709fff21e817ef01ff0050a4e2701aa53147a6d2fad5775220f409608", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0246756423c7966fd570be798de6f7b7e7aed6961a7a9682cccf72adf8fd3e8f42200e8ffb1cb12344e05ca007424792263674458b159e0d07487fa71b75ef08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dd8f4406a28eb79cbf29159a5a3787374bfebb2c44c6312d73e79860ef2b0fcc4b3456d21848db5550b1b508a26885c0b0d89d86bf60e550ed383569b328e6f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 12:41:15.607651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:41:15.607982) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1491765621.892106-1873093691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:41:15.694197) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 12:41:15.694517) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 12:41:15.694853) ========= ========= Total master_lag: 0.33 =========