builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1490905506.4 results: success (0) revision: 8df9fabf2587b7020889755acb9e75b664fe13cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:06.403025) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:06.403486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:06.403797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:06.418814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:06.419152) ========= 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=17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-30 13:25:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.7M=0.001s 2017-03-30 13:25:06 (16.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089643 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:06.526191) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:06.526547) ========= 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=17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019094 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:06.579133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 13:25:06.579511) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8df9fabf2587b7020889755acb9e75b664fe13cf --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 8df9fabf2587b7020889755acb9e75b664fe13cf --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=17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-30 13:25:06,649 truncating revision to first 12 chars 2017-03-30 13:25:06,649 Setting DEBUG logging. 2017-03-30 13:25:06,649 attempt 1/10 2017-03-30 13:25:06,649 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8df9fabf2587?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 13:25:07,358 unpacking tar archive at: mozilla-central-8df9fabf2587/testing/mozharness/ program finished with exit code 0 elapsedTime=1.037711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 13:25:07.632906) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:07.633601) ========= script_repo_revision: 8df9fabf2587b7020889755acb9e75b664fe13cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:07.634414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:07.634858) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 13:25:07.646784) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-03-30 13:25:07.647583) ========= /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=17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:25:07 INFO - MultiFileLogger online at 20170330 13:25:07 in /builds/slave/test 13:25:07 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 13:25:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:07 INFO - {'append_to_log': False, 13:25:07 INFO - 'base_work_dir': '/builds/slave/test', 13:25:07 INFO - 'blob_upload_branch': 'Firefox', 13:25:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:07 INFO - 'branch': 'Firefox', 13:25:07 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:07 INFO - 'config_files': ('talos/linux_config.py',), 13:25:07 INFO - 'default_actions': ('clobber', 13:25:07 INFO - 'read-buildbot-config', 13:25:07 INFO - 'download-and-extract', 13:25:07 INFO - 'populate-webroot', 13:25:07 INFO - 'create-virtualenv', 13:25:07 INFO - 'install', 13:25:07 INFO - 'run-tests'), 13:25:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:07 INFO - 'download_minidump_stackwalk': True, 13:25:07 INFO - 'download_symbols': 'ondemand', 13:25:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:07 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:07 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:07 INFO - 'gecko_profile': False, 13:25:07 INFO - 'gecko_profile_interval': 0, 13:25:07 INFO - 'installer_path': 'installer.exe', 13:25:07 INFO - 'log_level': 'info', 13:25:07 INFO - 'log_name': 'talos', 13:25:07 INFO - 'log_to_console': True, 13:25:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:25:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:25:07 INFO - 'opt_config_files': (), 13:25:07 INFO - 'pip_index': False, 13:25:07 INFO - 'suite': 'dromaeojs', 13:25:07 INFO - 'system_bits': '32', 13:25:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:07 INFO - 'title': 'talos-linux64-ix-009', 13:25:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:07 INFO - 'use_talos_json': True, 13:25:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:07 INFO - 'work_dir': 'build'} 13:25:07 INFO - [mozharness: 2017-03-30 20:25:07.809418Z] Running clobber step. 13:25:07 INFO - Running pre-action listener: _resource_record_pre_action 13:25:07 INFO - Running main action method: clobber 13:25:07 INFO - rmtree: /builds/slave/test/build 13:25:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:25:08 INFO - Running post-action listener: _resource_record_post_action 13:25:08 INFO - [mozharness: 2017-03-30 20:25:08.739639Z] Finished clobber step (success) 13:25:08 INFO - [mozharness: 2017-03-30 20:25:08.739740Z] Running read-buildbot-config step. 13:25:08 INFO - Running pre-action listener: _resource_record_pre_action 13:25:08 INFO - Running main action method: read_buildbot_config 13:25:08 INFO - Using buildbot properties: 13:25:08 INFO - { 13:25:08 INFO - "project": "", 13:25:08 INFO - "product": "firefox", 13:25:08 INFO - "who": "ryanvm@gmail.com", 13:25:08 INFO - "installer_path": "public/build/target.tar.bz2", 13:25:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:25:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:25:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:25:08 INFO - "stage_platform": "linux64-pgo", 13:25:08 INFO - "basedir": "/builds/slave/test", 13:25:08 INFO - "buildnumber": 105, 13:25:08 INFO - "platform": "ubuntu64_hw", 13:25:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:25:08 INFO - "slavebuilddir": "test", 13:25:08 INFO - "taskId": "LXDmzp-JTAyjnJD7limtwA", 13:25:08 INFO - "branch": "mozilla-central", 13:25:08 INFO - "script_repo_revision": "production", 13:25:08 INFO - "revision": "8df9fabf2587b7020889755acb9e75b664fe13cf", 13:25:08 INFO - "slavename": "talos-linux64-ix-009", 13:25:08 INFO - "repo_path": "mozilla-central" 13:25:08 INFO - } 13:25:08 INFO - Finding installer, test and symbols from parent task. 13:25:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LXDmzp-JTAyjnJD7limtwA'}, attempt #1 13:25:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LXDmzp-JTAyjnJD7limtwA'}, attempt #1 13:25:09 INFO - Task dependencies: VhOUcxSDSnye0YXu2Ahz9Q 13:25:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q'}, attempt #1 13:25:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.tar.bz2 13:25:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/test_packages.json 13:25:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.crashreporter-symbols.zip 13:25:10 INFO - Running post-action listener: _resource_record_post_action 13:25:10 INFO - [mozharness: 2017-03-30 20:25:10.104811Z] Finished read-buildbot-config step (success) 13:25:10 INFO - [mozharness: 2017-03-30 20:25:10.105069Z] Running download-and-extract step. 13:25:10 INFO - Running pre-action listener: _resource_record_pre_action 13:25:10 INFO - Running main action method: download_and_extract 13:25:10 INFO - mkdir: /builds/slave/test/build/tests 13:25:10 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')]} 13:25:10 INFO - trying https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.test_packages.json 13:25:10 INFO - Downloading https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:25:10 INFO - Downloaded 986 bytes. 13:25:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:25:10 INFO - Using the following test package requirements: 13:25:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:25:10 INFO - u'common': [u'target.common.tests.zip'], 13:25:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:25:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:25:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:25:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:25:10 INFO - u'mozbase': [u'target.common.tests.zip'], 13:25:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:25:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:25:10 INFO - u'web-platform': [u'target.common.tests.zip', 13:25:10 INFO - u'target.web-platform.tests.zip'], 13:25:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:25:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:25:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.common.tests.zip 13:25:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:25:10 INFO - Fetch https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.common.tests.zip into memory 13:25:12 INFO - Expected file size: 60352526 13:25:12 INFO - Obtained file size: 60352526 13:25:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:25:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.common.tests.zip 13:25:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:25:21 INFO - Fetch https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.common.tests.zip into memory 13:25:23 INFO - Expected file size: 60352526 13:25:23 INFO - Obtained file size: 60352526 13:25:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.talos.tests.zip 13:25:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:25:33 INFO - Fetch https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.talos.tests.zip into memory 13:25:34 INFO - Expected file size: 14404152 13:25:34 INFO - Obtained file size: 14404152 13:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:34 INFO - trying https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.tar.bz2 13:25:34 INFO - Downloading https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:25:35 INFO - Downloaded 68116001 bytes. 13:25:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.tar.bz2 13:25:35 INFO - mkdir: /builds/slave/test/properties 13:25:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:25:35 INFO - Writing to file /builds/slave/test/properties/build_url 13:25:35 INFO - Contents: 13:25:35 INFO - build_url:https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.tar.bz2 13:25:35 INFO - Running post-action listener: _resource_record_post_action 13:25:35 INFO - Running post-action listener: set_extra_try_arguments 13:25:35 INFO - [mozharness: 2017-03-30 20:25:35.856535Z] Finished download-and-extract step (success) 13:25:35 INFO - [mozharness: 2017-03-30 20:25:35.856633Z] Running populate-webroot step. 13:25:35 INFO - Running pre-action listener: _resource_record_pre_action 13:25:35 INFO - Running main action method: populate_webroot 13:25:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:25:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:25:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:25:35 INFO - '--tppagecycles', 13:25:35 INFO - '7'], 13:25:35 INFO - 'tests': ['tsvgm']}}, 13:25:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:25:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:25:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:25:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:25:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:25:35 INFO - 'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:25:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:25:35 INFO - 'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['damp', 'tps']}, 13:25:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:25:35 INFO - 'tests': ['damp', 'tps']}, 13:25:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['dromaeo_dom']}, 13:25:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:25:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['basic_compositor_video']}, 13:25:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:25:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'other-e10s': {'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['tsvgx', 13:25:35 INFO - 'tsvgr_opacity', 13:25:35 INFO - 'tart', 13:25:35 INFO - 'tscrollx', 13:25:35 INFO - 'cart', 13:25:35 INFO - 'tsvg_static']}, 13:25:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:25:35 INFO - 'tsvgr_opacity', 13:25:35 INFO - 'tart', 13:25:35 INFO - 'tscrollx', 13:25:35 INFO - 'cart', 13:25:35 INFO - 'tsvg_static']}, 13:25:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:25:35 INFO - 'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['tp5o']}, 13:25:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:25:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:25:35 INFO - 'talos_options': ['--disable-e10s', 13:25:35 INFO - '--xperf_path', 13:25:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:35 INFO - 'tests': ['tp5n']}, 13:25:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:25:35 INFO - 'talos_options': ['--xperf_path', 13:25:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:35 INFO - 'tests': ['tp5n']}}, 13:25:35 INFO - 'talos.zip': {'path': '', 13:25:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:25:35 INFO - Running post-action listener: _resource_record_post_action 13:25:35 INFO - [mozharness: 2017-03-30 20:25:35.869710Z] Finished populate-webroot step (success) 13:25:35 INFO - [mozharness: 2017-03-30 20:25:35.869800Z] Running create-virtualenv step. 13:25:35 INFO - Running pre-action listener: _resource_record_pre_action 13:25:35 INFO - Running main action method: create_virtualenv 13:25:35 INFO - Creating virtualenv /builds/slave/test/build/venv 13:25:35 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 13:25:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:25:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:25:35 INFO - Using real prefix '/usr' 13:25:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:25:36 INFO - Installing distribute.............................................................................................................................................................................................done. 13:25:38 INFO - Installing pip.................done. 13:25:38 INFO - Return code: 0 13:25:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:25:38 INFO - Reading from file tmpfile_stdout 13:25:38 INFO - Output received: 13:25:38 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) 13:25:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:25:38 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')]} 13:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:38 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')]} 13:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:38 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 0x2a441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', '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 13:25:38 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 13:25:38 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 13:25:38 INFO - Using env: {'DISPLAY': ':0', 13:25:38 INFO - 'HOME': '/home/cltbld', 13:25:38 INFO - 'LANG': 'en_US.UTF-8', 13:25:38 INFO - 'LANGUAGE': 'en_US:en', 13:25:38 INFO - 'LOGNAME': 'cltbld', 13:25:38 INFO - 'MAIL': '/var/mail/cltbld', 13:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:38 INFO - 'MOZ_NO_REMOTE': '1', 13:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:38 INFO - 'NO_EM_RESTART': '1', 13:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:38 INFO - 'PWD': '/builds/slave/test', 13:25:38 INFO - 'SHELL': '/bin/bash', 13:25:38 INFO - 'SHLVL': '1', 13:25:38 INFO - 'TERM': 'linux', 13:25:38 INFO - 'TMOUT': '86400', 13:25:38 INFO - 'USER': 'cltbld', 13:25:38 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:38 INFO - '_': '/tools/buildbot/bin/python'} 13:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:38 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 13:25:38 INFO - Cleaning up... 13:25:38 INFO - Return code: 0 13:25:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:25:38 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')]} 13:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:38 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')]} 13:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:38 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 0x2a441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', '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 13:25:38 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 13:25:38 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 13:25:38 INFO - Using env: {'DISPLAY': ':0', 13:25:38 INFO - 'HOME': '/home/cltbld', 13:25:38 INFO - 'LANG': 'en_US.UTF-8', 13:25:38 INFO - 'LANGUAGE': 'en_US:en', 13:25:38 INFO - 'LOGNAME': 'cltbld', 13:25:38 INFO - 'MAIL': '/var/mail/cltbld', 13:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:38 INFO - 'MOZ_NO_REMOTE': '1', 13:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:38 INFO - 'NO_EM_RESTART': '1', 13:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:38 INFO - 'PWD': '/builds/slave/test', 13:25:38 INFO - 'SHELL': '/bin/bash', 13:25:38 INFO - 'SHLVL': '1', 13:25:38 INFO - 'TERM': 'linux', 13:25:38 INFO - 'TMOUT': '86400', 13:25:38 INFO - 'USER': 'cltbld', 13:25:38 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:38 INFO - '_': '/tools/buildbot/bin/python'} 13:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:39 INFO - Downloading/unpacking psutil>=3.1.1 13:25:39 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 13:25:39 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 13:25:39 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 13:25:39 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 13:25:39 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 13:25:39 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 13:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:25:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:41 INFO - Installing collected packages: psutil 13:25:41 INFO - Running setup.py install for psutil 13:25:41 INFO - building 'psutil._psutil_linux' extension 13:25:41 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 13:25:41 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 13:25:41 INFO - building 'psutil._psutil_posix' extension 13:25:41 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 13:25:41 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 13:25:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:41 INFO - Successfully installed psutil 13:25:41 INFO - Cleaning up... 13:25:41 INFO - Return code: 0 13:25:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:25:41 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')]} 13:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:41 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')]} 13:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:41 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 0x2a441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', '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 13:25:41 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 13:25:41 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 13:25:41 INFO - Using env: {'DISPLAY': ':0', 13:25:41 INFO - 'HOME': '/home/cltbld', 13:25:41 INFO - 'LANG': 'en_US.UTF-8', 13:25:41 INFO - 'LANGUAGE': 'en_US:en', 13:25:41 INFO - 'LOGNAME': 'cltbld', 13:25:41 INFO - 'MAIL': '/var/mail/cltbld', 13:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:41 INFO - 'MOZ_NO_REMOTE': '1', 13:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:41 INFO - 'NO_EM_RESTART': '1', 13:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:41 INFO - 'PWD': '/builds/slave/test', 13:25:41 INFO - 'SHELL': '/bin/bash', 13:25:41 INFO - 'SHLVL': '1', 13:25:41 INFO - 'TERM': 'linux', 13:25:41 INFO - 'TMOUT': '86400', 13:25:41 INFO - 'USER': 'cltbld', 13:25:41 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:41 INFO - '_': '/tools/buildbot/bin/python'} 13:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:25:44 INFO - Installing collected packages: mozsystemmonitor 13:25:44 INFO - Running setup.py install for mozsystemmonitor 13:25:44 INFO - Successfully installed mozsystemmonitor 13:25:44 INFO - Cleaning up... 13:25:44 INFO - Return code: 0 13:25:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:25:44 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')]} 13:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:44 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')]} 13:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:44 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 0x2a441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', '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 13:25:44 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 13:25:44 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 13:25:44 INFO - Using env: {'DISPLAY': ':0', 13:25:44 INFO - 'HOME': '/home/cltbld', 13:25:44 INFO - 'LANG': 'en_US.UTF-8', 13:25:44 INFO - 'LANGUAGE': 'en_US:en', 13:25:44 INFO - 'LOGNAME': 'cltbld', 13:25:44 INFO - 'MAIL': '/var/mail/cltbld', 13:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:44 INFO - 'MOZ_NO_REMOTE': '1', 13:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:44 INFO - 'NO_EM_RESTART': '1', 13:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:44 INFO - 'PWD': '/builds/slave/test', 13:25:44 INFO - 'SHELL': '/bin/bash', 13:25:44 INFO - 'SHLVL': '1', 13:25:44 INFO - 'TERM': 'linux', 13:25:44 INFO - 'TMOUT': '86400', 13:25:44 INFO - 'USER': 'cltbld', 13:25:44 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:44 INFO - '_': '/tools/buildbot/bin/python'} 13:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:44 INFO - Downloading/unpacking jsonschema==2.5.1 13:25:44 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 13:25:44 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 13:25:44 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 13:25:44 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 13:25:44 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 13:25:44 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 13:25:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:25:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:46 INFO - Downloading functools32-3.2.3-2.tar.gz 13:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:25:46 INFO - warning: no files found matching '*.txt' 13:25:46 INFO - no previously-included directories found matching 'build' 13:25:46 INFO - no previously-included directories found matching 'dist' 13:25:46 INFO - no previously-included directories found matching '.git*' 13:25:46 INFO - Installing collected packages: jsonschema, functools32 13:25:46 INFO - Running setup.py install for functools32 13:25:46 INFO - warning: no files found matching '*.txt' 13:25:46 INFO - no previously-included directories found matching 'build' 13:25:46 INFO - no previously-included directories found matching 'dist' 13:25:46 INFO - no previously-included directories found matching '.git*' 13:25:46 INFO - Successfully installed jsonschema functools32 13:25:46 INFO - Cleaning up... 13:25:46 INFO - Return code: 0 13:25:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:25:46 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')]} 13:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:46 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')]} 13:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:46 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 0x2a441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', '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 13:25:46 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 13:25:46 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 13:25:46 INFO - Using env: {'DISPLAY': ':0', 13:25:46 INFO - 'HOME': '/home/cltbld', 13:25:46 INFO - 'LANG': 'en_US.UTF-8', 13:25:46 INFO - 'LANGUAGE': 'en_US:en', 13:25:46 INFO - 'LOGNAME': 'cltbld', 13:25:46 INFO - 'MAIL': '/var/mail/cltbld', 13:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:46 INFO - 'MOZ_NO_REMOTE': '1', 13:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:46 INFO - 'NO_EM_RESTART': '1', 13:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:46 INFO - 'PWD': '/builds/slave/test', 13:25:46 INFO - 'SHELL': '/bin/bash', 13:25:46 INFO - 'SHLVL': '1', 13:25:46 INFO - 'TERM': 'linux', 13:25:46 INFO - 'TMOUT': '86400', 13:25:46 INFO - 'USER': 'cltbld', 13:25:46 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:46 INFO - '_': '/tools/buildbot/bin/python'} 13:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:25:47 INFO - Cleaning up... 13:25:47 INFO - Return code: 0 13:25:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:25:47 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')]} 13:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:47 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')]} 13:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:47 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 0x2a441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', '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 13:25:47 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 13:25:47 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 13:25:47 INFO - Using env: {'DISPLAY': ':0', 13:25:47 INFO - 'HOME': '/home/cltbld', 13:25:47 INFO - 'LANG': 'en_US.UTF-8', 13:25:47 INFO - 'LANGUAGE': 'en_US:en', 13:25:47 INFO - 'LOGNAME': 'cltbld', 13:25:47 INFO - 'MAIL': '/var/mail/cltbld', 13:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:47 INFO - 'MOZ_NO_REMOTE': '1', 13:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:47 INFO - 'NO_EM_RESTART': '1', 13:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:47 INFO - 'PWD': '/builds/slave/test', 13:25:47 INFO - 'SHELL': '/bin/bash', 13:25:47 INFO - 'SHLVL': '1', 13:25:47 INFO - 'TERM': 'linux', 13:25:47 INFO - 'TMOUT': '86400', 13:25:47 INFO - 'USER': 'cltbld', 13:25:47 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:47 INFO - '_': '/tools/buildbot/bin/python'} 13:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:47 INFO - Downloading/unpacking blobuploader==1.2.4 13:25:47 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 13:25:47 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 13:25:47 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 13:25:47 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 13:25:47 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 13:25:47 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 13:25:49 INFO - Downloading blobuploader-1.2.4.tar.gz 13:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:25:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:25:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:50 INFO - Downloading docopt-0.6.1.tar.gz 13:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:25:50 INFO - Installing collected packages: blobuploader, requests, docopt 13:25:50 INFO - Running setup.py install for blobuploader 13:25:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:25:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:25:50 INFO - Running setup.py install for requests 13:25:50 INFO - Running setup.py install for docopt 13:25:50 INFO - Successfully installed blobuploader requests docopt 13:25:50 INFO - Cleaning up... 13:25:50 INFO - Return code: 0 13:25:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25: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')]} 13:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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')]} 13:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:50 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 0x2a441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', '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 13:25:50 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 13:25:50 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 13:25:50 INFO - Using env: {'DISPLAY': ':0', 13:25:50 INFO - 'HOME': '/home/cltbld', 13:25:50 INFO - 'LANG': 'en_US.UTF-8', 13:25:50 INFO - 'LANGUAGE': 'en_US:en', 13:25:50 INFO - 'LOGNAME': 'cltbld', 13:25:50 INFO - 'MAIL': '/var/mail/cltbld', 13:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:50 INFO - 'MOZ_NO_REMOTE': '1', 13:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:50 INFO - 'NO_EM_RESTART': '1', 13:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:50 INFO - 'PWD': '/builds/slave/test', 13:25:50 INFO - 'SHELL': '/bin/bash', 13:25:50 INFO - 'SHLVL': '1', 13:25:50 INFO - 'TERM': 'linux', 13:25:50 INFO - 'TMOUT': '86400', 13:25:50 INFO - 'USER': 'cltbld', 13:25:50 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:50 INFO - '_': '/tools/buildbot/bin/python'} 13:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:25:51 INFO - Running setup.py (path:/tmp/pip-RSwpWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:25:51 INFO - Running setup.py (path:/tmp/pip-FMtJdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:25:51 INFO - Running setup.py (path:/tmp/pip-Xsjrv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:25:51 INFO - Running setup.py (path:/tmp/pip-1ZupQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:25:51 INFO - Running setup.py (path:/tmp/pip-mj9_44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:25:51 INFO - Running setup.py (path:/tmp/pip-tvAL5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:25:51 INFO - Running setup.py (path:/tmp/pip-sb5TgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:25:51 INFO - Running setup.py (path:/tmp/pip-y0_aMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:25:51 INFO - Running setup.py (path:/tmp/pip-IIGa2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:25:51 INFO - Running setup.py (path:/tmp/pip-Tz4NDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:25:51 INFO - Running setup.py (path:/tmp/pip-q3DNnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:25:51 INFO - Running setup.py (path:/tmp/pip-ppswR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:25:51 INFO - Running setup.py (path:/tmp/pip-5BegKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:25:52 INFO - Running setup.py (path:/tmp/pip-QQd8zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:52 INFO - Running setup.py (path:/tmp/pip-FKx2qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:25:52 INFO - Running setup.py (path:/tmp/pip-NMaGNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:25:52 INFO - Running setup.py (path:/tmp/pip-yDSEJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:25:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:25:52 INFO - Running setup.py install for manifestparser 13:25:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Running setup.py install for mozcrash 13:25:52 INFO - Running setup.py install for mozdebug 13:25:52 INFO - Running setup.py install for mozdevice 13:25:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Running setup.py install for mozfile 13:25:52 INFO - Running setup.py install for mozhttpd 13:25:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Running setup.py install for mozinfo 13:25:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:25:52 INFO - Running setup.py install for mozInstall 13:25:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Running setup.py install for mozleak 13:25:53 INFO - Running setup.py install for mozlog 13:25:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Running setup.py install for moznetwork 13:25:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Running setup.py install for mozprocess 13:25:53 INFO - Running setup.py install for mozprofile 13:25:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Running setup.py install for mozrunner 13:25:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:25:53 INFO - Running setup.py install for mozscreenshot 13:25:53 INFO - Running setup.py install for moztest 13:25:53 INFO - Running setup.py install for mozversion 13:25:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:25:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:25:54 INFO - Cleaning up... 13:25:54 INFO - Return code: 0 13:25:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25: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')]} 13:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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')]} 13:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:54 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 0x2a441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', '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 13:25:54 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 13:25:54 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 13:25:54 INFO - Using env: {'DISPLAY': ':0', 13:25:54 INFO - 'HOME': '/home/cltbld', 13:25:54 INFO - 'LANG': 'en_US.UTF-8', 13:25:54 INFO - 'LANGUAGE': 'en_US:en', 13:25:54 INFO - 'LOGNAME': 'cltbld', 13:25:54 INFO - 'MAIL': '/var/mail/cltbld', 13:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:54 INFO - 'MOZ_NO_REMOTE': '1', 13:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:54 INFO - 'NO_EM_RESTART': '1', 13:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:54 INFO - 'PWD': '/builds/slave/test', 13:25:54 INFO - 'SHELL': '/bin/bash', 13:25:54 INFO - 'SHLVL': '1', 13:25:54 INFO - 'TERM': 'linux', 13:25:54 INFO - 'TMOUT': '86400', 13:25:54 INFO - 'USER': 'cltbld', 13:25:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:54 INFO - '_': '/tools/buildbot/bin/python'} 13:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:25:54 INFO - Running setup.py (path:/tmp/pip-Bx7Jqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:25:54 INFO - Running setup.py (path:/tmp/pip-cfPNYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:25:54 INFO - Running setup.py (path:/tmp/pip-OZG9ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:25:54 INFO - Running setup.py (path:/tmp/pip-03KYiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:25:54 INFO - Running setup.py (path:/tmp/pip-RN_l6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:25:54 INFO - Running setup.py (path:/tmp/pip-URsAns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:25:54 INFO - Running setup.py (path:/tmp/pip-g8zWbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:25:54 INFO - Running setup.py (path:/tmp/pip-WjsWAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:25:54 INFO - Running setup.py (path:/tmp/pip-3Zthq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:25:54 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)) 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:25:54 INFO - Running setup.py (path:/tmp/pip-X1nTpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:25:55 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)) 13:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:25:55 INFO - Running setup.py (path:/tmp/pip-UYlRfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:25:55 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)) 13:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:25:55 INFO - Running setup.py (path:/tmp/pip-RWyN35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:25:55 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)) 13:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:25:55 INFO - Running setup.py (path:/tmp/pip-zs03JD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:25:55 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)) 13:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:25:55 INFO - Running setup.py (path:/tmp/pip-bkudya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:25:55 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)) 13:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:55 INFO - Running setup.py (path:/tmp/pip-G_66Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:55 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)) 13:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:25:55 INFO - Running setup.py (path:/tmp/pip-HMPB4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:25:55 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)) 13:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:25:55 INFO - Running setup.py (path:/tmp/pip-mSdUQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:25:55 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)) 13:25:55 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)) 13:25:55 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)) 13:25:55 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)) 13:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:25:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:25:55 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 13:25:55 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 13:25:55 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 13:25:55 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 13:25:55 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 13:25:55 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 13:25:57 INFO - Downloading blessings-1.6.tar.gz 13:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:25:57 INFO - Installing collected packages: blessings 13:25:57 INFO - Running setup.py install for blessings 13:25:57 INFO - Successfully installed blessings 13:25:57 INFO - Cleaning up... 13:25:57 INFO - Return code: 0 13:25:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:25:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:25:58 INFO - Reading from file tmpfile_stdout 13:25:58 INFO - Current package versions: 13:25:58 INFO - argparse == 1.2.1 13:25:58 INFO - blessings == 1.6 13:25:58 INFO - blobuploader == 1.2.4 13:25:58 INFO - docopt == 0.6.1 13:25:58 INFO - functools32 == 3.2.3-2 13:25:58 INFO - jsonschema == 2.5.1 13:25:58 INFO - manifestparser == 1.1 13:25:58 INFO - mozInstall == 1.12 13:25:58 INFO - mozcrash == 1.0 13:25:58 INFO - mozdebug == 0.1 13:25:58 INFO - mozdevice == 0.49 13:25:58 INFO - mozfile == 1.2 13:25:58 INFO - mozhttpd == 0.7 13:25:58 INFO - mozinfo == 0.9 13:25:58 INFO - mozleak == 0.1 13:25:58 INFO - mozlog == 3.4 13:25:58 INFO - moznetwork == 0.27 13:25:58 INFO - mozprocess == 0.25 13:25:58 INFO - mozprofile == 0.28 13:25:58 INFO - mozrunner == 6.13 13:25:58 INFO - mozscreenshot == 0.1 13:25:58 INFO - mozsystemmonitor == 0.3 13:25:58 INFO - moztest == 0.8 13:25:58 INFO - mozversion == 1.4 13:25:58 INFO - psutil == 3.1.1 13:25:58 INFO - requests == 1.2.3 13:25:58 INFO - wsgiref == 0.1.2 13:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:58 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 0x2a441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', '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 13:25:58 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 13:25:58 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 13:25:58 INFO - Using env: {'DISPLAY': ':0', 13:25:58 INFO - 'HOME': '/home/cltbld', 13:25:58 INFO - 'LANG': 'en_US.UTF-8', 13:25:58 INFO - 'LANGUAGE': 'en_US:en', 13:25:58 INFO - 'LOGNAME': 'cltbld', 13:25:58 INFO - 'MAIL': '/var/mail/cltbld', 13:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:58 INFO - 'MOZ_NO_REMOTE': '1', 13:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:58 INFO - 'NO_EM_RESTART': '1', 13:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:58 INFO - 'PWD': '/builds/slave/test', 13:25:58 INFO - 'SHELL': '/bin/bash', 13:25:58 INFO - 'SHLVL': '1', 13:25:58 INFO - 'TERM': 'linux', 13:25:58 INFO - 'TMOUT': '86400', 13:25:58 INFO - 'USER': 'cltbld', 13:25:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:58 INFO - '_': '/tools/buildbot/bin/python'} 13:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 INFO - Cleaning up... 13:25:58 INFO - Return code: 0 13:25:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:58 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 0x2a441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', '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 13:25:58 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 13:25:58 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 13:25:58 INFO - Using env: {'DISPLAY': ':0', 13:25:58 INFO - 'HOME': '/home/cltbld', 13:25:58 INFO - 'LANG': 'en_US.UTF-8', 13:25:58 INFO - 'LANGUAGE': 'en_US:en', 13:25:58 INFO - 'LOGNAME': 'cltbld', 13:25:58 INFO - 'MAIL': '/var/mail/cltbld', 13:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:58 INFO - 'MOZ_NO_REMOTE': '1', 13:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:58 INFO - 'NO_EM_RESTART': '1', 13:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:58 INFO - 'PWD': '/builds/slave/test', 13:25:58 INFO - 'SHELL': '/bin/bash', 13:25:58 INFO - 'SHLVL': '1', 13:25:58 INFO - 'TERM': 'linux', 13:25:58 INFO - 'TMOUT': '86400', 13:25:58 INFO - 'USER': 'cltbld', 13:25:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:58 INFO - '_': '/tools/buildbot/bin/python'} 13:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:25:58 INFO - Cleaning up... 13:25:58 INFO - Return code: 0 13:25:58 INFO - Running post-action listener: _resource_record_post_action 13:25:58 INFO - Running post-action listener: _start_resource_monitoring 13:25:58 INFO - Starting resource monitoring. 13:25:58 INFO - [mozharness: 2017-03-30 20:25:58.518997Z] Finished create-virtualenv step (success) 13:25:58 INFO - [mozharness: 2017-03-30 20:25:58.519464Z] Running install step. 13:25:58 INFO - Running pre-action listener: _resource_record_pre_action 13:25:58 INFO - Running main action method: install 13:25:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:25:58 INFO - Reading from file tmpfile_stdout 13:25:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:25:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:25:58 INFO - Reading from file tmpfile_stdout 13:25:58 INFO - Output received: 13:25:58 INFO - Usage: mozinstall [options] installer 13:25:58 INFO - Options: 13:25:58 INFO - -h, --help show this help message and exit 13:25:58 INFO - -d DEST, --destination=DEST 13:25:58 INFO - Directory to install application into. [default: 13:25:58 INFO - "/builds/slave/test"] 13:25:58 INFO - --app=APP Application being installed. [default: firefox] 13:25:58 INFO - mkdir: /builds/slave/test/build/application 13:25:58 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'] 13:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:26:15 INFO - Reading from file tmpfile_stdout 13:26:15 INFO - Output received: 13:26:15 INFO - /builds/slave/test/build/application/firefox/firefox 13:26:15 INFO - Running post-action listener: _resource_record_post_action 13:26:15 INFO - [mozharness: 2017-03-30 20:26:15.730650Z] Finished install step (success) 13:26:15 INFO - [mozharness: 2017-03-30 20:26:15.730920Z] Running run-tests step. 13:26:15 INFO - Running pre-action listener: _resource_record_pre_action 13:26:15 INFO - Running main action method: run_tests 13:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:26:15 INFO - Python 2.7.3 13:26:15 INFO - Return code: 0 13:26:15 INFO - grabbing minidump binary from tooltool 13:26:15 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')]} 13:26:15 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 0x2cdf400>, '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 0x2ce03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce0840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:26:15 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 13:26:15 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 13:26:15 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 13:26:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:26:15 INFO - Return code: 0 13:26:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:26:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:26:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:26:15 INFO - ENV: RUST_BACKTRACE is now 1 13:26:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:26:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:26:15 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/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 13:26:15 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/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 13:26:15 INFO - Using env: {'DISPLAY': ':0', 13:26:15 INFO - 'HOME': '/home/cltbld', 13:26:15 INFO - 'LANG': 'en_US.UTF-8', 13:26:15 INFO - 'LANGUAGE': 'en_US:en', 13:26:15 INFO - 'LOGNAME': 'cltbld', 13:26:15 INFO - 'MAIL': '/var/mail/cltbld', 13:26:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:26:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:15 INFO - 'MOZ_NO_REMOTE': '1', 13:26:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:15 INFO - 'NO_EM_RESTART': '1', 13:26:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:15 INFO - 'PWD': '/builds/slave/test', 13:26:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:26:15 INFO - 'RUST_BACKTRACE': '1', 13:26:15 INFO - 'SHELL': '/bin/bash', 13:26:15 INFO - 'SHLVL': '1', 13:26:15 INFO - 'TERM': 'linux', 13:26:15 INFO - 'TMOUT': '86400', 13:26:15 INFO - 'USER': 'cltbld', 13:26:15 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493', 13:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:15 INFO - '_': '/tools/buildbot/bin/python'} 13:26:15 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/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 13:26:16 INFO - mozversion application_buildid: 20170330192027 13:26:16 INFO - mozversion application_changeset: 8df9fabf2587b7020889755acb9e75b664fe13cf 13:26:16 INFO - mozversion application_display_name: Nightly 13:26:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:26:16 INFO - mozversion application_name: Firefox 13:26:16 INFO - mozversion application_remotingname: firefox 13:26:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:26:16 INFO - mozversion application_vendor: Mozilla 13:26:16 INFO - mozversion application_version: 55.0a1 13:26:16 INFO - mozversion platform_buildid: 20170330192027 13:26:16 INFO - mozversion platform_changeset: 8df9fabf2587b7020889755acb9e75b664fe13cf 13:26:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:26:16 INFO - mozversion platform_version: 55.0a1 13:26:16 INFO - using testdate: 1490905576 13:26:16 INFO - actual date: 1490905576 13:26:16 INFO - starting webserver on 'localhost:56301' 13:26:16 INFO - SUITE-START | Running 2 tests 13:26:16 INFO - TEST-START | dromaeo_css 13:26:16 INFO - operating with platform_type : linux_ 13:26:16 INFO - Initialising browser for dromaeo_css test... 13:26:16 INFO - TEST-INFO | started process 10957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXnN64/profile http://localhost:56301/getInfo.html) 13:26:19 INFO - PID 10957 | __metrics Screen width/height:1600/1200 13:26:19 INFO - PID 10957 | colorDepth:24 13:26:19 INFO - PID 10957 | Browser inner width/height: 1024/697 13:26:19 INFO - PID 10957 | __metrics 13:26:21 ERROR - PID 10957 | 1490905581336 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 13:26:21 INFO - PID 10957 | 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" 13:26:21 INFO - PID 10957 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:26:22 INFO - TEST-INFO | 10957: exit 0 13:26:22 INFO - Browser initialized. 13:26:22 INFO - Running cycle 1/1 for dromaeo_css test... 13:26:22 INFO - TEST-INFO | started process 11050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXnN64/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:34 INFO - PID 11050 | RSS: Main: 145567744 13:26:34 INFO - PID 11050 | 13:29:36 INFO - PID 11050 | Cycle 1(1): loaded http://localhost:56301/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56301/tests/dromaeo/cssquery-ext.html) 13:29:38 INFO - PID 11050 | RSS: Main: 294993920 13:29:38 INFO - PID 11050 | 13:31:23 INFO - PID 11050 | ************************* 13:31:23 INFO - PID 11050 | A coding exception was thrown and uncaught in a Task. 13:31:23 INFO - PID 11050 | 13:31:23 ERROR - PID 11050 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:31:23 INFO - PID 11050 | Full stack: 13:31:23 INFO - PID 11050 | ************************* 13:31:23 INFO - PID 11050 | ************************* 13:31:23 INFO - PID 11050 | A coding exception was thrown and uncaught in a Task. 13:31:23 INFO - PID 11050 | 13:31:23 ERROR - PID 11050 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:31:23 INFO - PID 11050 | Full stack: 13:31:23 INFO - PID 11050 | ************************* 13:31:23 INFO - PID 11050 | ************************* 13:31:23 INFO - PID 11050 | A coding exception was thrown and uncaught in a Task. 13:31:23 INFO - PID 11050 | 13:31:23 ERROR - PID 11050 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:31:23 INFO - PID 11050 | Full stack: 13:31:23 INFO - PID 11050 | ************************* 13:31:23 INFO - PID 11050 | ************************* 13:31:23 INFO - PID 11050 | A coding exception was thrown and uncaught in a Task. 13:31:23 INFO - PID 11050 | 13:31:23 ERROR - PID 11050 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:31:23 INFO - PID 11050 | Full stack: 13:31:23 INFO - PID 11050 | ************************* 13:32:40 INFO - PID 11050 | Cycle 1(1): loaded http://localhost:56301/tests/dromaeo/cssquery-ext.html (next: http://localhost:56301/tests/dromaeo/cssquery-jquery.html) 13:32:41 INFO - PID 11050 | RSS: Main: 235360256 13:32:41 INFO - PID 11050 | 13:35:43 INFO - PID 11050 | Cycle 1(1): loaded http://localhost:56301/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56301/tests/dromaeo/cssquery-mootools.html) 13:35:43 INFO - PID 11050 | RSS: Main: 181723136 13:35:43 INFO - PID 11050 | 13:38:45 INFO - PID 11050 | Cycle 1(1): loaded http://localhost:56301/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56301/tests/dromaeo/cssquery-prototype.html) 13:38:46 INFO - PID 11050 | RSS: Main: 178069504 13:38:46 INFO - PID 11050 | 13:41:49 INFO - PID 11050 | Cycle 1(1): loaded http://localhost:56301/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56301/tests/dromaeo/cssquery-yui.html) 13:41:49 INFO - PID 11050 | RSS: Main: 184229888 13:41:49 INFO - PID 11050 | 13:44:52 INFO - PID 11050 | Cycle 1(1): loaded http://localhost:56301/tests/dromaeo/cssquery-yui.html (next: http://localhost:56301/tests/dromaeo/cssquery-dojo.html) 13:44:53 INFO - PID 11050 | RSS: Main: 276664320 13:44:53 INFO - PID 11050 | 13:44:53 INFO - PID 11050 | __start_tp_report 13:44:53 INFO - PID 11050 | _x_x_mozilla_page_load 13:44:53 INFO - PID 11050 | _x_x_mozilla_page_load_details 13:44:53 INFO - PID 11050 | |i|pagename|runs| 13:44:53 INFO - PID 11050 | |0;dojo.html;3305;3335.316260166666;3354.2955979244357;3368.141124013376;3383.543221665076;5749.425057494249;5765.884682306357;5782.219400380942;5786;5834.154047663086;5780.0751879699255;5792.218050563172;5819.127130930363;5872.060470324749;5885.234919460464;5103.387593488768;5173.689578625275;5185.55922746567;5225.921611175835;5227.47725227478;5291.206319052135;5298.973505132469;5299.178627312773;5311.362636483627;5356.758945847427;5084.237364395371;5169.043726910496;5176.870578235536;5185.196294574347;5193.45468725784;5271.393789714193;5278.47215278473;5292.655977361498;5348.465153484621;5367.43641917597;5144.305518754958;5150.381954165487;5164.406093299281;5191;5205.479452054802;5592.7762889484375;5711.485966263056;5721.9427805721825;5724.799632012901;5729.255196824428;6147.907781383283;6153.907691384633;6233.34549872266;6236.282827474854;6251.874962500725;6227.221597300338;6257.311695713468;6262.843428914313;6264.373562643745;6264.561480696353;5767.019606666877;5782.913256301159;5785.305763308388;5786.88426231473;5789.2763404574425;6235.064740288903;6286.308506064329;6339.492840572743;6348.111264422984;6455.4512866406885;5946.524278057745;6006.789762358297;6018.548608854353;6133.44798968095;6196.969015154986;6254.312025677172;6291.213598300213;6295.937040629627;6298.244210694746;6311.116443697886;6203.283269297921;6263.279722831932;6280.277768056732;6284;6296.212973378328;6085.69571521431;6093.6554992613665;6179.3202747697715;6189.133521307021;6323;4802.951970480251;4804.615630749532;4817.78319975602;4818;4827.903441931142;4231.915361692749;4250.53244143144;4253.659707223414;4261.019965407973;4301.677374196947;5734.827955161351;5777.335606405233;5800.59395842287;5924.052151655715;5942.227510423617;6313.810585682345;6365.331640177715;6368.745250190033;6373.52198585108;6374.649394283359;5896.233489646404;5913.29040515141;5927.199828023248;5953.464188223081;5978.312494063239;5191.97404012985;5272.130098533699;5314;5360.544353729899;5404.918926216032;6373;6431.83920401975;6453.999999999906;6455.806325810233;6465.127207826978;6323.177986861679;6323.36766323364;6323.588966717149;6329.240491141092;6337.683115844282;6242.094896240111;6565.704543295658;6569.671516424255;6573;6576.473882089517;6111.908321375094;6131.590761709946;6141.854248382413;6178.814635560941;6208.379162083756;6301;6302.338254483213;6311.305756366888;6311.936880631319;6314;6022.457978781756;6061.575689701678;6108.816735497942;6118.479929206067;6125.173101631401;6069.302030266399;6131.804871721949;6132.141360525334;6133.977404287468;6134.773364742599;6194.4115309045565;6213.782517611862;6241.594296370721;6244.718987645476;6246.46905013079;6099;6268.216472940882;6288.622682639057;6295.213098362705;6297.55917085818;5950.702464876826;5968.104784282393;6055.1220073090035;6059.121427393092;6063.120847477179 13:44:53 INFO - PID 11050 | |1;ext.html;740.5001623903863;799.2886331165262;817.2318021060205;1119.1829964126189;1127.4306475230007;31522;32465.83767081167;32475.67524324759;39914.600853991455;40924.795376023154;42602.360964585554;43056;43083.35374969378;43111;43120.56879431205;8403.285720713731;8567.485950842938;8569.400141990063;8571.400001999862;8576.0995095515;6140.8464788380425;6455.225372955252;7934.603269836514;8419.115992820758;8467.153284671545;8507.064222935473;8599.355048371366;8607.39748217625;8609.870851937194;8611.48331100136;8518.063013068588;8580.914190858073;8591.527465989368;8595.828083438359;8604.52675102869;8295.170482951717;8396.916030839735;8411.663533458654;8413.326933845277;8415.663373465053;40052.59947400547;40213.798931005156;40243.39634905449;40286.194276114606;40326.59673403258;2924.38587896542;2936.6916473770375;2942.5586162075647;2944.7055294470597;2977.077106097095;27746.583801242796;27792.861035694692;27930.581041284397;28236.435271294664;29339.85330073336;3609.4659769597815;3620.601733809279;3644.6355364463607;3648.3068217038676;3711.6102809204913;192222;192232;192660;192982;193173.03413482982;45307.09385812265;45398;45434.31848522275;45451.77274113608;45499.31751023737;48283.517164828605;48397;48471;48472.27291590558;48502.5149748498;13506.257155856325;13556;13636.590902272948;13649.590512284647;13687.04190706641;10793.730156746144;10833.67498975032;10844.566217351217;10851.620193293196;10901.236913415985;12689.809652855214;12771.425285862158;12791.808122878165;12798.744025119446;12804.167729097579;5578.330600327906;5618.0449323615085;5654.15187721845;5682.119006827913;5843.1235314703135;994.3536701144315;1045.7814366360508;1050.9316894401993;1087.282393620207;1096.7477480179602;25661.599800647895;26125.869370653025;26214;26226.606600901003;26366.604500932503;1134.2343917855414;1141.2981016674685;1148.3970915269551;1161.3902701082;1181.0433548825479;13494.356523738732;16567.751483727752;17312.913435432994;17550.38573649916;17587.384441544484;339561;340861;342089;342750;343171;60730.39269607247;61308;61324.38675613187;61418;61458.385416146164;1390.2840037380756;1443.689606734536;1447.992760036193;1448.891333150018;1459.1172340733915;29317.26706832346;29587.85206073956;30687.846560767055;30781;30834.53748193734;53286.46713532815;53742.46257537531;53762;53833;54070;357615;359339;360212;360296;360774;34550;35273.647263528066;35404.46893296654;36007.03922568568;36280.818595907906;33443.83278083594;40775;41731;44515.554844451144;45083.77458112688;32704.83647581747;33072.33855322832;33218.66781332156;33279.334413312085;33739.49390759091;32418;32504;32675.34649306953;32912.835435822664;34162;38619.22761544809;39266;39418.802905985285;39457.40813887736;39538;32466.35067298688;32480.83759581187;32484.53819578172;32516.83741581277;32724.672753273117;24978.250652480456;26183;26306.21081367562;26359;26428.560807695976 13:44:53 INFO - PID 11050 | |2;jquery.html;425.6488397072416;430.1440134133076;430.5705059203444;444.85542198785396;451.8237887223981;20123.798762012375;21358.57282854342;22097.447563810914;22148.557028859454;22199.11203551858;21304.36086917391;21845.126194952223;21866.250699944005;22005.66991495129;22153.335399938027;5812.796552120677;6019.458248757611;6033.728482218289;6038.0641000644755;6043.033114701649;5726.3987281335485;6010.669413182273;6045.6674882881425;6064.151018857364;6066.211392518989;5825.796097136601;6042.214512113419;6043.909341359883;6047.425494578008;6051.0318349064155;5844.649321040752;5909.497692696126;5954.732037058299;5973.253343332083;5975.103734439847;5339.145736682112;5385.461453854622;5394.541463975527;5395.460453954613;5513.751881165357;25373.492530149477;25529.23412297634;25676.743232567624;25812.87093564539;25817;1998.0609113716675;2000.689893066577;2051.292304155064;2057.331367305632;2060.464279287396;15180;15236.552527509868;15366.462173823862;15441.845581544154;16057.518274451784;1758.4460894818092;1805.5756897129163;1809.348634491582;1830.4234166237593;1832.1114259584092;105203.47398263036;109271;109347;111262;112604.43697781459;12025.338606376557;12162.331071791137;12228.816567751313;12248.44881980313;12533;17258.568535786704;17288.740668889975;17304.13479326054;17312.653746924992;17313.480595582154;8109.878351824727;8421.536815475207;8467.661293548312;8507.276881465144;8582.914170858336;7533.8116547086765;7535.7362492313605;7581.696732130763;7834.725784597512;7848.960755196302;7510.324070833652;7697.807554811175;7785.260400261966;7800.609969501502;7808.219178082147;2125.6067627488965;2139.679048142791;2242.141269880882;2252.3580779478098;2364.2316247219724;986.4032260482305;992.5434300221979;1000.7898341348252;1001.6043662753171;1004.7488127968008;19871;22370.88814555917;24435.511289774106;24631.261062168163;24697;1002.9247806414548;1010.3382284603597;1020.2246292817512;1030.1707125763833;1031.185363562792;10108.646197383203;11023.669289921316;11043.944780276208;11055.11559075272;11062.668119956414;603672;604436;604890;619455;644269;113631;114733.4263328678;114992.42503787427;116127;118414;1181.8463599731979;1200.087933170779;1237.5297386993066;1247.1394737631188;1261.7161138743709;16189.67620647557;16969.660606788042;17145.228464718868;17182.828171718123;17234.224459899084;44584;46515.30227046529;46610.53389466062;47862.28206576974;48518.757406212746;61347;62879.37120628735;63660.09019729416;63704.36295636984;64172.67913660402;8575.914240857512;8628.568571571272;8743.693970710994;8781.824363512822;9127.863082053642;13385.263810490516;13619.114757540729;13651.79522307186;13852.16886986784;14158.787618185941;11592.594259200887;11738.823917641414;11984.40077996114;12490.87509124897;12648;10833.67498975032;11113.277636953571;11182.66452006441;11577.479013444246;11632.418379081182;11777.352245626573;12091.697707557381;12254.816177757162;12260.693482663004;12358.258504489759;8578.65685372578;8779.912200877909;8805.735827925173;8956.955215223883;8992.370534062553;11710.531578736754;11841.407929603658;12126.333051682243;12219.938900305442;12438.37808109609 13:44:53 INFO - PID 11050 | |3;mootools.html;1175.8647755508118;1308.228145394217;1355.1191725378503;1378.111118328678;1380.1236215003473;9005.27957763379;10661.626843060494;10916.181286403531;10964.28732132411;10973.341599504036;10638.521266543004;10736.73158171046;10737.677869663923;10742.838857417126;10747.08649764771;1921.7117432385114;1985.8411327093797;2244.8091912187483;2289.095807156172;2289.553537060274;2272.329662749493;2348.812095032402;2358.716953965518;2366;2368.348704106367;2292.988535057322;2314.1900334882826;2314.537092581482;2315.849469784467;2334.941626459335;2274.8748818814956;2286.634138537843;2289.5878741826464;2289.874056926885;2291.129370839079;2227.3095340444515;2231.866088034723;2234.5195782906753;2265.4223173090923;2295.8737269450176;10557.841632375521;10618.522166502526;10657.094146997515;10663.040326370587;10664.946675266652;6151.3541078187045;6398.968005159944;6412.262589802186;6412.871742565123;6426.164598602152;3349.464085746269;3409.335179639971;3725.3108174987715;3737.682297004758;3739.8317075731657;1187.857457105153;1228.2384921348732;1237.4369661803948;1252.8183413405004;1278.9040821938393;15797.526074217792;15822.129782861937;15880.761788573182;15892.920535397248;15894.682106357808;4990.30135780991;5147.124988751922;5166.173412254097;5435.592330575144;5493.807716729895;13083.803742943863;13089.803652945213;13104.2137471752;13115.409806558728;13120.278384688743;6073.331933487313;6079.544034197453;6088.817335479943;6094.542909281821;6094.939050609526;5491;5499.450054994469;5774.0761478163295;5828.184054232411;5835.124731290341;4220.430241917364;4307.0955099429475;4344.391785150082;4367.148406060787;4381.101874115862;1289.5744404346542;1291.9095663303478;1295.6372215779597;1303.4590644882267;1313.9737205255842;775.7866586688706;794.5471081483614;805.9476134051268;806.6168569929237;822.9053658829191;6071.908921366183;6132.570720049643;6314.842128946813;6366.236051673829;6545.770898018546;606.6117684681807;611.8470382404399;616.1004932798165;620.1039497925454;926.1942110364026;4423.911521769611;4518.525554816762;4531.932021019687;4657.60410365116;4671.6262698984;13753.862461375258;14077.084989475652;14092.506762263476;14109.57671269843;14119.647008824657;13809.930950345184;14707.338169782386;14905.925470372578;14951.252437378087;14981;10635.946820266005;10798.352098874093;10874.891251087545;10885.673429797118;10902.07332376741;6636.767713130017;6754;6765.729370825112;6841.794746157623;6877.1747390313485;13010.349482526026;13176.209427434385;13364.665883352605;13404.664883377993;13405.195688258736;11027.61403350879;12300.446479908605;13304.068715189844;13490.32548372597;13681.315934203449;9052.23056040244;9148.862767058366;9187.586558604746;9263.305252105984;9292.860607090764;10011;10053.547590358305;10146.695599131743;10155.54300056514;10157.136643385395;8727.476351418934;8739.737807865775;8768.123187681182;8879.28965682731;8901.376903616943;8382.874256886274;8403.747887563139;8553.529555874487;8579.914200857911;8590.78523036929;7628.427867909818;7774.339181169664;7777.261160189773;7780.727674531364;7781;5435.782568697208;5527.364353099284;5531.170324451365;5605.5515558756015;5723.370429252862;5537.224788529528;5570.636608606042;5631.352394474688;5700.344460386943;5715.571332150189 13:44:53 INFO - PID 11050 | |4;prototype.html;406.03734163804535;408.4914281719259;423.8855509012567;427.1307888447011;433.40190537058857;5828.125781132832;5917.431880551657;5920.792772252972;5932.317783454904;5946.970265148668;5755.942440575593;5771.826845194641;5802.12968054792;5835.708214589265;5855.648661080339;4401.691881568291;4504.414426124616;4545.977270113644;4555.248384016633;4628.143793398232;4546.726077487151;4551.704139230956;4552.544745525437;4553.134904368159;4554.476235232941;4525.434320709911;4532.342810292505;4532.750698711569;4542.454905411355;4544.341070544769;4437.156940181355;4480.439945006874;4532.297493888453;4539.4779600346055;4544.795484203202;3953.743006704555;3963.009247688078;3989.3018721723583;3996.300647386696;4007.358822588401;5633.521150702195;5636.436356364372;5636.464535869086;5688.146777983336;5704.543636509069;5088.821891233826;5227.712475813829;5258.6318957672975;5259.684418934838;5273.367195936474;6130.356312587203;6163.322034576193;6169.475594574466;6174.8147555573405;6184.350643182491;4439.289713645833;4441.75570343631;4448.733076015449;4450.732956022649;4464.8214071437105;6133.69331533426;6226.564140510166;6287.591306565105;6471.967640161769;6487.3836985486305;4333.9133217335475;4391.6486681065435;4400.361947517656;4404.801783919731;4404.823807047682;4451.421315228999;4453.955460445354;4464.553544645574;4481.5294394088805;4489.88775280614;4837.080954618611;4848.393950756155;5090.236464530276;5107.7446127693465;5112.872178195575;6094.207752992172;6097.603655762361;6131.988221943329;6141.140240366352;6162.445379915739;1557.8831587630973;1558.1508078097463;1559.0411896683684;1562.1798555758319;1562.5312406278072;1032.1484775060605;1077.3212875888141;1084.3981590217504;1087.5486673030603;1099.7525556749827;5897.056470964625;5900.1739756434135;5902.439268269508;5918.378570250148;5932.525397968238;6284.465820405317;6324.146240257506;6346.174997250328;6360.109584658151;6360.427561519393;5760.107183386582;5819.243498345273;5887.970560147171;5924.5852790305125;5925.200097986803;3308.7353011759;3320.1201681554408;3322.372037701509;3326.5841769778776;3365.663433656615;6466.224053113657;6517.5319326312565;6569.343065693392;6574.5397822152945;6622;6494.383033611799;6494.805155845333;6511.153550038464;6515.641639709766;6528.51036172289;6277.905831412532;6507.642079685474;6569.37590928861;6597.967010164918;6620.238672552622;6287.176718751511;6294.905576416266;6301.6219026858535;6318.4313411793155;6327.145835312174;6179.969100154471;6289.748410063729;6297.779577714941;6304.71628776697;6308.116863639002;6289.245290565162;6375.553711240169;6409.487241020801;6564.8358791030605;6625.701843417154;4523.0953809238945;4528.252838281778;4529.433820772403;4540.772961351985;4549.863504094882;6214.627122372672;6358.872822543431;6373.139626150411;6381.202349706286;6395.232572091379;6126.295476020315;6179.412955769195;6193.2349280454855;6199.225096862892;6206.534509911684;6177.1969643945995;6187.721552530057;6191.226096737908;6211.3167551570195;6229.269072453263;5952.791652292149;6055.576109672281;6090.543209259235;6114.663693496723;6196.442320191204;6160.969195153995;6164.7842325518395;6186.1339412483185;6189.907151392643;6190.7523699051535;5815.331236907809;5973.193618861398;5981.185145957372;5989.580729348903;6047.274327080602 13:44:53 INFO - PID 11050 | |5;yui.html;739.2348918868969;754.7471597014999;764.5947647746692;768.535036303037;772.582805285146;16092.356305747771;17169.399071032516;17286.049267290295;17376.652466950654;17390.21744021519;15449.22753862308;16271.430499932505;16313.102779347131;16322.347106115742;16369.672606547892;930.1860871737247;953.3040880157489;955.4267439536258;955.4935883981466;956.9665061722841;922.4880191493718;944.2681921510815;948.563660716068;950.9952450237773;967.5742673223795;1018.4398580780542;1019.1948360795;1019.4596863662271;1019.7093828258947;1019.7807471393648;1009.90910818026;1010.6311196413329;1011.8633984412121;1013.1185868294594;1013.7414959185397;739.3272122368619;741.2328240271294;741.851629674062;743.2456057102046;744.0253268218597;16390.426335078217;16694.081825499714;16695.83304166955;17443.12784360777;17490.825091749048;16018.919905400515;16069.196540173061;16114.572215741293;16143.838561614351;16441.753373699405;12017;12247.877521224851;12396.157191270735;12569.497220111185;12586.118971671987;3170.8731650733944;3211.132994091582;3308.3217940322174;3336.099253201646;3337.566116404876;90954.54522727344;91980;94716;95692;96066;12059.276443413422;12140.150189486827;12161.513539458323;12406.937965310297;12569.874301257054;25485.10802121917;25638.871805641225;25686;25810.354741131247;26116.608250876252;8060.798480038046;8335.416520843604;8444.240018398374;8543.786405339917;8552.067762830095;3944.36890097583;3970.5235371755575;3980.44273801668;3992.0818211811447;4016.49793775778;4013.257547353749;4094.8976275592754;4098.877033688994;4142.523609784913;4144.647704945053;771.2865599320718;781.4959351218432;805.64551597297;807.8909347238165;812.3501199040744;616.5961295351552;627.8681476889905;639.6322114784018;640.225327353907;653.3956090616161;10611.84082238767;10711.892881071246;10844.783104337868;10879.196072261526;11055;642.9614223146626;652.8379484517567;654.9803505894831;656.3534918105662;661.2792056658266;4634.467036290802;4928.926066109011;4939.703617782944;4967.90064198714;4969.552740253394;80948;80978;81354;83564.58217708993;86501;68944;70243.64878175678;70752;71245;72285.6385718068;64431.35568644253;65412.67293663501;65840;66434.33565664281;66779;9903.356281841658;9923.503824808875;10135.189184865341;10155.54300056514;10188.847167292644;34007.659923400446;34576.654233457346;34795.145141899906;35463;36048.81975590105;41405;41604.3759343604;41963.580364195965;42079.57920420879;42560.36159457549;12142.696432588902;12164.148509604243;12356.505739770308;12536.811947820972;12597.93701031489;12550.169958476892;12607.49570017189;12894.613161605166;12922.547710830077;13007.479700811862;12496.562620308245;12672.556460523838;12967.805482917953;12969.935150324189;13137.73724525485;12766;12982.805257921327;13226.206427614374;13376.799348009594;13674.589762307147;12230.75538489243;12943.352832358532;13010.934945325213;13124.934375328063;13483.730325393633;9226.815463690822;9553.23574114083;9564.234861211226;9657.227421806097;9756.365836220622;10853.837192442277;10878.836817447904;11043.889561104608;11083.224174307721;11143.275687080313 13:44:53 INFO - PID 11050 | __end_tp_report 13:44:53 INFO - PID 11050 | __start_cc_report 13:44:53 INFO - PID 11050 | _x_x_mozilla_cycle_collect,1509 13:44:53 INFO - PID 11050 | __end_cc_report 13:44:53 INFO - PID 11050 | __startTimestamp1490906693045__endTimestamp 13:44:53 INFO - PID 11050 | 13:44:53 INFO - PID 11050 | ------- Summary: start ------- 13:44:53 INFO - PID 11050 | Number of tests: 6 13:44:53 INFO - PID 11050 | 13:44:53 INFO - PID 11050 | [#0] dojo.html Cycles:165 Average:5791.24 Median:6059.12 stddev:680.25 (11.2%) stddev-sans-first:653.78 13:44:53 INFO - PID 11050 | Values: 3305.0 3335.3 3354.3 3368.1 3383.5 5749.4 5765.9 5782.2 5786.0 5834.2 5780.1 5792.2 5819.1 5872.1 5885.2 5103.4 5173.7 5185.6 5225.9 5227.5 5291.2 5299.0 5299.2 5311.4 5356.8 5084.2 5169.0 5176.9 5185.2 5193.5 5271.4 5278.5 5292.7 5348.5 5367.4 5144.3 5150.4 5164.4 5191.0 5205.5 5592.8 5711.5 5721.9 5724.8 5729.3 6147.9 6153.9 6233.3 6236.3 6251.9 6227.2 6257.3 6262.8 6264.4 6264.6 5767.0 5782.9 5785.3 5786.9 5789.3 6235.1 6286.3 6339.5 6348.1 6455.5 5946.5 6006.8 6018.5 6133.4 6197.0 6254.3 6291.2 6295.9 6298.2 6311.1 6203.3 6263.3 6280.3 6284.0 6296.2 6085.7 6093.7 6179.3 6189.1 6323.0 4803.0 4804.6 4817.8 4818.0 4827.9 4231.9 4250.5 4253.7 4261.0 4301.7 5734.8 5777.3 5800.6 5924.1 5942.2 6313.8 6365.3 6368.7 6373.5 6374.6 5896.2 5913.3 5927.2 5953.5 5978.3 5192.0 5272.1 5314.0 5360.5 5404.9 6373.0 6431.8 6454.0 6455.8 6465.1 6323.2 6323.4 6323.6 6329.2 6337.7 6242.1 6565.7 6569.7 6573.0 6576.5 6111.9 6131.6 6141.9 6178.8 6208.4 6301.0 6302.3 6311.3 6311.9 6314.0 6022.5 6061.6 6108.8 6118.5 6125.2 6069.3 6131.8 6132.1 6134.0 6134.8 6194.4 6213.8 6241.6 6244.7 6246.5 6099.0 6268.2 6288.6 6295.2 6297.6 5950.7 5968.1 6055.1 6059.1 6063.1 13:44:53 INFO - PID 11050 | 13:44:53 INFO - PID 11050 | [#1] ext.html Cycles:180 Average:46077.66 Median:34911.82 stddev:80941.48 (231.8%) stddev-sans-first:81096.96 13:44:53 INFO - PID 11050 | Values: 740.5 799.3 817.2 1119.2 1127.4 31522.0 32465.8 32475.7 39914.6 40924.8 42602.4 43056.0 43083.4 43111.0 43120.6 8403.3 8567.5 8569.4 8571.4 8576.1 6140.8 6455.2 7934.6 8419.1 8467.2 8507.1 8599.4 8607.4 8609.9 8611.5 8518.1 8580.9 8591.5 8595.8 8604.5 8295.2 8396.9 8411.7 8413.3 8415.7 40052.6 40213.8 40243.4 40286.2 40326.6 2924.4 2936.7 2942.6 2944.7 2977.1 27746.6 27792.9 27930.6 28236.4 29339.9 3609.5 3620.6 3644.6 3648.3 3711.6 192222.0 192232.0 192660.0 192982.0 193173.0 45307.1 45398.0 45434.3 45451.8 45499.3 48283.5 48397.0 48471.0 48472.3 48502.5 13506.3 13556.0 13636.6 13649.6 13687.0 10793.7 10833.7 10844.6 10851.6 10901.2 12689.8 12771.4 12791.8 12798.7 12804.2 5578.3 5618.0 5654.2 5682.1 5843.1 994.4 1045.8 1050.9 1087.3 1096.7 25661.6 26125.9 26214.0 26226.6 26366.6 1134.2 1141.3 1148.4 1161.4 1181.0 13494.4 16567.8 17312.9 17550.4 17587.4 339561.0 340861.0 342089.0 342750.0 343171.0 60730.4 61308.0 61324.4 61418.0 61458.4 1390.3 1443.7 1448.0 1448.9 1459.1 29317.3 29587.9 30687.8 30781.0 30834.5 53286.5 53742.5 53762.0 53833.0 54070.0 357615.0 359339.0 360212.0 360296.0 360774.0 34550.0 35273.6 35404.5 36007.0 36280.8 33443.8 40775.0 41731.0 44515.6 45083.8 32704.8 33072.3 33218.7 33279.3 33739.5 32418.0 32504.0 32675.3 32912.8 34162.0 38619.2 39266.0 39418.8 39457.4 39538.0 32466.4 32480.8 32484.5 32516.8 32724.7 24978.3 26183.0 26306.2 26359.0 26428.6 13:44:53 INFO - PID 11050 | 13:44:53 INFO - PID 11050 | [#2] jquery.html Cycles:180 Average:34923.71 Median:21935.96 stddev:101807.30 (464.1%) stddev-sans-first:102059.95 13:44:53 INFO - PID 11050 | Values: 425.6 430.1 430.6 444.9 451.8 20123.8 21358.6 22097.4 22148.6 22199.1 21304.4 21845.1 21866.3 22005.7 22153.3 5812.8 6019.5 6033.7 6038.1 6043.0 5726.4 6010.7 6045.7 6064.2 6066.2 5825.8 6042.2 6043.9 6047.4 6051.0 5844.6 5909.5 5954.7 5973.3 5975.1 5339.1 5385.5 5394.5 5395.5 5513.8 25373.5 25529.2 25676.7 25812.9 25817.0 1998.1 2000.7 2051.3 2057.3 2060.5 15180.0 15236.6 15366.5 15441.8 16057.5 1758.4 1805.6 1809.3 1830.4 1832.1 105203.5 109271.0 109347.0 111262.0 112604.4 12025.3 12162.3 12228.8 12248.4 12533.0 17258.6 17288.7 17304.1 17312.7 17313.5 8109.9 8421.5 8467.7 8507.3 8582.9 7533.8 7535.7 7581.7 7834.7 7849.0 7510.3 7697.8 7785.3 7800.6 7808.2 2125.6 2139.7 2242.1 2252.4 2364.2 986.4 992.5 1000.8 1001.6 1004.7 19871.0 22370.9 24435.5 24631.3 24697.0 1002.9 1010.3 1020.2 1030.2 1031.2 10108.6 11023.7 11043.9 11055.1 11062.7 603672.0 604436.0 604890.0 619455.0 644269.0 113631.0 114733.4 114992.4 116127.0 118414.0 1181.8 1200.1 1237.5 1247.1 1261.7 16189.7 16969.7 17145.2 17182.8 17234.2 44584.0 46515.3 46610.5 47862.3 48518.8 61347.0 62879.4 63660.1 63704.4 64172.7 8575.9 8628.6 8743.7 8781.8 9127.9 13385.3 13619.1 13651.8 13852.2 14158.8 11592.6 11738.8 11984.4 12490.9 12648.0 10833.7 11113.3 11182.7 11577.5 11632.4 11777.4 12091.7 12254.8 12260.7 12358.3 8578.7 8779.9 8805.7 8957.0 8992.4 11710.5 11841.4 12126.3 12219.9 12438.4 13:44:53 INFO - PID 11050 | 13:44:53 INFO - PID 11050 | [#3] mootools.html Cycles:180 Average:6875.15 Median:2353.76 stddev:4409.31 (187.3%) stddev-sans-first:4400.88 13:44:53 INFO - PID 11050 | Values: 1175.9 1308.2 1355.1 1378.1 1380.1 9005.3 10661.6 10916.2 10964.3 10973.3 10638.5 10736.7 10737.7 10742.8 10747.1 1921.7 1985.8 2244.8 2289.1 2289.6 2272.3 2348.8 2358.7 2366.0 2368.3 2293.0 2314.2 2314.5 2315.8 2334.9 2274.9 2286.6 2289.6 2289.9 2291.1 2227.3 2231.9 2234.5 2265.4 2295.9 10557.8 10618.5 10657.1 10663.0 10664.9 6151.4 6399.0 6412.3 6412.9 6426.2 3349.5 3409.3 3725.3 3737.7 3739.8 1187.9 1228.2 1237.4 1252.8 1278.9 15797.5 15822.1 15880.8 15892.9 15894.7 4990.3 5147.1 5166.2 5435.6 5493.8 13083.8 13089.8 13104.2 13115.4 13120.3 6073.3 6079.5 6088.8 6094.5 6094.9 5491.0 5499.5 5774.1 5828.2 5835.1 4220.4 4307.1 4344.4 4367.1 4381.1 1289.6 1291.9 1295.6 1303.5 1314.0 775.8 794.5 805.9 806.6 822.9 6071.9 6132.6 6314.8 6366.2 6545.8 606.6 611.8 616.1 620.1 926.2 4423.9 4518.5 4531.9 4657.6 4671.6 13753.9 14077.1 14092.5 14109.6 14119.6 13809.9 14707.3 14905.9 14951.3 14981.0 10635.9 10798.4 10874.9 10885.7 10902.1 6636.8 6754.0 6765.7 6841.8 6877.2 13010.3 13176.2 13364.7 13404.7 13405.2 11027.6 12300.4 13304.1 13490.3 13681.3 9052.2 9148.9 9187.6 9263.3 9292.9 10011.0 10053.5 10146.7 10155.5 10157.1 8727.5 8739.7 8768.1 8879.3 8901.4 8382.9 8403.7 8553.5 8579.9 8590.8 7628.4 7774.3 7777.3 7780.7 7781.0 5435.8 5527.4 5531.2 5605.6 5723.4 5537.2 5570.6 5631.4 5700.3 5715.6 13:44:53 INFO - PID 11050 | 13:44:53 INFO - PID 11050 | [#4] prototype.html Cycles:180 Average:5172.10 Median:5898.62 stddev:1526.07 (25.9%) stddev-sans-first:1487.83 13:44:53 INFO - PID 11050 | Values: 406.0 408.5 423.9 427.1 433.4 5828.1 5917.4 5920.8 5932.3 5947.0 5755.9 5771.8 5802.1 5835.7 5855.6 4401.7 4504.4 4546.0 4555.2 4628.1 4546.7 4551.7 4552.5 4553.1 4554.5 4525.4 4532.3 4532.8 4542.5 4544.3 4437.2 4480.4 4532.3 4539.5 4544.8 3953.7 3963.0 3989.3 3996.3 4007.4 5633.5 5636.4 5636.5 5688.1 5704.5 5088.8 5227.7 5258.6 5259.7 5273.4 6130.4 6163.3 6169.5 6174.8 6184.4 4439.3 4441.8 4448.7 4450.7 4464.8 6133.7 6226.6 6287.6 6472.0 6487.4 4333.9 4391.6 4400.4 4404.8 4404.8 4451.4 4454.0 4464.6 4481.5 4489.9 4837.1 4848.4 5090.2 5107.7 5112.9 6094.2 6097.6 6132.0 6141.1 6162.4 1557.9 1558.2 1559.0 1562.2 1562.5 1032.1 1077.3 1084.4 1087.5 1099.8 5897.1 5900.2 5902.4 5918.4 5932.5 6284.5 6324.1 6346.2 6360.1 6360.4 5760.1 5819.2 5888.0 5924.6 5925.2 3308.7 3320.1 3322.4 3326.6 3365.7 6466.2 6517.5 6569.3 6574.5 6622.0 6494.4 6494.8 6511.2 6515.6 6528.5 6277.9 6507.6 6569.4 6598.0 6620.2 6287.2 6294.9 6301.6 6318.4 6327.1 6180.0 6289.7 6297.8 6304.7 6308.1 6289.2 6375.6 6409.5 6564.8 6625.7 4523.1 4528.3 4529.4 4540.8 4549.9 6214.6 6358.9 6373.1 6381.2 6395.2 6126.3 6179.4 6193.2 6199.2 6206.5 6177.2 6187.7 6191.2 6211.3 6229.3 5952.8 6055.6 6090.5 6114.7 6196.4 6161.0 6164.8 6186.1 6189.9 6190.8 5815.3 5973.2 5981.2 5989.6 6047.3 13:44:53 INFO - PID 11050 | 13:44:53 INFO - PID 11050 | [#5] yui.html Cycles:180 Average:17898.83 Median:35129.07 stddev:23575.39 (67.1%) stddev-sans-first:23606.31 13:44:53 INFO - PID 11050 | Values: 739.2 754.7 764.6 768.5 772.6 16092.4 17169.4 17286.0 17376.7 17390.2 15449.2 16271.4 16313.1 16322.3 16369.7 930.2 953.3 955.4 955.5 957.0 922.5 944.3 948.6 951.0 967.6 1018.4 1019.2 1019.5 1019.7 1019.8 1009.9 1010.6 1011.9 1013.1 1013.7 739.3 741.2 741.9 743.2 744.0 16390.4 16694.1 16695.8 17443.1 17490.8 16018.9 16069.2 16114.6 16143.8 16441.8 12017.0 12247.9 12396.2 12569.5 12586.1 3170.9 3211.1 3308.3 3336.1 3337.6 90954.5 91980.0 94716.0 95692.0 96066.0 12059.3 12140.2 12161.5 12406.9 12569.9 25485.1 25638.9 25686.0 25810.4 26116.6 8060.8 8335.4 8444.2 8543.8 8552.1 3944.4 3970.5 3980.4 3992.1 4016.5 4013.3 4094.9 4098.9 4142.5 4144.6 771.3 781.5 805.6 807.9 812.4 616.6 627.9 639.6 640.2 653.4 10611.8 10711.9 10844.8 10879.2 11055.0 643.0 652.8 655.0 656.4 661.3 4634.5 4928.9 4939.7 4967.9 4969.6 80948.0 80978.0 81354.0 83564.6 86501.0 68944.0 70243.6 70752.0 71245.0 72285.6 64431.4 65412.7 65840.0 66434.3 66779.0 9903.4 9923.5 10135.2 10155.5 10188.8 34007.7 34576.7 34795.1 35463.0 36048.8 41405.0 41604.4 41963.6 42079.6 42560.4 12142.7 12164.1 12356.5 12536.8 12597.9 12550.2 12607.5 12894.6 12922.5 13007.5 12496.6 12672.6 12967.8 12969.9 13137.7 12766.0 12982.8 13226.2 13376.8 13674.6 12230.8 12943.4 13010.9 13124.9 13483.7 9226.8 9553.2 9564.2 9657.2 9756.4 10853.8 10878.8 11043.9 11083.2 11143.3 13:44:53 INFO - PID 11050 | -------- Summary: end -------- 13:44:53 INFO - PID 11050 | 13:44:53 INFO - TEST-INFO | 11050: exit 0 13:44:53 INFO - TEST-OK | dromaeo_css | took 1117874ms 13:44:53 INFO - TEST-START | kraken 13:44:53 INFO - operating with platform_type : linux_ 13:44:53 INFO - Initialising browser for kraken test... 13:44:53 INFO - TEST-INFO | started process 11376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsX4yFz/profile http://localhost:56301/getInfo.html) 13:44:57 INFO - PID 11376 | __metrics Screen width/height:1600/1200 13:44:57 INFO - PID 11376 | colorDepth:24 13:44:57 INFO - PID 11376 | Browser inner width/height: 1024/697 13:44:57 INFO - PID 11376 | __metrics 13:44:58 ERROR - PID 11376 | 1490906698503 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 13:44:58 INFO - PID 11376 | 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" 13:44:58 INFO - PID 11376 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:44:59 INFO - TEST-INFO | 11376: exit 0 13:44:59 INFO - Browser initialized. 13:44:59 INFO - Running cycle 1/1 for kraken test... 13:44:59 INFO - TEST-INFO | started process 11474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsX4yFz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:11 INFO - PID 11474 | RSS: Main: 144814080 13:45:11 INFO - PID 11474 | 13:45:14 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56301/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:15 INFO - PID 11474 | RSS: Main: 200339456 13:45:15 INFO - PID 11474 | 13:45:17 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56301/tests/kraken/driver.html?testName=audio-dft) 13:45:18 INFO - PID 11474 | RSS: Main: 179949568 13:45:18 INFO - PID 11474 | 13:45:21 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56301/tests/kraken/driver.html?testName=audio-fft) 13:45:21 INFO - PID 11474 | RSS: Main: 261357568 13:45:21 INFO - PID 11474 | 13:45:24 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56301/tests/kraken/driver.html?testName=audio-oscillator) 13:45:24 INFO - PID 11474 | RSS: Main: 171991040 13:45:24 INFO - PID 11474 | 13:45:26 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56301/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:45:27 INFO - PID 11474 | RSS: Main: 176959488 13:45:27 INFO - PID 11474 | 13:45:30 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56301/tests/kraken/driver.html?testName=imaging-darkroom) 13:45:31 INFO - PID 11474 | RSS: Main: 214900736 13:45:31 INFO - PID 11474 | 13:45:34 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56301/tests/kraken/driver.html?testName=imaging-desaturate) 13:45:35 INFO - PID 11474 | RSS: Main: 210669568 13:45:35 INFO - PID 11474 | 13:45:38 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56301/tests/kraken/driver.html?testName=json-parse-financial) 13:45:38 INFO - PID 11474 | RSS: Main: 212094976 13:45:38 INFO - PID 11474 | 13:45:40 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56301/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:45:40 INFO - PID 11474 | RSS: Main: 176271360 13:45:40 INFO - PID 11474 | 13:45:42 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56301/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:45:43 INFO - PID 11474 | RSS: Main: 183242752 13:45:43 INFO - PID 11474 | 13:45:45 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56301/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:45:45 INFO - PID 11474 | RSS: Main: 192802816 13:45:45 INFO - PID 11474 | 13:45:48 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:45:49 INFO - PID 11474 | RSS: Main: 201830400 13:45:49 INFO - PID 11474 | 13:45:52 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:45:52 INFO - PID 11474 | RSS: Main: 198320128 13:45:52 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | Cycle 1(1): loaded http://localhost:56301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56301/tests/kraken/driver.html?testName=ai-astar) 13:45:54 INFO - PID 11474 | RSS: Main: 266760192 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | __start_tp_report 13:45:54 INFO - PID 11474 | _x_x_mozilla_page_load 13:45:54 INFO - PID 11474 | _x_x_mozilla_page_load_details 13:45:54 INFO - PID 11474 | |i|pagename|runs| 13:45:54 INFO - PID 11474 | |0;ai-astar;108;114;110;111;111;111;112;109;109;111 13:45:54 INFO - PID 11474 | |1;audio-beat-detection;147;121;119;162;119;123;122;120;144;122 13:45:54 INFO - PID 11474 | |2;audio-dft;165;164;163;164;164;163;165;165;169;165 13:45:54 INFO - PID 11474 | |3;audio-fft;73;76;75;113;76;80;75;77;89;77 13:45:54 INFO - PID 11474 | |4;audio-oscillator;83;83;114;84;84;84;98;89;85;110 13:45:54 INFO - PID 11474 | |5;imaging-gaussian-blur;115;114;114;114;115;113;114;113;114;113 13:45:54 INFO - PID 11474 | |6;imaging-darkroom;148;148;149;148;147;148;149;149;147;147 13:45:54 INFO - PID 11474 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 13:45:54 INFO - PID 11474 | |8;json-parse-financial;57;55;54;57;58;58;57;57;57;57 13:45:54 INFO - PID 11474 | |9;json-stringify-tinderbox;55;56;56;55;55;55;55;56;55;56 13:45:54 INFO - PID 11474 | |10;stanford-crypto-aes;80;80;80;79;79;80;78;78;80;79 13:45:54 INFO - PID 11474 | |11;stanford-crypto-ccm;142;130;136;129;128;132;134;142;190;130 13:45:54 INFO - PID 11474 | |12;stanford-crypto-pbkdf2;184;183;186;194;183;192;183;184;177;183 13:45:54 INFO - PID 11474 | |13;stanford-crypto-sha256-iterative;69;67;67;67;69;66;69;66;68;64 13:45:54 INFO - PID 11474 | __end_tp_report 13:45:54 INFO - PID 11474 | __start_cc_report 13:45:54 INFO - PID 11474 | _x_x_mozilla_cycle_collect,1743 13:45:54 INFO - PID 11474 | __end_cc_report 13:45:54 INFO - PID 11474 | __startTimestamp1490906754807__endTimestamp 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | ------- Summary: start ------- 13:45:54 INFO - PID 11474 | Number of tests: 14 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.71 (1.5%) stddev-sans-first:1.54 13:45:54 INFO - PID 11474 | Values: 108.0 114.0 110.0 111.0 111.0 111.0 112.0 109.0 109.0 111.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:122.50 stddev:15.31 (12.5%) stddev-sans-first:14.93 13:45:54 INFO - PID 11474 | Values: 147.0 121.0 119.0 162.0 119.0 123.0 122.0 120.0 144.0 122.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:1.70 (1.0%) stddev-sans-first:1.80 13:45:54 INFO - PID 11474 | Values: 165.0 164.0 163.0 164.0 164.0 163.0 165.0 165.0 169.0 165.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.50 stddev:12.05 (15.8%) stddev-sans-first:12.42 13:45:54 INFO - PID 11474 | Values: 73.0 76.0 75.0 113.0 76.0 80.0 75.0 77.0 89.0 77.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:84.00 stddev:11.80 (14.0%) stddev-sans-first:12.11 13:45:54 INFO - PID 11474 | Values: 83.0 83.0 114.0 84.0 84.0 84.0 98.0 89.0 85.0 110.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 13:45:54 INFO - PID 11474 | Values: 115.0 114.0 114.0 114.0 115.0 113.0 114.0 113.0 114.0 113.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 13:45:54 INFO - PID 11474 | Values: 148.0 148.0 149.0 148.0 147.0 148.0 149.0 149.0 147.0 147.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:45:54 INFO - PID 11474 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.25 (2.2%) stddev-sans-first:1.32 13:45:54 INFO - PID 11474 | Values: 57.0 55.0 54.0 57.0 58.0 58.0 57.0 57.0 57.0 57.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 13:45:54 INFO - PID 11474 | Values: 55.0 56.0 56.0 55.0 55.0 55.0 55.0 56.0 55.0 56.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:80.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 13:45:54 INFO - PID 11474 | Values: 80.0 80.0 80.0 79.0 79.0 80.0 78.0 78.0 80.0 79.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:135.00 stddev:18.51 (13.7%) stddev-sans-first:19.61 13:45:54 INFO - PID 11474 | Values: 142.0 130.0 136.0 129.0 128.0 132.0 134.0 142.0 190.0 130.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.90 Median:184.00 stddev:4.86 (2.6%) stddev-sans-first:5.15 13:45:54 INFO - PID 11474 | Values: 184.0 183.0 186.0 194.0 183.0 192.0 183.0 184.0 177.0 183.0 13:45:54 INFO - PID 11474 | 13:45:54 INFO - PID 11474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.62 (2.4%) stddev-sans-first:1.58 13:45:54 INFO - PID 11474 | Values: 69.0 67.0 67.0 67.0 69.0 66.0 69.0 66.0 68.0 64.0 13:45:54 INFO - PID 11474 | -------- Summary: end -------- 13:45:54 INFO - PID 11474 | 13:45:55 INFO - TEST-INFO | 11474: exit 0 13:45:55 INFO - TEST-OK | kraken | took 62013ms 13:45:55 INFO - SUITE-END | took 1179s 13:45:55 INFO - Completed test suite (00:19:39) 13:45:55 INFO - javascript benchmark 13:45:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7560.9751395568865, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.0, 3335.316260166666, 3354.2955979244357, 3368.141124013376, 3383.543221665076, 5749.425057494249, 5765.884682306357, 5782.219400380942, 5786.0, 5834.154047663086, 5780.0751879699255, 5792.218050563172, 5819.127130930363, 5872.060470324749, 5885.234919460464, 5103.387593488768, 5173.689578625275, 5185.55922746567, 5225.921611175835, 5227.47725227478, 5291.206319052135, 5298.973505132469, 5299.178627312773, 5311.362636483627, 5356.758945847427, 5084.237364395371, 5169.043726910496, 5176.870578235536, 5185.196294574347, 5193.45468725784, 5271.393789714193, 5278.47215278473, 5292.655977361498, 5348.465153484621, 5367.43641917597, 5144.305518754958, 5150.381954165487, 5164.406093299281, 5191.0, 5205.479452054802, 5592.7762889484375, 5711.485966263056, 5721.9427805721825, 5724.799632012901, 5729.255196824428, 6147.907781383283, 6153.907691384633, 6233.34549872266, 6236.282827474854, 6251.874962500725, 6227.221597300338, 6257.311695713468, 6262.843428914313, 6264.373562643745, 6264.561480696353, 5767.019606666877, 5782.913256301159, 5785.305763308388, 5786.88426231473, 5789.2763404574425, 6235.064740288903, 6286.308506064329, 6339.492840572743, 6348.111264422984, 6455.4512866406885, 5946.524278057745, 6006.789762358297, 6018.548608854353, 6133.44798968095, 6196.969015154986, 6254.312025677172, 6291.213598300213, 6295.937040629627, 6298.244210694746, 6311.116443697886, 6203.283269297921, 6263.279722831932, 6280.277768056732, 6284.0, 6296.212973378328, 6085.69571521431, 6093.6554992613665, 6179.3202747697715, 6189.133521307021, 6323.0, 4802.951970480251, 4804.615630749532, 4817.78319975602, 4818.0, 4827.903441931142, 4231.915361692749, 4250.53244143144, 4253.659707223414, 4261.019965407973, 4301.677374196947, 5734.827955161351, 5777.335606405233, 5800.59395842287, 5924.052151655715, 5942.227510423617, 6313.810585682345, 6365.331640177715, 6368.745250190033, 6373.52198585108, 6374.649394283359, 5896.233489646404, 5913.29040515141, 5927.199828023248, 5953.464188223081, 5978.312494063239, 5191.97404012985, 5272.130098533699, 5314.0, 5360.544353729899, 5404.918926216032, 6373.0, 6431.83920401975, 6453.999999999906, 6455.806325810233, 6465.127207826978, 6323.177986861679, 6323.36766323364, 6323.588966717149, 6329.240491141092, 6337.683115844282, 6242.094896240111, 6565.704543295658, 6569.671516424255, 6573.0, 6576.473882089517, 6111.908321375094, 6131.590761709946, 6141.854248382413, 6178.814635560941, 6208.379162083756, 6301.0, 6302.338254483213, 6311.305756366888, 6311.936880631319, 6314.0, 6022.457978781756, 6061.575689701678, 6108.816735497942, 6118.479929206067, 6125.173101631401, 6069.302030266399, 6131.804871721949, 6132.141360525334, 6133.977404287468, 6134.773364742599, 6194.4115309045565, 6213.782517611862, 6241.594296370721, 6244.718987645476, 6246.46905013079, 6099.0, 6268.216472940882, 6288.622682639057, 6295.213098362705, 6297.55917085818, 5950.702464876826, 5968.104784282393, 6055.1220073090035, 6059.121427393092, 6063.120847477179], "value": 5744.004356659623, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.5001623903863, 799.2886331165262, 817.2318021060205, 1119.1829964126189, 1127.4306475230007, 31522.0, 32465.83767081167, 32475.67524324759, 39914.600853991455, 40924.795376023154, 42602.360964585554, 43056.0, 43083.35374969378, 43111.0, 43120.56879431205, 8403.285720713731, 8567.485950842938, 8569.400141990063, 8571.400001999862, 8576.0995095515, 6140.8464788380425, 6455.225372955252, 7934.603269836514, 8419.115992820758, 8467.153284671545, 8507.064222935473, 8599.355048371366, 8607.39748217625, 8609.870851937194, 8611.48331100136, 8518.063013068588, 8580.914190858073, 8591.527465989368, 8595.828083438359, 8604.52675102869, 8295.170482951717, 8396.916030839735, 8411.663533458654, 8413.326933845277, 8415.663373465053, 40052.59947400547, 40213.798931005156, 40243.39634905449, 40286.194276114606, 40326.59673403258, 2924.38587896542, 2936.6916473770375, 2942.5586162075647, 2944.7055294470597, 2977.077106097095, 27746.583801242796, 27792.861035694692, 27930.581041284397, 28236.435271294664, 29339.85330073336, 3609.4659769597815, 3620.601733809279, 3644.6355364463607, 3648.3068217038676, 3711.6102809204913, 192222.0, 192232.0, 192660.0, 192982.0, 193173.03413482982, 45307.09385812265, 45398.0, 45434.31848522275, 45451.77274113608, 45499.31751023737, 48283.517164828605, 48397.0, 48471.0, 48472.27291590558, 48502.5149748498, 13506.257155856325, 13556.0, 13636.590902272948, 13649.590512284647, 13687.04190706641, 10793.730156746144, 10833.67498975032, 10844.566217351217, 10851.620193293196, 10901.236913415985, 12689.809652855214, 12771.425285862158, 12791.808122878165, 12798.744025119446, 12804.167729097579, 5578.330600327906, 5618.0449323615085, 5654.15187721845, 5682.119006827913, 5843.1235314703135, 994.3536701144315, 1045.7814366360508, 1050.9316894401993, 1087.282393620207, 1096.7477480179602, 25661.599800647895, 26125.869370653025, 26214.0, 26226.606600901003, 26366.604500932503, 1134.2343917855414, 1141.2981016674685, 1148.3970915269551, 1161.3902701082, 1181.0433548825479, 13494.356523738732, 16567.751483727752, 17312.913435432994, 17550.38573649916, 17587.384441544484, 339561.0, 340861.0, 342089.0, 342750.0, 343171.0, 60730.39269607247, 61308.0, 61324.38675613187, 61418.0, 61458.385416146164, 1390.2840037380756, 1443.689606734536, 1447.992760036193, 1448.891333150018, 1459.1172340733915, 29317.26706832346, 29587.85206073956, 30687.846560767055, 30781.0, 30834.53748193734, 53286.46713532815, 53742.46257537531, 53762.0, 53833.0, 54070.0, 357615.0, 359339.0, 360212.0, 360296.0, 360774.0, 34550.0, 35273.647263528066, 35404.46893296654, 36007.03922568568, 36280.818595907906, 33443.83278083594, 40775.0, 41731.0, 44515.554844451144, 45083.77458112688, 32704.83647581747, 33072.33855322832, 33218.66781332156, 33279.334413312085, 33739.49390759091, 32418.0, 32504.0, 32675.34649306953, 32912.835435822664, 34162.0, 38619.22761544809, 39266.0, 39418.802905985285, 39457.40813887736, 39538.0, 32466.35067298688, 32480.83759581187, 32484.53819578172, 32516.83741581277, 32724.672753273117, 24978.250652480456, 26183.0, 26306.21081367562, 26359.0, 26428.560807695976], "value": 17985.802707940675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.6488397072416, 430.1440134133076, 430.5705059203444, 444.85542198785396, 451.8237887223981, 20123.798762012375, 21358.57282854342, 22097.447563810914, 22148.557028859454, 22199.11203551858, 21304.36086917391, 21845.126194952223, 21866.250699944005, 22005.66991495129, 22153.335399938027, 5812.796552120677, 6019.458248757611, 6033.728482218289, 6038.0641000644755, 6043.033114701649, 5726.3987281335485, 6010.669413182273, 6045.6674882881425, 6064.151018857364, 6066.211392518989, 5825.796097136601, 6042.214512113419, 6043.909341359883, 6047.425494578008, 6051.0318349064155, 5844.649321040752, 5909.497692696126, 5954.732037058299, 5973.253343332083, 5975.103734439847, 5339.145736682112, 5385.461453854622, 5394.541463975527, 5395.460453954613, 5513.751881165357, 25373.492530149477, 25529.23412297634, 25676.743232567624, 25812.87093564539, 25817.0, 1998.0609113716675, 2000.689893066577, 2051.292304155064, 2057.331367305632, 2060.464279287396, 15180.0, 15236.552527509868, 15366.462173823862, 15441.845581544154, 16057.518274451784, 1758.4460894818092, 1805.5756897129163, 1809.348634491582, 1830.4234166237593, 1832.1114259584092, 105203.47398263036, 109271.0, 109347.0, 111262.0, 112604.43697781459, 12025.338606376557, 12162.331071791137, 12228.816567751313, 12248.44881980313, 12533.0, 17258.568535786704, 17288.740668889975, 17304.13479326054, 17312.653746924992, 17313.480595582154, 8109.878351824727, 8421.536815475207, 8467.661293548312, 8507.276881465144, 8582.914170858336, 7533.8116547086765, 7535.7362492313605, 7581.696732130763, 7834.725784597512, 7848.960755196302, 7510.324070833652, 7697.807554811175, 7785.260400261966, 7800.609969501502, 7808.219178082147, 2125.6067627488965, 2139.679048142791, 2242.141269880882, 2252.3580779478098, 2364.2316247219724, 986.4032260482305, 992.5434300221979, 1000.7898341348252, 1001.6043662753171, 1004.7488127968008, 19871.0, 22370.88814555917, 24435.511289774106, 24631.261062168163, 24697.0, 1002.9247806414548, 1010.3382284603597, 1020.2246292817512, 1030.1707125763833, 1031.185363562792, 10108.646197383203, 11023.669289921316, 11043.944780276208, 11055.11559075272, 11062.668119956414, 603672.0, 604436.0, 604890.0, 619455.0, 644269.0, 113631.0, 114733.4263328678, 114992.42503787427, 116127.0, 118414.0, 1181.8463599731979, 1200.087933170779, 1237.5297386993066, 1247.1394737631188, 1261.7161138743709, 16189.67620647557, 16969.660606788042, 17145.228464718868, 17182.828171718123, 17234.224459899084, 44584.0, 46515.30227046529, 46610.53389466062, 47862.28206576974, 48518.757406212746, 61347.0, 62879.37120628735, 63660.09019729416, 63704.36295636984, 64172.67913660402, 8575.914240857512, 8628.568571571272, 8743.693970710994, 8781.824363512822, 9127.863082053642, 13385.263810490516, 13619.114757540729, 13651.79522307186, 13852.16886986784, 14158.787618185941, 11592.594259200887, 11738.823917641414, 11984.40077996114, 12490.87509124897, 12648.0, 10833.67498975032, 11113.277636953571, 11182.66452006441, 11577.479013444246, 11632.418379081182, 11777.352245626573, 12091.697707557381, 12254.816177757162, 12260.693482663004, 12358.258504489759, 8578.65685372578, 8779.912200877909, 8805.735827925173, 8956.955215223883, 8992.370534062553, 11710.531578736754, 11841.407929603658, 12126.333051682243, 12219.938900305442, 12438.37808109609], "value": 10066.129878118567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1175.8647755508118, 1308.228145394217, 1355.1191725378503, 1378.111118328678, 1380.1236215003473, 9005.27957763379, 10661.626843060494, 10916.181286403531, 10964.28732132411, 10973.341599504036, 10638.521266543004, 10736.73158171046, 10737.677869663923, 10742.838857417126, 10747.08649764771, 1921.7117432385114, 1985.8411327093797, 2244.8091912187483, 2289.095807156172, 2289.553537060274, 2272.329662749493, 2348.812095032402, 2358.716953965518, 2366.0, 2368.348704106367, 2292.988535057322, 2314.1900334882826, 2314.537092581482, 2315.849469784467, 2334.941626459335, 2274.8748818814956, 2286.634138537843, 2289.5878741826464, 2289.874056926885, 2291.129370839079, 2227.3095340444515, 2231.866088034723, 2234.5195782906753, 2265.4223173090923, 2295.8737269450176, 10557.841632375521, 10618.522166502526, 10657.094146997515, 10663.040326370587, 10664.946675266652, 6151.3541078187045, 6398.968005159944, 6412.262589802186, 6412.871742565123, 6426.164598602152, 3349.464085746269, 3409.335179639971, 3725.3108174987715, 3737.682297004758, 3739.8317075731657, 1187.857457105153, 1228.2384921348732, 1237.4369661803948, 1252.8183413405004, 1278.9040821938393, 15797.526074217792, 15822.129782861937, 15880.761788573182, 15892.920535397248, 15894.682106357808, 4990.30135780991, 5147.124988751922, 5166.173412254097, 5435.592330575144, 5493.807716729895, 13083.803742943863, 13089.803652945213, 13104.2137471752, 13115.409806558728, 13120.278384688743, 6073.331933487313, 6079.544034197453, 6088.817335479943, 6094.542909281821, 6094.939050609526, 5491.0, 5499.450054994469, 5774.0761478163295, 5828.184054232411, 5835.124731290341, 4220.430241917364, 4307.0955099429475, 4344.391785150082, 4367.148406060787, 4381.101874115862, 1289.5744404346542, 1291.9095663303478, 1295.6372215779597, 1303.4590644882267, 1313.9737205255842, 775.7866586688706, 794.5471081483614, 805.9476134051268, 806.6168569929237, 822.9053658829191, 6071.908921366183, 6132.570720049643, 6314.842128946813, 6366.236051673829, 6545.770898018546, 606.6117684681807, 611.8470382404399, 616.1004932798165, 620.1039497925454, 926.1942110364026, 4423.911521769611, 4518.525554816762, 4531.932021019687, 4657.60410365116, 4671.6262698984, 13753.862461375258, 14077.084989475652, 14092.506762263476, 14109.57671269843, 14119.647008824657, 13809.930950345184, 14707.338169782386, 14905.925470372578, 14951.252437378087, 14981.0, 10635.946820266005, 10798.352098874093, 10874.891251087545, 10885.673429797118, 10902.07332376741, 6636.767713130017, 6754.0, 6765.729370825112, 6841.794746157623, 6877.1747390313485, 13010.349482526026, 13176.209427434385, 13364.665883352605, 13404.664883377993, 13405.195688258736, 11027.61403350879, 12300.446479908605, 13304.068715189844, 13490.32548372597, 13681.315934203449, 9052.23056040244, 9148.862767058366, 9187.586558604746, 9263.305252105984, 9292.860607090764, 10011.0, 10053.547590358305, 10146.695599131743, 10155.54300056514, 10157.136643385395, 8727.476351418934, 8739.737807865775, 8768.123187681182, 8879.28965682731, 8901.376903616943, 8382.874256886274, 8403.747887563139, 8553.529555874487, 8579.914200857911, 8590.78523036929, 7628.427867909818, 7774.339181169664, 7777.261160189773, 7780.727674531364, 7781.0, 5435.782568697208, 5527.364353099284, 5531.170324451365, 5605.5515558756015, 5723.370429252862, 5537.224788529528, 5570.636608606042, 5631.352394474688, 5700.344460386943, 5715.571332150189], "value": 5135.445188875668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.03734163804535, 408.4914281719259, 423.8855509012567, 427.1307888447011, 433.40190537058857, 5828.125781132832, 5917.431880551657, 5920.792772252972, 5932.317783454904, 5946.970265148668, 5755.942440575593, 5771.826845194641, 5802.12968054792, 5835.708214589265, 5855.648661080339, 4401.691881568291, 4504.414426124616, 4545.977270113644, 4555.248384016633, 4628.143793398232, 4546.726077487151, 4551.704139230956, 4552.544745525437, 4553.134904368159, 4554.476235232941, 4525.434320709911, 4532.342810292505, 4532.750698711569, 4542.454905411355, 4544.341070544769, 4437.156940181355, 4480.439945006874, 4532.297493888453, 4539.4779600346055, 4544.795484203202, 3953.743006704555, 3963.009247688078, 3989.3018721723583, 3996.300647386696, 4007.358822588401, 5633.521150702195, 5636.436356364372, 5636.464535869086, 5688.146777983336, 5704.543636509069, 5088.821891233826, 5227.712475813829, 5258.6318957672975, 5259.684418934838, 5273.367195936474, 6130.356312587203, 6163.322034576193, 6169.475594574466, 6174.8147555573405, 6184.350643182491, 4439.289713645833, 4441.75570343631, 4448.733076015449, 4450.732956022649, 4464.8214071437105, 6133.69331533426, 6226.564140510166, 6287.591306565105, 6471.967640161769, 6487.3836985486305, 4333.9133217335475, 4391.6486681065435, 4400.361947517656, 4404.801783919731, 4404.823807047682, 4451.421315228999, 4453.955460445354, 4464.553544645574, 4481.5294394088805, 4489.88775280614, 4837.080954618611, 4848.393950756155, 5090.236464530276, 5107.7446127693465, 5112.872178195575, 6094.207752992172, 6097.603655762361, 6131.988221943329, 6141.140240366352, 6162.445379915739, 1557.8831587630973, 1558.1508078097463, 1559.0411896683684, 1562.1798555758319, 1562.5312406278072, 1032.1484775060605, 1077.3212875888141, 1084.3981590217504, 1087.5486673030603, 1099.7525556749827, 5897.056470964625, 5900.1739756434135, 5902.439268269508, 5918.378570250148, 5932.525397968238, 6284.465820405317, 6324.146240257506, 6346.174997250328, 6360.109584658151, 6360.427561519393, 5760.107183386582, 5819.243498345273, 5887.970560147171, 5924.5852790305125, 5925.200097986803, 3308.7353011759, 3320.1201681554408, 3322.372037701509, 3326.5841769778776, 3365.663433656615, 6466.224053113657, 6517.5319326312565, 6569.343065693392, 6574.5397822152945, 6622.0, 6494.383033611799, 6494.805155845333, 6511.153550038464, 6515.641639709766, 6528.51036172289, 6277.905831412532, 6507.642079685474, 6569.37590928861, 6597.967010164918, 6620.238672552622, 6287.176718751511, 6294.905576416266, 6301.6219026858535, 6318.4313411793155, 6327.145835312174, 6179.969100154471, 6289.748410063729, 6297.779577714941, 6304.71628776697, 6308.116863639002, 6289.245290565162, 6375.553711240169, 6409.487241020801, 6564.8358791030605, 6625.701843417154, 4523.0953809238945, 4528.252838281778, 4529.433820772403, 4540.772961351985, 4549.863504094882, 6214.627122372672, 6358.872822543431, 6373.139626150411, 6381.202349706286, 6395.232572091379, 6126.295476020315, 6179.412955769195, 6193.2349280454855, 6199.225096862892, 6206.534509911684, 6177.1969643945995, 6187.721552530057, 6191.226096737908, 6211.3167551570195, 6229.269072453263, 5952.791652292149, 6055.576109672281, 6090.543209259235, 6114.663693496723, 6196.442320191204, 6160.969195153995, 6164.7842325518395, 6186.1339412483185, 6189.907151392643, 6190.7523699051535, 5815.331236907809, 5973.193618861398, 5981.185145957372, 5989.580729348903, 6047.274327080602], "value": 4702.577209888436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.2348918868969, 754.7471597014999, 764.5947647746692, 768.535036303037, 772.582805285146, 16092.356305747771, 17169.399071032516, 17286.049267290295, 17376.652466950654, 17390.21744021519, 15449.22753862308, 16271.430499932505, 16313.102779347131, 16322.347106115742, 16369.672606547892, 930.1860871737247, 953.3040880157489, 955.4267439536258, 955.4935883981466, 956.9665061722841, 922.4880191493718, 944.2681921510815, 948.563660716068, 950.9952450237773, 967.5742673223795, 1018.4398580780542, 1019.1948360795, 1019.4596863662271, 1019.7093828258947, 1019.7807471393648, 1009.90910818026, 1010.6311196413329, 1011.8633984412121, 1013.1185868294594, 1013.7414959185397, 739.3272122368619, 741.2328240271294, 741.851629674062, 743.2456057102046, 744.0253268218597, 16390.426335078217, 16694.081825499714, 16695.83304166955, 17443.12784360777, 17490.825091749048, 16018.919905400515, 16069.196540173061, 16114.572215741293, 16143.838561614351, 16441.753373699405, 12017.0, 12247.877521224851, 12396.157191270735, 12569.497220111185, 12586.118971671987, 3170.8731650733944, 3211.132994091582, 3308.3217940322174, 3336.099253201646, 3337.566116404876, 90954.54522727344, 91980.0, 94716.0, 95692.0, 96066.0, 12059.276443413422, 12140.150189486827, 12161.513539458323, 12406.937965310297, 12569.874301257054, 25485.10802121917, 25638.871805641225, 25686.0, 25810.354741131247, 26116.608250876252, 8060.798480038046, 8335.416520843604, 8444.240018398374, 8543.786405339917, 8552.067762830095, 3944.36890097583, 3970.5235371755575, 3980.44273801668, 3992.0818211811447, 4016.49793775778, 4013.257547353749, 4094.8976275592754, 4098.877033688994, 4142.523609784913, 4144.647704945053, 771.2865599320718, 781.4959351218432, 805.64551597297, 807.8909347238165, 812.3501199040744, 616.5961295351552, 627.8681476889905, 639.6322114784018, 640.225327353907, 653.3956090616161, 10611.84082238767, 10711.892881071246, 10844.783104337868, 10879.196072261526, 11055.0, 642.9614223146626, 652.8379484517567, 654.9803505894831, 656.3534918105662, 661.2792056658266, 4634.467036290802, 4928.926066109011, 4939.703617782944, 4967.90064198714, 4969.552740253394, 80948.0, 80978.0, 81354.0, 83564.58217708993, 86501.0, 68944.0, 70243.64878175678, 70752.0, 71245.0, 72285.6385718068, 64431.35568644253, 65412.67293663501, 65840.0, 66434.33565664281, 66779.0, 9903.356281841658, 9923.503824808875, 10135.189184865341, 10155.54300056514, 10188.847167292644, 34007.659923400446, 34576.654233457346, 34795.145141899906, 35463.0, 36048.81975590105, 41405.0, 41604.3759343604, 41963.580364195965, 42079.57920420879, 42560.36159457549, 12142.696432588902, 12164.148509604243, 12356.505739770308, 12536.811947820972, 12597.93701031489, 12550.169958476892, 12607.49570017189, 12894.613161605166, 12922.547710830077, 13007.479700811862, 12496.562620308245, 12672.556460523838, 12967.805482917953, 12969.935150324189, 13137.73724525485, 12766.0, 12982.805257921327, 13226.206427614374, 13376.799348009594, 13674.589762307147, 12230.75538489243, 12943.352832358532, 13010.934945325213, 13124.934375328063, 13483.730325393633, 9226.815463690822, 9553.23574114083, 9564.234861211226, 9657.227421806097, 9756.365836220622, 10853.837192442277, 10878.836817447904, 11043.889561104608, 11083.224174307721, 11143.275687080313], "value": 7438.958808238166, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 110.0, 111.0, 111.0, 111.0, 112.0, 109.0, 109.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 119.0, 162.0, 119.0, 123.0, 122.0, 120.0, 144.0, 122.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 164.0, 164.0, 163.0, 165.0, 165.0, 169.0, 165.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 75.0, 113.0, 76.0, 80.0, 75.0, 77.0, 89.0, 77.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 84.0, 84.0, 84.0, 98.0, 89.0, 85.0, 110.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0, 113.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 147.0, 148.0, 149.0, 149.0, 147.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 57.0, 58.0, 58.0, 57.0, 57.0, 57.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 79.0, 79.0, 80.0, 78.0, 78.0, 80.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 130.0, 136.0, 129.0, 128.0, 132.0, 134.0, 142.0, 190.0, 130.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 186.0, 194.0, 183.0, 192.0, 183.0, 184.0, 177.0, 183.0], "value": 184.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 69.0, 66.0, 69.0, 66.0, 68.0, 64.0], "value": 67.2, "unit": "score"}]}]} 13:45:56 INFO - Return code: 0 13:45:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:45:56 ERROR - # TBPL SUCCESS # 13:45:56 INFO - Running post-action listener: _resource_record_post_action 13:45:56 INFO - [mozharness: 2017-03-30 20:45:56.090015Z] Finished run-tests step (success) 13:45:56 INFO - Running post-run listener: _resource_record_post_run 13:45:56 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 155648; Write bytes: 370094080; Read time: 324; Write time: 282236 13:45:56 INFO - TinderboxPrint: CPU usage
13.0% 13:45:56 INFO - TinderboxPrint: I/O read bytes / time
155,648 / 324 13:45:56 INFO - TinderboxPrint: I/O write bytes / time
370,094,080 / 282,236 13:45:56 INFO - TinderboxPrint: CPU idle
8,313.1 (87.0%) 13:45:56 INFO - TinderboxPrint: CPU user
1,192.3 (12.5%) 13:45:56 INFO - TinderboxPrint: Swap in / out
0 / 0 13:45:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 111382528; Read time: 72; Write time: 73624 13:45:56 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 151552; Write bytes: 257576960; Read time: 252; Write time: 208552 13:45:56 INFO - Running post-run listener: _upload_blobber_files 13:45:56 INFO - Blob upload gear active. 13:45:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:45:56 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 13:45:56 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'] 13:45:56 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 13:45:57 INFO - (blobuploader) - INFO - Open directory for files ... 13:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:45:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:45:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:45:57 INFO - (blobuploader) - INFO - Done attempting. 13:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:45:58 INFO - (blobuploader) - INFO - Done attempting. 13:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:45:59 INFO - (blobuploader) - INFO - Done attempting. 13:45:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:45:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:45:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:03 INFO - (blobuploader) - INFO - Done attempting. 13:46:03 INFO - (blobuploader) - INFO - Iteration through files over. 13:46:03 INFO - Return code: 0 13:46:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:46:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:46:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fefa6f9747745cbc82a2c30bc7af58e15305b2d5e22568a855cb7a9c467a92e6bbf72ce9937b892ad79e58e6caa1dec93144e3ed3dddb9878a1d3e740486a769", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94eebb4f048da10fcf55b64afb0487b2afff8e7ea962518714874258d25aee2fea69bc40fa46ad6c44dbeb9cf2b7f92d631db412074b76baae863cf7f91f0ce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61b097937417cfb41578ab0e7b5f48066dc43db971ef3d7c178276e70f190345dbce46b77b193601a08e7c0c015b87cbf7a411d001c11e6d2bb047cfb59adc99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dbbc7fc0fe05c10e8fae72224eb0ebdcca10962e4b069552629cf67b71b12125c7dc175c3341f36cbd6f56e0fec6e2a1df6e8d516de1750087b2eee05d8aa8a"} 13:46:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:46:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:46:03 INFO - Contents: 13:46:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fefa6f9747745cbc82a2c30bc7af58e15305b2d5e22568a855cb7a9c467a92e6bbf72ce9937b892ad79e58e6caa1dec93144e3ed3dddb9878a1d3e740486a769", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94eebb4f048da10fcf55b64afb0487b2afff8e7ea962518714874258d25aee2fea69bc40fa46ad6c44dbeb9cf2b7f92d631db412074b76baae863cf7f91f0ce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61b097937417cfb41578ab0e7b5f48066dc43db971ef3d7c178276e70f190345dbce46b77b193601a08e7c0c015b87cbf7a411d001c11e6d2bb047cfb59adc99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dbbc7fc0fe05c10e8fae72224eb0ebdcca10962e4b069552629cf67b71b12125c7dc175c3341f36cbd6f56e0fec6e2a1df6e8d516de1750087b2eee05d8aa8a"} 13:46:03 INFO - Running post-run listener: copy_logs_to_upload_dir 13:46:03 INFO - Copying logs to upload dir... 13:46:03 INFO - mkdir: /builds/slave/test/build/upload/logs 13:46:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.426468 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-03-30 13:46:03.092222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 13:46:03.095329) ========= 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=17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fefa6f9747745cbc82a2c30bc7af58e15305b2d5e22568a855cb7a9c467a92e6bbf72ce9937b892ad79e58e6caa1dec93144e3ed3dddb9878a1d3e740486a769", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94eebb4f048da10fcf55b64afb0487b2afff8e7ea962518714874258d25aee2fea69bc40fa46ad6c44dbeb9cf2b7f92d631db412074b76baae863cf7f91f0ce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61b097937417cfb41578ab0e7b5f48066dc43db971ef3d7c178276e70f190345dbce46b77b193601a08e7c0c015b87cbf7a411d001c11e6d2bb047cfb59adc99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dbbc7fc0fe05c10e8fae72224eb0ebdcca10962e4b069552629cf67b71b12125c7dc175c3341f36cbd6f56e0fec6e2a1df6e8d516de1750087b2eee05d8aa8a"} build_url:https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/VhOUcxSDSnye0YXu2Ahz9Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fefa6f9747745cbc82a2c30bc7af58e15305b2d5e22568a855cb7a9c467a92e6bbf72ce9937b892ad79e58e6caa1dec93144e3ed3dddb9878a1d3e740486a769", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94eebb4f048da10fcf55b64afb0487b2afff8e7ea962518714874258d25aee2fea69bc40fa46ad6c44dbeb9cf2b7f92d631db412074b76baae863cf7f91f0ce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61b097937417cfb41578ab0e7b5f48066dc43db971ef3d7c178276e70f190345dbce46b77b193601a08e7c0c015b87cbf7a411d001c11e6d2bb047cfb59adc99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dbbc7fc0fe05c10e8fae72224eb0ebdcca10962e4b069552629cf67b71b12125c7dc175c3341f36cbd6f56e0fec6e2a1df6e8d516de1750087b2eee05d8aa8a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 13:46:03.120830) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 13:46:03.121136) ========= 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=17051fcd5208b27b50bedfeb000001dd-1490905505.469125-2026983493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 13:46:03.203704) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 13:46:03.204020) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 13:46:03.204332) ========= ========= Total master_lag: 0.18 =========