builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-072 starttime: 1505242071.7 results: success (0) revision: 4069ad6982eabbab5b30fd45de159fe746e5a517 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:51.697308) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:51.697807) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:51.698103) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:51.710568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:51.710966) ========= 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=199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-12 11:47:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-09-12 11:47:51 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.212769 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:51.941786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:51.942147) ========= 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=199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023126 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:51.992952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-12 11:47:51.993307) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4069ad6982eabbab5b30fd45de159fe746e5a517 --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 4069ad6982eabbab5b30fd45de159fe746e5a517 --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=199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-12 11:47:52,054 truncating revision to first 12 chars 2017-09-12 11:47:52,054 Setting DEBUG logging. 2017-09-12 11:47:52,054 attempt 1/10 2017-09-12 11:47:52,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4069ad6982ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-12 11:47:53,145 unpacking tar archive at: mozilla-central-4069ad6982ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.374652 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-12 11:47:53.386533) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:53.386930) ========= script_repo_revision: 4069ad6982eabbab5b30fd45de159fe746e5a517 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:53.387468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:53.387760) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 11:47:53.401579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-12 11:47:53.401996) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --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-stylo-disabled-e10s', '--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=199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:47:53 INFO - MultiFileLogger online at 20170912 11:47:53 in /builds/slave/test 11:47:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:47:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:47:53 INFO - {'append_to_log': False, 11:47:53 INFO - 'base_work_dir': '/builds/slave/test', 11:47:53 INFO - 'blob_upload_branch': 'Firefox', 11:47:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:47:53 INFO - 'branch': 'Firefox', 11:47:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:47:53 INFO - 'code_coverage': False, 11:47:53 INFO - 'config_files': ('talos/linux_config.py',), 11:47:53 INFO - 'default_actions': ('clobber', 11:47:53 INFO - 'read-buildbot-config', 11:47:53 INFO - 'download-and-extract', 11:47:53 INFO - 'populate-webroot', 11:47:53 INFO - 'create-virtualenv', 11:47:53 INFO - 'install', 11:47:53 INFO - 'setup-mitmproxy', 11:47:53 INFO - 'run-tests'), 11:47:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:47:53 INFO - 'disable_ccov_upload': False, 11:47:53 INFO - 'disable_stylo': False, 11:47:53 INFO - 'download_minidump_stackwalk': True, 11:47:53 INFO - 'download_symbols': 'ondemand', 11:47:53 INFO - 'enable_stylo': False, 11:47:53 INFO - 'enable_webrender': False, 11:47:53 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:47:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:47:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:47:53 INFO - 'gecko_profile': False, 11:47:53 INFO - 'gecko_profile_interval': 0, 11:47:53 INFO - 'installer_path': 'installer.exe', 11:47:53 INFO - 'log_level': 'info', 11:47:53 INFO - 'log_name': 'talos', 11:47:53 INFO - 'log_to_console': True, 11:47:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:47:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:47:53 INFO - 'opt_config_files': (), 11:47:53 INFO - 'pip_index': False, 11:47:53 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:47:53 INFO - 'system_bits': '32', 11:47:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:47:53 INFO - 'title': 'talos-linux64-ix-072', 11:47:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:47:53 INFO - 'use_talos_json': True, 11:47:53 INFO - 'verify': 'False', 11:47:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:47:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:47:53 INFO - 'work_dir': 'build'} 11:47:53 INFO - [mozharness: 2017-09-12 18:47:53.601219Z] Running clobber step. 11:47:53 INFO - Running pre-action listener: _resource_record_pre_action 11:47:53 INFO - Running main action method: clobber 11:47:53 INFO - rmtree: /builds/slave/test/build 11:47:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:47:54 INFO - Running post-action listener: _resource_record_post_action 11:47:54 INFO - [mozharness: 2017-09-12 18:47:54.624628Z] Finished clobber step (success) 11:47:54 INFO - [mozharness: 2017-09-12 18:47:54.624726Z] Running read-buildbot-config step. 11:47:54 INFO - Running pre-action listener: _resource_record_pre_action 11:47:54 INFO - Running main action method: read_buildbot_config 11:47:54 INFO - Using buildbot properties: 11:47:54 INFO - { 11:47:54 INFO - "project": "", 11:47:54 INFO - "product": "firefox", 11:47:54 INFO - "who": "ryanvm@gmail.com", 11:47:54 INFO - "installer_path": "public/build/target.tar.bz2", 11:47:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:47:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:47:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 11:47:54 INFO - "stage_platform": "linux64-pgo", 11:47:54 INFO - "basedir": "/builds/slave/test", 11:47:54 INFO - "buildnumber": 9, 11:47:54 INFO - "platform": "ubuntu64_hw", 11:47:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:47:54 INFO - "slavebuilddir": "test", 11:47:54 INFO - "taskId": "QydLlijJRyChBuW08x4wdw", 11:47:54 INFO - "branch": "mozilla-central", 11:47:54 INFO - "script_repo_revision": "production", 11:47:54 INFO - "revision": "4069ad6982eabbab5b30fd45de159fe746e5a517", 11:47:54 INFO - "slavename": "talos-linux64-ix-072", 11:47:54 INFO - "repo_path": "mozilla-central" 11:47:54 INFO - } 11:47:54 INFO - Finding installer, test and symbols from parent task. 11:47:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QydLlijJRyChBuW08x4wdw'}, attempt #1 11:47:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QydLlijJRyChBuW08x4wdw'}, attempt #1 11:47:55 INFO - Task dependencies: WIyyaxl_SfCVWW1rKMtdsA 11:47:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA'}, attempt #1 11:47:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.tar.bz2 11:47:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.test_packages.json 11:47:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.crashreporter-symbols.zip 11:47:56 INFO - Running post-action listener: _resource_record_post_action 11:47:56 INFO - [mozharness: 2017-09-12 18:47:56.065841Z] Finished read-buildbot-config step (success) 11:47:56 INFO - [mozharness: 2017-09-12 18:47:56.066057Z] Running download-and-extract step. 11:47:56 INFO - Running pre-action listener: _resource_record_pre_action 11:47:56 INFO - Running main action method: download_and_extract 11:47:56 INFO - mkdir: /builds/slave/test/build/tests 11:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:47:56 INFO - trying https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.test_packages.json 11:47:56 INFO - Downloading https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:47:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:47:56 INFO - Downloaded 989 bytes. 11:47:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:47:56 INFO - Using the following test package requirements: 11:47:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:47:56 INFO - u'common': [u'target.common.tests.zip'], 11:47:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:47:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:47:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:47:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:47:56 INFO - u'mozbase': [u'target.common.tests.zip'], 11:47:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:47:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:47:56 INFO - u'web-platform': [u'target.common.tests.zip', 11:47:56 INFO - u'target.web-platform.tests.tar.gz'], 11:47:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:47:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:47:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.common.tests.zip 11:47:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:47:56 INFO - Fetch https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.common.tests.zip into memory 11:47:57 INFO - Content-Length response header: 55709761 11:47:57 INFO - Bytes received: 55709761 11:48:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.talos.tests.zip 11:48:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:48:08 INFO - Fetch https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.talos.tests.zip into memory 11:48:09 INFO - Content-Length response header: 14499231 11:48:09 INFO - Bytes received: 14499231 11:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:09 INFO - trying https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.tar.bz2 11:48:09 INFO - Downloading https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:48:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:48:10 INFO - Downloaded 63693408 bytes. 11:48:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.tar.bz2 11:48:10 INFO - mkdir: /builds/slave/test/properties 11:48:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:48:10 INFO - Writing to file /builds/slave/test/properties/build_url 11:48:10 INFO - Contents: 11:48:10 INFO - build_url:https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.tar.bz2 11:48:10 INFO - Running post-action listener: _resource_record_post_action 11:48:10 INFO - Running post-action listener: find_tests_for_verification 11:48:10 INFO - Running post-action listener: set_extra_try_arguments 11:48:10 INFO - [mozharness: 2017-09-12 18:48:10.966024Z] Finished download-and-extract step (success) 11:48:10 INFO - [mozharness: 2017-09-12 18:48:10.966122Z] Running populate-webroot step. 11:48:10 INFO - Running pre-action listener: _resource_record_pre_action 11:48:10 INFO - Running main action method: populate_webroot 11:48:10 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:48:10 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['tresize', 11:48:10 INFO - 'tcanvasmark']}, 11:48:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:48:10 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['dromaeo_css', 11:48:10 INFO - 'kraken']}, 11:48:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:48:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:10 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:48:10 INFO - 'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:48:10 INFO - 'tests': ['damp', 'tps']}, 11:48:10 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:48:10 INFO - 'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['damp', 'tps']}, 11:48:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:48:10 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['dromaeo_dom']}, 11:48:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:48:10 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['basic_compositor_video', 11:48:10 INFO - 'glvideo']}, 11:48:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:48:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:48:10 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:48:10 INFO - 'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['ts_paint_webext', 11:48:10 INFO - 'tp5o_webext']}, 11:48:10 INFO - 'other-e10s': {'tests': ['a11yr', 11:48:10 INFO - 'ts_paint', 11:48:10 INFO - 'tpaint', 11:48:10 INFO - 'sessionrestore', 11:48:10 INFO - 'sessionrestore_many_windows', 11:48:10 INFO - 'sessionrestore_no_auto_restore', 11:48:10 INFO - 'tabpaint']}, 11:48:10 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['a11yr', 11:48:10 INFO - 'ts_paint', 11:48:10 INFO - 'tpaint', 11:48:10 INFO - 'sessionrestore', 11:48:10 INFO - 'sessionrestore_many_windows', 11:48:10 INFO - 'sessionrestore_no_auto_restore', 11:48:10 INFO - 'tabpaint']}, 11:48:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:48:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:48:10 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['bloom_basic_singleton']}, 11:48:10 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['bloom_basic']}, 11:48:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:48:10 INFO - 'tsvgr_opacity', 11:48:10 INFO - 'tart', 11:48:10 INFO - 'tscrollx', 11:48:10 INFO - 'tsvg_static']}, 11:48:10 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['tsvgx', 11:48:10 INFO - 'tsvgr_opacity', 11:48:10 INFO - 'tart', 11:48:10 INFO - 'tscrollx', 11:48:10 INFO - 'tsvg_static']}, 11:48:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:48:10 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:48:10 INFO - 'talos_options': ['--disable-stylo'], 11:48:10 INFO - 'tests': ['tp5o']}, 11:48:10 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:48:10 INFO - 'talos_options': ['--mitmproxy', 11:48:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:48:10 INFO - '--firstNonBlankPaint'], 11:48:10 INFO - 'tests': ['tp6_google', 11:48:10 INFO - 'tp6_youtube', 11:48:10 INFO - 'tp6_amazon', 11:48:10 INFO - 'tp6_facebook']}, 11:48:10 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:48:10 INFO - 'talos_options': ['--disable-stylo', 11:48:10 INFO - '--mitmproxy', 11:48:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:48:10 INFO - '--firstNonBlankPaint'], 11:48:10 INFO - 'tests': ['tp6_google', 11:48:10 INFO - 'tp6_youtube', 11:48:10 INFO - 'tp6_amazon', 11:48:10 INFO - 'tp6_facebook']}, 11:48:10 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:48:10 INFO - 'talos_options': ['--stylo-threads=1', 11:48:10 INFO - '--mitmproxy', 11:48:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:48:10 INFO - '--firstNonBlankPaint'], 11:48:10 INFO - 'tests': ['tp6_google', 11:48:10 INFO - 'tp6_youtube', 11:48:10 INFO - 'tp6_amazon', 11:48:10 INFO - 'tp6_facebook']}, 11:48:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:48:10 INFO - 'talos_options': ['--xperf_path', 11:48:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:10 INFO - 'tests': ['tp5n']}, 11:48:10 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:48:10 INFO - 'talos_options': ['--disable-stylo', 11:48:10 INFO - '--xperf_path', 11:48:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:10 INFO - 'tests': ['tp5n']}}} 11:48:10 INFO - Running post-action listener: _resource_record_post_action 11:48:10 INFO - [mozharness: 2017-09-12 18:48:10.980992Z] Finished populate-webroot step (success) 11:48:10 INFO - [mozharness: 2017-09-12 18:48:10.981082Z] Running create-virtualenv step. 11:48:10 INFO - Running pre-action listener: _resource_record_pre_action 11:48:10 INFO - Running main action method: create_virtualenv 11:48:10 INFO - Creating virtualenv /builds/slave/test/build/venv 11:48:10 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:48:10 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:48:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:48:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:48:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:48:11 INFO - Installing distribute.............................................................................................................................................................................................done. 11:48:11 INFO - Installing pip...............done. 11:48:11 INFO - Return code: 0 11:48:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:48:11 INFO - Reading from file tmpfile_stdout 11:48:11 INFO - Output received: 11:48:11 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:48:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:11 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/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 0x1da51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2111a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, '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': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', '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 11:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:48:11 INFO - Using env: {'DISPLAY': ':0', 11:48:11 INFO - 'HOME': '/home/cltbld', 11:48:11 INFO - 'LANG': 'en_US.UTF-8', 11:48:11 INFO - 'LANGUAGE': 'en_US:en', 11:48:11 INFO - 'LOGNAME': 'cltbld', 11:48:11 INFO - 'MAIL': '/var/mail/cltbld', 11:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:11 INFO - 'MOZ_NO_REMOTE': '1', 11:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:11 INFO - 'NO_EM_RESTART': '1', 11:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:11 INFO - 'PWD': '/builds/slave/test', 11:48:11 INFO - 'SHELL': '/bin/bash', 11:48:11 INFO - 'SHLVL': '1', 11:48:11 INFO - 'TERM': 'linux', 11:48:11 INFO - 'TMOUT': '86400', 11:48:11 INFO - 'USER': 'cltbld', 11:48:11 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:11 INFO - '_': '/tools/buildbot/bin/python'} 11:48:13 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:48:13 INFO - Downloading/unpacking pip>=1.5 11:48:13 INFO - Running setup.py egg_info for package pip 11:48:13 INFO - /usr/lib/python2.7/distutils/dist.py:267: UserWarning: Unknown distribution option: 'python_requires' 11:48:13 INFO - warnings.warn(msg) 11:48:13 INFO - warning: no previously-included files found matching '.coveragerc' 11:48:13 INFO - warning: no previously-included files found matching '.mailmap' 11:48:13 INFO - warning: no previously-included files found matching '.travis.yml' 11:48:13 INFO - warning: no previously-included files found matching '.landscape.yml' 11:48:13 INFO - warning: no previously-included files found matching 'pip/_vendor/Makefile' 11:48:13 INFO - warning: no previously-included files found matching 'tox.ini' 11:48:13 INFO - warning: no previously-included files found matching 'dev-requirements.txt' 11:48:13 INFO - warning: no previously-included files found matching 'appveyor.yml' 11:48:13 INFO - no previously-included directories found matching '.github' 11:48:13 INFO - no previously-included directories found matching '.travis' 11:48:13 INFO - no previously-included directories found matching 'docs/_build' 11:48:13 INFO - no previously-included directories found matching 'contrib' 11:48:13 INFO - no previously-included directories found matching 'tasks' 11:48:13 INFO - no previously-included directories found matching 'tests' 11:48:13 INFO - Installing collected packages: pip 11:48:13 INFO - Found existing installation: pip 1.1 11:48:13 INFO - Uninstalling pip: 11:48:13 INFO - Successfully uninstalled pip 11:48:13 INFO - Running setup.py install for pip 11:48:13 INFO - /usr/lib/python2.7/distutils/dist.py:267: UserWarning: Unknown distribution option: 'python_requires' 11:48:13 INFO - warnings.warn(msg) 11:48:13 INFO - warning: no previously-included files found matching '.coveragerc' 11:48:13 INFO - warning: no previously-included files found matching '.mailmap' 11:48:13 INFO - warning: no previously-included files found matching '.travis.yml' 11:48:13 INFO - warning: no previously-included files found matching '.landscape.yml' 11:48:13 INFO - warning: no previously-included files found matching 'pip/_vendor/Makefile' 11:48:13 INFO - warning: no previously-included files found matching 'tox.ini' 11:48:13 INFO - warning: no previously-included files found matching 'dev-requirements.txt' 11:48:13 INFO - warning: no previously-included files found matching 'appveyor.yml' 11:48:13 INFO - no previously-included directories found matching '.github' 11:48:13 INFO - no previously-included directories found matching '.travis' 11:48:13 INFO - no previously-included directories found matching 'docs/_build' 11:48:13 INFO - no previously-included directories found matching 'contrib' 11:48:13 INFO - no previously-included directories found matching 'tasks' 11:48:13 INFO - no previously-included directories found matching 'tests' 11:48:13 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:48:13 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:48:13 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:48:13 INFO - Successfully installed pip 11:48:13 INFO - Cleaning up... 11:48:13 INFO - Return code: 0 11:48:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1da51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2111a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, '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': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', '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 11:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:48:13 INFO - Using env: {'DISPLAY': ':0', 11:48:13 INFO - 'HOME': '/home/cltbld', 11:48:13 INFO - 'LANG': 'en_US.UTF-8', 11:48:13 INFO - 'LANGUAGE': 'en_US:en', 11:48:13 INFO - 'LOGNAME': 'cltbld', 11:48:13 INFO - 'MAIL': '/var/mail/cltbld', 11:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:13 INFO - 'MOZ_NO_REMOTE': '1', 11:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:13 INFO - 'NO_EM_RESTART': '1', 11:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:13 INFO - 'PWD': '/builds/slave/test', 11:48:13 INFO - 'SHELL': '/bin/bash', 11:48:13 INFO - 'SHLVL': '1', 11:48:13 INFO - 'TERM': 'linux', 11:48:13 INFO - 'TMOUT': '86400', 11:48:13 INFO - 'USER': 'cltbld', 11:48:13 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:13 INFO - '_': '/tools/buildbot/bin/python'} 11:48:13 INFO - Collecting psutil>=3.1.1 11:48:14 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/psutil-3.1.1.tar.gz (247kB) 11:48:15 INFO - Installing collected packages: psutil 11:48:15 INFO - Running setup.py install for psutil: started 11:48:15 INFO - Running setup.py install for psutil: finished with status 'done' 11:48:15 INFO - Successfully installed psutil-3.1.1 11:48:15 INFO - Return code: 0 11:48:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:15 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/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 0x1da51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2111a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, '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': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', '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 11:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:48:15 INFO - Using env: {'DISPLAY': ':0', 11:48:15 INFO - 'HOME': '/home/cltbld', 11:48:15 INFO - 'LANG': 'en_US.UTF-8', 11:48:15 INFO - 'LANGUAGE': 'en_US:en', 11:48:15 INFO - 'LOGNAME': 'cltbld', 11:48:15 INFO - 'MAIL': '/var/mail/cltbld', 11:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:15 INFO - 'MOZ_NO_REMOTE': '1', 11:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:15 INFO - 'NO_EM_RESTART': '1', 11:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:15 INFO - 'PWD': '/builds/slave/test', 11:48:15 INFO - 'SHELL': '/bin/bash', 11:48:15 INFO - 'SHLVL': '1', 11:48:15 INFO - 'TERM': 'linux', 11:48:15 INFO - 'TMOUT': '86400', 11:48:15 INFO - 'USER': 'cltbld', 11:48:15 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:15 INFO - '_': '/tools/buildbot/bin/python'} 11:48:16 INFO - Collecting mozsystemmonitor==0.3 11:48:17 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/mozsystemmonitor-0.3.tar.gz 11:48:17 INFO - Requirement already satisfied: psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:48:17 INFO - Installing collected packages: mozsystemmonitor 11:48:17 INFO - Running setup.py install for mozsystemmonitor: started 11:48:17 INFO - Running setup.py install for mozsystemmonitor: finished with status 'done' 11:48:18 INFO - Successfully installed mozsystemmonitor-0.3 11:48:18 INFO - Return code: 0 11:48:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:18 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/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 0x1da51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2111a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, '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': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', '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 11:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:48:18 INFO - Using env: {'DISPLAY': ':0', 11:48:18 INFO - 'HOME': '/home/cltbld', 11:48:18 INFO - 'LANG': 'en_US.UTF-8', 11:48:18 INFO - 'LANGUAGE': 'en_US:en', 11:48:18 INFO - 'LOGNAME': 'cltbld', 11:48:18 INFO - 'MAIL': '/var/mail/cltbld', 11:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:18 INFO - 'MOZ_NO_REMOTE': '1', 11:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:18 INFO - 'NO_EM_RESTART': '1', 11:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:18 INFO - 'PWD': '/builds/slave/test', 11:48:18 INFO - 'SHELL': '/bin/bash', 11:48:18 INFO - 'SHLVL': '1', 11:48:18 INFO - 'TERM': 'linux', 11:48:18 INFO - 'TMOUT': '86400', 11:48:18 INFO - 'USER': 'cltbld', 11:48:18 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:18 INFO - '_': '/tools/buildbot/bin/python'} 11:48:19 INFO - Collecting jsonschema==2.5.1 11:48:20 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/jsonschema-2.5.1-py2.py3-none-any.whl 11:48:20 INFO - Collecting functools32; python_version == "2.7" (from jsonschema==2.5.1) 11:48:21 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/functools32-3.2.3-2.tar.gz 11:48:22 INFO - Installing collected packages: functools32, jsonschema 11:48:22 INFO - Running setup.py install for functools32: started 11:48:22 INFO - Running setup.py install for functools32: finished with status 'done' 11:48:22 INFO - Successfully installed functools32-3.2.3.post2 jsonschema-2.5.1 11:48:22 INFO - Return code: 0 11:48:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1da51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2111a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, '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': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', '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 11:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:48:22 INFO - Using env: {'DISPLAY': ':0', 11:48:22 INFO - 'HOME': '/home/cltbld', 11:48:22 INFO - 'LANG': 'en_US.UTF-8', 11:48:22 INFO - 'LANGUAGE': 'en_US:en', 11:48:22 INFO - 'LOGNAME': 'cltbld', 11:48:22 INFO - 'MAIL': '/var/mail/cltbld', 11:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:22 INFO - 'MOZ_NO_REMOTE': '1', 11:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:22 INFO - 'NO_EM_RESTART': '1', 11:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:22 INFO - 'PWD': '/builds/slave/test', 11:48:22 INFO - 'SHELL': '/bin/bash', 11:48:22 INFO - 'SHLVL': '1', 11:48:22 INFO - 'TERM': 'linux', 11:48:22 INFO - 'TMOUT': '86400', 11:48:22 INFO - 'USER': 'cltbld', 11:48:22 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:22 INFO - '_': '/tools/buildbot/bin/python'} 11:48:22 INFO - Requirement already satisfied: functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:48:22 INFO - Return code: 0 11:48:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1da51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2111a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, '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': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', '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 11:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:48:22 INFO - Using env: {'DISPLAY': ':0', 11:48:22 INFO - 'HOME': '/home/cltbld', 11:48:22 INFO - 'LANG': 'en_US.UTF-8', 11:48:22 INFO - 'LANGUAGE': 'en_US:en', 11:48:22 INFO - 'LOGNAME': 'cltbld', 11:48:22 INFO - 'MAIL': '/var/mail/cltbld', 11:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:22 INFO - 'MOZ_NO_REMOTE': '1', 11:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:22 INFO - 'NO_EM_RESTART': '1', 11:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:22 INFO - 'PWD': '/builds/slave/test', 11:48:22 INFO - 'SHELL': '/bin/bash', 11:48:22 INFO - 'SHLVL': '1', 11:48:22 INFO - 'TERM': 'linux', 11:48:22 INFO - 'TMOUT': '86400', 11:48:22 INFO - 'USER': 'cltbld', 11:48:22 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:22 INFO - '_': '/tools/buildbot/bin/python'} 11:48:23 INFO - Collecting blobuploader==1.2.4 11:48:24 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/blobuploader-1.2.4.tar.gz 11:48:24 INFO - Collecting requests==1.2.3. (from blobuploader==1.2.4) 11:48:25 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/requests-1.2.3.tar.gz (348kB) 11:48:26 INFO - Collecting docopt==0.6.1 (from blobuploader==1.2.4) 11:48:27 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/docopt-0.6.1.tar.gz 11:48:27 INFO - Installing collected packages: requests, docopt, blobuploader 11:48:27 INFO - Running setup.py install for requests: started 11:48:27 INFO - Running setup.py install for requests: finished with status 'done' 11:48:27 INFO - Running setup.py install for docopt: started 11:48:27 INFO - Running setup.py install for docopt: finished with status 'done' 11:48:27 INFO - Running setup.py install for blobuploader: started 11:48:27 INFO - Running setup.py install for blobuploader: finished with status 'done' 11:48:27 INFO - Successfully installed blobuploader-1.2.4 docopt-0.6.1 requests-1.2.3 11:48:27 INFO - Return code: 0 11:48:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:27 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/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 0x1da51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2111a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, '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': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', '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 11:48:27 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:48:27 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:48:27 INFO - Using env: {'DISPLAY': ':0', 11:48:27 INFO - 'HOME': '/home/cltbld', 11:48:27 INFO - 'LANG': 'en_US.UTF-8', 11:48:27 INFO - 'LANGUAGE': 'en_US:en', 11:48:27 INFO - 'LOGNAME': 'cltbld', 11:48:27 INFO - 'MAIL': '/var/mail/cltbld', 11:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:27 INFO - 'MOZ_NO_REMOTE': '1', 11:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:27 INFO - 'NO_EM_RESTART': '1', 11:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:27 INFO - 'PWD': '/builds/slave/test', 11:48:27 INFO - 'SHELL': '/bin/bash', 11:48:27 INFO - 'SHLVL': '1', 11:48:27 INFO - 'TERM': 'linux', 11:48:27 INFO - 'TMOUT': '86400', 11:48:27 INFO - 'USER': 'cltbld', 11:48:27 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:27 INFO - '_': '/tools/buildbot/bin/python'} 11:48:28 INFO - Processing /builds/slave/test/build/tests/mozbase/manifestparser 11:48:28 INFO - Processing /builds/slave/test/build/tests/mozbase/mozcrash 11:48:28 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdebug 11:48:28 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdevice 11:48:28 INFO - Processing /builds/slave/test/build/tests/mozbase/mozfile 11:48:28 INFO - Processing /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:29 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinfo 11:48:29 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinstall 11:48:29 INFO - Processing /builds/slave/test/build/tests/mozbase/mozleak 11:48:29 INFO - Processing /builds/slave/test/build/tests/mozbase/mozlog 11:48:29 INFO - Processing /builds/slave/test/build/tests/mozbase/moznetwork 11:48:29 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprocess 11:48:29 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprofile 11:48:29 INFO - Processing /builds/slave/test/build/tests/mozbase/mozrunner 11:48:29 INFO - Processing /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:30 INFO - Processing /builds/slave/test/build/tests/mozbase/moztest 11:48:30 INFO - Processing /builds/slave/test/build/tests/mozbase/mozversion 11:48:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:48:30 INFO - Running setup.py install for manifestparser: started 11:48:30 INFO - Running setup.py install for manifestparser: finished with status 'done' 11:48:30 INFO - Running setup.py install for mozcrash: started 11:48:30 INFO - Running setup.py install for mozcrash: finished with status 'done' 11:48:30 INFO - Running setup.py install for mozdebug: started 11:48:30 INFO - Running setup.py install for mozdebug: finished with status 'done' 11:48:30 INFO - Running setup.py install for mozdevice: started 11:48:30 INFO - Running setup.py install for mozdevice: finished with status 'done' 11:48:30 INFO - Running setup.py install for mozfile: started 11:48:30 INFO - Running setup.py install for mozfile: finished with status 'done' 11:48:30 INFO - Running setup.py install for mozhttpd: started 11:48:30 INFO - Running setup.py install for mozhttpd: finished with status 'done' 11:48:30 INFO - Running setup.py install for mozinfo: started 11:48:30 INFO - Running setup.py install for mozinfo: finished with status 'done' 11:48:30 INFO - Running setup.py install for mozInstall: started 11:48:30 INFO - Running setup.py install for mozInstall: finished with status 'done' 11:48:30 INFO - Running setup.py install for mozleak: started 11:48:31 INFO - Running setup.py install for mozleak: finished with status 'done' 11:48:31 INFO - Running setup.py install for mozlog: started 11:48:31 INFO - Running setup.py install for mozlog: finished with status 'done' 11:48:31 INFO - Running setup.py install for moznetwork: started 11:48:31 INFO - Running setup.py install for moznetwork: finished with status 'done' 11:48:31 INFO - Running setup.py install for mozprocess: started 11:48:31 INFO - Running setup.py install for mozprocess: finished with status 'done' 11:48:31 INFO - Running setup.py install for mozprofile: started 11:48:31 INFO - Running setup.py install for mozprofile: finished with status 'done' 11:48:31 INFO - Running setup.py install for mozrunner: started 11:48:31 INFO - Running setup.py install for mozrunner: finished with status 'done' 11:48:31 INFO - Running setup.py install for mozscreenshot: started 11:48:31 INFO - Running setup.py install for mozscreenshot: finished with status 'done' 11:48:31 INFO - Running setup.py install for moztest: started 11:48:31 INFO - Running setup.py install for moztest: finished with status 'done' 11:48:31 INFO - Running setup.py install for mozversion: started 11:48:31 INFO - Running setup.py install for mozversion: finished with status 'done' 11:48:32 INFO - Successfully installed manifestparser-1.1 mozInstall-1.13 mozcrash-1.0 mozdebug-0.1 mozdevice-0.51 mozfile-1.2 mozhttpd-0.7 mozinfo-0.10 mozleak-0.1 mozlog-3.5 moznetwork-0.27 mozprocess-0.25 mozprofile-0.28 mozrunner-6.13 mozscreenshot-0.1 moztest-0.8 mozversion-1.4 11:48:32 INFO - Return code: 0 11:48:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1da51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2111a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, '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': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', '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 11:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:48:32 INFO - Using env: {'DISPLAY': ':0', 11:48:32 INFO - 'HOME': '/home/cltbld', 11:48:32 INFO - 'LANG': 'en_US.UTF-8', 11:48:32 INFO - 'LANGUAGE': 'en_US:en', 11:48:32 INFO - 'LOGNAME': 'cltbld', 11:48:32 INFO - 'MAIL': '/var/mail/cltbld', 11:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:32 INFO - 'MOZ_NO_REMOTE': '1', 11:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:32 INFO - 'NO_EM_RESTART': '1', 11:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:32 INFO - 'PWD': '/builds/slave/test', 11:48:32 INFO - 'SHELL': '/bin/bash', 11:48:32 INFO - 'SHLVL': '1', 11:48:32 INFO - 'TERM': 'linux', 11:48:32 INFO - 'TMOUT': '86400', 11:48:32 INFO - 'USER': 'cltbld', 11:48:32 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:32 INFO - '_': '/tools/buildbot/bin/python'} 11:48:32 INFO - Processing /builds/slave/test/build/tests/mozbase/manifestparser 11:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:48:32 INFO - Processing /builds/slave/test/build/tests/mozbase/mozcrash 11:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:48:32 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdebug 11:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:48:32 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdevice 11:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/mozfile 11:48:33 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)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:33 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)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinfo 11:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinstall 11:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/mozleak 11:48:33 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)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/mozlog 11:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/moznetwork 11:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprocess 11:48:33 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)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprofile 11:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/mozrunner 11:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:48:33 INFO - Processing /builds/slave/test/build/tests/mozbase/moztest 11:48:34 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)) 11:48:34 INFO - Processing /builds/slave/test/build/tests/mozbase/mozversion 11:48:34 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)) 11:48:34 INFO - Requirement already satisfied: 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)) 11:48:34 INFO - Requirement already satisfied: 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)) 11:48:34 INFO - Requirement already satisfied: 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)) 11:48:34 INFO - Requirement already satisfied: moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:48:34 INFO - Requirement already satisfied: mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:48:34 INFO - Requirement already satisfied: requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:48:34 INFO - Collecting blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:48:35 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/blessings-1.6.tar.gz 11:48:35 INFO - Installing collected packages: blessings 11:48:35 INFO - Running setup.py install for blessings: started 11:48:35 INFO - Running setup.py install for blessings: finished with status 'done' 11:48:35 INFO - Successfully installed blessings-1.6 11:48:35 INFO - Return code: 0 11:48:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:48:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:36 INFO - Reading from file tmpfile_stdout 11:48:36 INFO - Reading from file tmpfile_stderr 11:48:36 INFO - Current package versions: 11:48:36 INFO - blessings == 1.6 11:48:36 INFO - blobuploader == 1.2.4 11:48:36 INFO - docopt == 0.6.1 11:48:36 INFO - functools32 == 3.2.3.post2 11:48:36 INFO - jsonschema == 2.5.1 11:48:36 INFO - manifestparser == 1.1 11:48:36 INFO - mozInstall == 1.13 11:48:36 INFO - mozcrash == 1.0 11:48:36 INFO - mozdebug == 0.1 11:48:36 INFO - mozdevice == 0.51 11:48:36 INFO - mozfile == 1.2 11:48:36 INFO - mozhttpd == 0.7 11:48:36 INFO - mozinfo == 0.10 11:48:36 INFO - mozleak == 0.1 11:48:36 INFO - mozlog == 3.5 11:48:36 INFO - moznetwork == 0.27 11:48:36 INFO - mozprocess == 0.25 11:48:36 INFO - mozprofile == 0.28 11:48:36 INFO - mozrunner == 6.13 11:48:36 INFO - mozscreenshot == 0.1 11:48:36 INFO - mozsystemmonitor == 0.3 11:48:36 INFO - moztest == 0.8 11:48:36 INFO - mozversion == 1.4 11:48:36 INFO - psutil == 3.1.1 11:48:36 INFO - requests == 1.2.3 11:48:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1da51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2111a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, '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': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', '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 11:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:48:36 INFO - Using env: {'DISPLAY': ':0', 11:48:36 INFO - 'HOME': '/home/cltbld', 11:48:36 INFO - 'LANG': 'en_US.UTF-8', 11:48:36 INFO - 'LANGUAGE': 'en_US:en', 11:48:36 INFO - 'LOGNAME': 'cltbld', 11:48:36 INFO - 'MAIL': '/var/mail/cltbld', 11:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:36 INFO - 'MOZ_NO_REMOTE': '1', 11:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:36 INFO - 'NO_EM_RESTART': '1', 11:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:36 INFO - 'PWD': '/builds/slave/test', 11:48:36 INFO - 'SHELL': '/bin/bash', 11:48:36 INFO - 'SHLVL': '1', 11:48:36 INFO - 'TERM': 'linux', 11:48:36 INFO - 'TMOUT': '86400', 11:48:36 INFO - 'USER': 'cltbld', 11:48:36 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:36 INFO - '_': '/tools/buildbot/bin/python'} 11:48:36 INFO - Requirement already satisfied: 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)) 11:48:36 INFO - Requirement already satisfied: 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)) 11:48:36 INFO - Requirement already satisfied: 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)) 11:48:36 INFO - Requirement already satisfied: 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)) 11:48:36 INFO - Requirement already satisfied: 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)) 11:48:36 INFO - Requirement already satisfied: 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)) 11:48:36 INFO - Requirement already satisfied: 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)) 11:48:36 INFO - Requirement already satisfied: 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)) 11:48:36 INFO - Requirement already satisfied: 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)) 11:48:36 INFO - Collecting simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:48:38 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/simplejson-3.3.0.tar.gz (67kB) 11:48:38 INFO - Requirement already satisfied: 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)) 11:48:38 INFO - Requirement already satisfied: 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)) 11:48:38 INFO - Installing collected packages: simplejson 11:48:38 INFO - Running setup.py install for simplejson: started 11:48:39 INFO - Running setup.py install for simplejson: finished with status 'done' 11:48:39 INFO - Successfully installed simplejson-3.3.0 11:48:39 INFO - Return code: 0 11:48:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:39 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/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 0x1da51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2111a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, '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': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', '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 11:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:48:39 INFO - Using env: {'DISPLAY': ':0', 11:48:39 INFO - 'HOME': '/home/cltbld', 11:48:39 INFO - 'LANG': 'en_US.UTF-8', 11:48:39 INFO - 'LANGUAGE': 'en_US:en', 11:48:39 INFO - 'LOGNAME': 'cltbld', 11:48:39 INFO - 'MAIL': '/var/mail/cltbld', 11:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:39 INFO - 'MOZ_NO_REMOTE': '1', 11:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:39 INFO - 'NO_EM_RESTART': '1', 11:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:39 INFO - 'PWD': '/builds/slave/test', 11:48:39 INFO - 'SHELL': '/bin/bash', 11:48:39 INFO - 'SHLVL': '1', 11:48:39 INFO - 'TERM': 'linux', 11:48:39 INFO - 'TMOUT': '86400', 11:48:39 INFO - 'USER': 'cltbld', 11:48:39 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:39 INFO - '_': '/tools/buildbot/bin/python'} 11:48:39 INFO - Requirement already satisfied: jsonschema in ./venv/lib/python2.7/site-packages 11:48:39 INFO - Requirement already satisfied: functools32; python_version == "2.7" in ./venv/lib/python2.7/site-packages (from jsonschema) 11:48:39 INFO - Return code: 0 11:48:39 INFO - Running post-action listener: _resource_record_post_action 11:48:39 INFO - Running post-action listener: _start_resource_monitoring 11:48:39 INFO - Starting resource monitoring. 11:48:39 INFO - [mozharness: 2017-09-12 18:48:39.837034Z] Finished create-virtualenv step (success) 11:48:39 INFO - [mozharness: 2017-09-12 18:48:39.837555Z] Running install step. 11:48:39 INFO - Running pre-action listener: _resource_record_pre_action 11:48:39 INFO - Running main action method: install 11:48:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:40 INFO - Reading from file tmpfile_stdout 11:48:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:48:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:48:40 INFO - Reading from file tmpfile_stdout 11:48:40 INFO - Output received: 11:48:40 INFO - Usage: mozinstall [options] installer 11:48:40 INFO - Options: 11:48:40 INFO - -h, --help show this help message and exit 11:48:40 INFO - -d DEST, --destination=DEST 11:48:40 INFO - Directory to install application into. [default: 11:48:40 INFO - "/builds/slave/test"] 11:48:40 INFO - --app=APP Application being installed. [default: firefox] 11:48:40 INFO - mkdir: /builds/slave/test/build/application 11:48:40 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'] 11:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:48:56 INFO - Reading from file tmpfile_stdout 11:48:56 INFO - Output received: 11:48:56 INFO - /builds/slave/test/build/application/firefox/firefox 11:48:56 INFO - Running post-action listener: _resource_record_post_action 11:48:56 INFO - [mozharness: 2017-09-12 18:48:56.899446Z] Finished install step (success) 11:48:56 INFO - [mozharness: 2017-09-12 18:48:56.899597Z] Running setup-mitmproxy step. 11:48:56 INFO - Running pre-action listener: _resource_record_pre_action 11:48:56 INFO - Running main action method: setup_mitmproxy 11:48:56 INFO - Skipping: mitmproxy is not required 11:48:56 INFO - Running post-action listener: _resource_record_post_action 11:48:56 INFO - [mozharness: 2017-09-12 18:48:56.900720Z] Finished setup-mitmproxy step (success) 11:48:56 INFO - [mozharness: 2017-09-12 18:48:56.900941Z] Running run-tests step. 11:48:56 INFO - Running pre-action listener: _resource_record_pre_action 11:48:56 INFO - Running pre-action listener: _set_gcov_prefix 11:48:56 INFO - Running main action method: run_tests 11:48:56 WARNING - Try message not found. 11:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:48:56 INFO - Python 2.7.3 11:48:56 INFO - Return code: 0 11:48:56 INFO - grabbing minidump binary from tooltool 11:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:48:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x2115090>, '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 0x2115d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:48:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 11:48:56 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:48:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 11:48:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:48:57 INFO - Return code: 0 11:48:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:48:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:48:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:48:57 INFO - ENV: RUST_BACKTRACE is now full 11:48:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:48:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:48:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:48:57 INFO - Using env: {'DISPLAY': ':0', 11:48:57 INFO - 'HOME': '/home/cltbld', 11:48:57 INFO - 'LANG': 'en_US.UTF-8', 11:48:57 INFO - 'LANGUAGE': 'en_US:en', 11:48:57 INFO - 'LOGNAME': 'cltbld', 11:48:57 INFO - 'MAIL': '/var/mail/cltbld', 11:48:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:48:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:57 INFO - 'MOZ_NO_REMOTE': '1', 11:48:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:57 INFO - 'NO_EM_RESTART': '1', 11:48:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:57 INFO - 'PWD': '/builds/slave/test', 11:48:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:48:57 INFO - 'RUST_BACKTRACE': 'full', 11:48:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:48:57 INFO - 'SHELL': '/bin/bash', 11:48:57 INFO - 'SHLVL': '1', 11:48:57 INFO - 'TERM': 'linux', 11:48:57 INFO - 'TMOUT': '86400', 11:48:57 INFO - 'USER': 'cltbld', 11:48:57 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:57 INFO - '_': '/tools/buildbot/bin/python'} 11:48:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:48:57 INFO - mozversion application_buildid: 20170912172131 11:48:57 INFO - mozversion application_changeset: 4069ad6982eabbab5b30fd45de159fe746e5a517 11:48:57 INFO - mozversion application_display_name: Nightly 11:48:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:48:57 INFO - mozversion application_name: Firefox 11:48:57 INFO - mozversion application_remotingname: firefox 11:48:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:48:57 INFO - mozversion application_vendor: Mozilla 11:48:57 INFO - mozversion application_version: 57.0a1 11:48:57 INFO - mozversion platform_buildid: 20170912172131 11:48:57 INFO - mozversion platform_changeset: 4069ad6982eabbab5b30fd45de159fe746e5a517 11:48:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:48:57 INFO - mozversion platform_version: 57.0a1 11:48:57 INFO - using testdate: 1505242137 11:48:57 INFO - actual date: 1505242137 11:48:57 INFO - starting webserver on 'localhost:35597' 11:48:57 INFO - SUITE-START | Running 2 tests 11:48:57 INFO - TEST-START | dromaeo_css 11:48:57 INFO - Initialising browser for dromaeo_css test... 11:48:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35597/getInfo.html -profile /tmp/tmphwOVu8/profile 11:48:57 INFO - TEST-INFO | started process 20464 (/builds/slave/test/build/application/firefox/firefox http://localhost:35597/getInfo.html) 11:49:02 INFO - TEST-INFO | 20464: exit 0 11:49:02 INFO - Browser initialized. 11:49:02 INFO - Running cycle 1/1 for dromaeo_css test... 11:49:02 INFO - Using env: {'DISPLAY': ':0', 11:49:02 INFO - 'HOME': '/home/cltbld', 11:49:02 INFO - 'JSGC_DISABLE_POISONING': '1', 11:49:02 INFO - 'LANG': 'en_US.UTF-8', 11:49:02 INFO - 'LANGUAGE': 'en_US:en', 11:49:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:49:02 INFO - 'LOGNAME': 'cltbld', 11:49:02 INFO - 'MAIL': '/var/mail/cltbld', 11:49:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:49:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:49:02 INFO - 'MOZ_CRASHREPORTER': '1', 11:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:49:02 INFO - 'MOZ_NO_REMOTE': '1', 11:49:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:02 INFO - 'NO_EM_RESTART': '1', 11:49:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:02 INFO - 'PWD': '/builds/slave/test', 11:49:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:49:02 INFO - 'RUST_BACKTRACE': 'full', 11:49:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:49:02 INFO - 'SHELL': '/bin/bash', 11:49:02 INFO - 'SHLVL': '1', 11:49:02 INFO - 'STYLO_FORCE_DISABLED': '1', 11:49:02 INFO - 'TERM': 'linux', 11:49:02 INFO - 'TMOUT': '86400', 11:49:02 INFO - 'USER': 'cltbld', 11:49:02 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 11:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:02 INFO - '_': '/tools/buildbot/bin/python'} 11:49:02 INFO - TEST-INFO | started process 20665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphwOVu8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:03 INFO - PID 20665 | 11:49:03 INFO - PID 20665 | (/builds/slave/test/build/application/firefox/firefox:20715): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:49:03 INFO - PID 20665 | 11:49:13 INFO - PID 20665 | RSS: Main: 163409920 11:49:13 INFO - PID 20665 | 11:52:10 INFO - PID 20665 | Cycle 1(1): loaded http://localhost:35597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35597/tests/dromaeo/cssquery-ext.html) 11:52:11 INFO - PID 20665 | RSS: Main: 166789120 11:52:11 INFO - PID 20665 | 11:55:13 INFO - PID 20665 | Cycle 1(1): loaded http://localhost:35597/tests/dromaeo/cssquery-ext.html (next: http://localhost:35597/tests/dromaeo/cssquery-jquery.html) 11:55:13 INFO - PID 20665 | RSS: Main: 161955840 11:55:13 INFO - PID 20665 | 11:58:15 INFO - PID 20665 | Cycle 1(1): loaded http://localhost:35597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35597/tests/dromaeo/cssquery-mootools.html) 11:58:16 INFO - PID 20665 | RSS: Main: 164855808 11:58:16 INFO - PID 20665 | 12:01:17 INFO - PID 20665 | Cycle 1(1): loaded http://localhost:35597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35597/tests/dromaeo/cssquery-prototype.html) 12:01:18 INFO - PID 20665 | RSS: Main: 162783232 12:01:18 INFO - PID 20665 | 12:04:21 INFO - PID 20665 | Cycle 1(1): loaded http://localhost:35597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35597/tests/dromaeo/cssquery-yui.html) 12:04:21 INFO - PID 20665 | RSS: Main: 164687872 12:04:21 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | Cycle 1(1): loaded http://localhost:35597/tests/dromaeo/cssquery-yui.html (next: http://localhost:35597/tests/dromaeo/cssquery-dojo.html) 12:07:23 INFO - PID 20665 | RSS: Main: 165687296 12:07:23 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | __start_tp_report 12:07:23 INFO - PID 20665 | _x_x_mozilla_page_load 12:07:23 INFO - PID 20665 | _x_x_mozilla_page_load_details 12:07:23 INFO - PID 20665 | |i|pagename|runs| 12:07:23 INFO - PID 20665 | |0;dojo.html;3859.517560304962;3860.7683538987662;3861.4400911867774;3865.014421322562;3878.7866667333287;6096.969515152429;6116.082587611855;6185;6224.439800417961;6253.906191407133;6116.724747386367;6132.877342453148;6202;6245.594036387632;6291.307956124834;5515.4760297771645;5553.611247212697;5583.748731307101;5628.0713682242385;5641.802536911209;332.4722428180799;5495.230667706524;5498.0653288940775;5530.640508366943;5652.943470565303;5535.169724541331;5599.356074051496;5605.831825045255;5612.747426365823;5622.943770562283;5524.861878453031;5532.031894418501;5599.916001259984;5604.915926261109;5605.215269862222;5500.80747173851;5538.086215774432;5603.215549823028;5603.7478313475585;5606.887862242773;6113.938860611382;6169.3522180170885;6264.9686751566405;6269.811905642838;6301.023341382093;6541.411272985454;6637.037629543737;6670.39966403026;6710.966445167792;6746.730130794763;6767.593944363354;6780.762673306411;6842.247352791189;6843.794686159423;6847.897281540781;6261.24865016201;6267.62394256346;6334.809955701337;6346.143270658448;6350.237971443456;6682.863913134779;6769.458443324522;6831.146106736658;6879.258326839625;6968.442524598121;6508.739650414025;6508.837279068061;6558.803235902835;6573.901391479131;6603.405693487609;6539.5422320438065;6651.102101216274;6671.199456065303;6681.064650948871;6735.932640673628;6553.541252112306;6556.409923106943;6631.33686631333;6657.73369065232;6747.291534388916;6494.870102597922;6564.868702626016;6663.933360666331;6694.263631000586;6717.731290748413;4850.854474365775;4860.3681521401995;4898.461169271377;4964.875878103004;4966.205407134841;4469.262571675637;4477.485089214717;4487.640988720895;4493.573110554557;4519.412476378116;6169.136320915076;6181.536384771161;6251.437370636664;6256.6871656417;6262.812115636538;6559.967200163968;6696.397324240842;6700.095487109178;6732.562383445061;6773.017912402674;6218.440340369389;6224.190855188887;6235.376462353819;6240.188775459162;6270.717817698214;5398.082326004589;5470.8085217017215;5472.2338872557875;5472.398036216013;5491.2312276281355;6842.574913882058;6929.480288978246;6934.549254298455;7033.226345102034;7036.437085033185;6676.532642714963;6715.059891615276;6729.932700673126;6743.9325606743305;6750.594964302158;6929.1684997800585;6994.33553812387;7025.613591252531;7026.824329391806;7040.190378106583;6549.574277671936;6625.238097618835;6631.436327912182;6719.563228390139;6723.26044135135;6529.8694026120165;6619.205695316593;6634.83412914681;6635.966820165868;6637.336266373324;6453.645049522322;6525.543211975306;6551.901721474277;6565.967170164118;6576.112224849584;6417.518686098655;6555.344465553597;6581.769638062645;6590.9670451647435;6597.2742998271115;6414.583052101599;6431.421172094534;6501;6508.674566271762;6515.511336649675;6316.873662526816;6392.3927226913365;6427.710753016219;6526;6572.455472963754;6268.529860260407;6313.463355614824;6320.115183874169;6325.652089135142;6345.4923606112325 12:07:23 INFO - PID 20665 | |1;ext.html;934.5327336331834;948.9762755931101;967.5404183013068;1002.0780881588937;1007.0936157458286;44122.779386103066;45295.32057019147;45329.77335113328;45330.77334613326;45545.08909821806;45606.77196614012;45953;45990.7700461498;46041;46117.53882461174;8046.155153708864;8181.67273309067;8182.263596276334;8185.918140818605;8190.303824174952;7714.6142692865415;7774.766756997271;7776.261255180749;7778.261065198825;7778.80552986177;7788.766337009899;7794.532328060306;7797.142314345418;7804.76585702427;7817.648205830723;7723.806904827368;7724.575148366837;7732;7733.304002639733;7759.573223472707;7989.121196668362;8033.1163572007035;8049.396295277819;8056.8388632227025;8063.314618257456;40721.592784072076;41184.38223426651;41285.1742965139;41351.379729304084;41403.58596414058;3720.1257704439704;3726.4037753959237;3728.1425272187275;3740.738148329618;3747.775133491999;33129.337413251844;33154.6684533154;33258;33271;33311.00066997994;5292.073887069748;5417.187421886709;5417.51242388187;5437.537809286176;5500.4499550045075;207775;209248;209648;215352;218963;53584.46415535795;54321;54370.91258174814;54375.18437223445;54384;55699;55777.44222557804;55786.16320755192;55826.72086639541;55868.44131558714;16471.505854824376;16570.83429165717;16577.585560361087;16580.088095154882;16752.49742507727;13541.59375218745;13572.321383930765;13605.659858503617;13631.659208519866;13633.25017124048;13886.93056534711;13953.65115872091;14007.319121705257;14021.789673154912;14086.71826563463;5625.915611265835;5633.408492108351;5646.4353564644025;5669.262995810518;5792.333881603585;1111.261011427408;1119.043218048573;1120.2718233148519;1121.8878112188715;1126.2397881430002;25817.870910645328;25839;25930.870345648153;25937.35156621062;25998.87000564985;1192.9343886086176;1210.2012671636678;1215.197969340231;1218.6648671615376;1239.070696977267;13758.518451854337;13783.862161378258;13820.308984550933;14000.509982150576;14092.224927629079;289943;291142;293169;293396;293545;58113.41886581165;58185.709071454374;58234;58324.125138122115;58464.707676461345;1519.4985654733912;1531.3721374236732;1542.8071491063617;1551.6974190032836;1563.335582377485;25221.369465763502;25520.489590208465;25544.489110218063;25615.23154305374;25892.22323330303;40469.797651011555;40549.594504054585;40561;40603.59396405998;40639;232990;233145;234001;234072;234517.30965380254;36499.45250821186;38042.80978595089;39136.608633913296;39196.80401597974;39246.4113038299;51161.48838511716;51749.22376164436;52110;52201;52423;37418;37679.81160094182;37912.24175516529;37940.241195176495;38150.23699526049;37680.24639507139;37850.43224351692;37857.24285514219;38005.619943801314;38044.23911521699;42243.57756422397;43932.341014884165;43973.12053758971;44014;44367.11265774731;36036;36167;36245.78662205709;36326.81836590906;36361.818190908874;27090.32274193161;27182.592261115704;27234.863825680746;27404.177874663794;27534.173974780788 12:07:23 INFO - PID 20665 | |2;jquery.html;553.4133818152758;568.454283887468;574.8246784730655;588.4556784973898;604.4831668923069;23544.529109417803;24181.153659621916;24362.269131926027;24365.14721984731;24372.268831935027;25029.499410011787;25740.22779316619;26476.867615661944;26611.201663950065;26635.86682066587;6692.832679183023;6797.592144471348;6831.146106736658;6840.315968403144;6847.2125705544;6541;6699.698513566901;6770.830729231784;6778.22050464198;6786.796396108125;6762.526623136382;6764.898526522106;6771.119754431917;6771.390574848263;6774.119364482635;6493.805185844432;6780.559263647847;6782.084418603475;6782.559133656321;6784.253732089466;6227.813165605039;6231.40801623845;6234.906476402857;6249.468795152417;6251.687415629201;28779.424411511864;29340.266493337836;29365;29371.55942660862;29373.412531749458;2082.5834833033455;2088.9268875589432;2090.5087304483436;2095.9790402095937;2103;20054.097565609583;20466.897665511726;21045.789542104536;21133.260335888324;21144.577108457746;2539.263613552086;2550.872456377192;2554.441790507789;2557.105013245368;2590.1581985854486;128825.35587322003;135486.32256838752;146873;154348;156719;15368.385264589291;15401.30694118745;15632.06207627546;15905.80706446998;16147.596310092107;25048.248552543453;25091.4981700365;25106.748932510807;25123.874380627978;25170.74829251684;10246.897531024744;10551.050405463546;10615.31000484966;10679.412632305297;10737.570497180026;9465.90534094664;9475.194608458358;9637.132658060807;9661.516924153764;9662.227021838236;9523.238140948708;9550.044995500533;9582.28132890036;9914.752131196778;9988.250881183794;2672.0380662961707;2715.4704832557463;2837.7587905028304;2863.141057682687;2906.593076969226;1002.9498525073717;1039.8648175737105;1049.3284298049255;1049.9265051446478;1054.1092776603757;20840.791592084188;20950.161993520087;20976.79023209779;21406.25078122258;21439.57120857574;1084.3385534823751;1085.5006696919506;1089.330062011857;1091.5633746501305;1107.2802678259195;11268.477826608103;11616.419179041182;11757.059435245159;11785;11823.408829558488;595472;605926;610387;610689;615407;125935;126415.36792316164;128699;130266;130449;1108.933463992163;1211.4064108586729;1218.4760552962312;1262.1228246368685;1273.7134144817342;21671.45821354479;22024;22137.557248855253;22200.222992195195;22455;64261.67869160624;64852.6757366229;65592.67203663952;65817;67805.66097169483;79515.60242198984;79965.2003479981;81009.59495202487;81073.18926810657;81264;15301.387944482096;15513.84486155124;15531.767023494882;15598.688026239184;15634.218289085273;24325.756742433055;24380.146694865594;24393.390165245302;24419.755802442458;24558.14046508435;19641.901790491527;19708.40874773759;19742.30901918426;20151.69772453385;20155.59688806245;17377;17484.388046418313;17700.645987080443;17894.463166105037;18041;20682.689759653316;20730.170793168105;20744.377668669964;20906.05922733511;20950.790492094882;14305;15253.703435208132;15264.694706106038;15347.386104556139;15464.304106315018;20054.097565609292;20205.19179232873;20208.79791202069;20241.19035238633;20246.291379801638 12:07:23 INFO - PID 20665 | |3;mootools.html;1449.434720459021;1530.081950829503;1530.4872867589354;1548.0634216299145;1550.8836837237202;16277.186140692962;16820.747688784664;16856.915715421423;16859.915700421512;16863.40978065768;16526.669466610692;16609.418670346542;16621;16626.83373166268;16681.83318166818;2691.838489690615;2745.7117002714726;2754.1737478756395;2775.1951933939135;2793.1760130761472;2646.073874144053;2653.907113251027;2674.545327294355;2675.54515732326;2677.531431999392;2498.650188973545;2567.9743202568015;2572.3954870605394;2579.2520169150926;2583.7416258374105;2683.302341391233;2702.2974026753086;2723.72762723728;2729.495043416964;2734.753872151506;2414.311921102495;2441.841280316774;2444.7677470640438;2445.254197469771;2449.09383528094;16310.347586096543;16656.6668666626;16724.66550668992;16746.916265418717;16763.078030708308;7846.5292082475235;8116.107228204893;8127.3904457165945;8156.877646835303;8162.959185204096;5271.973640131813;5370.22131790892;5561.610687251894;5565.777368905239;5577.386487486373;2009.136071489259;2049.836013118962;2055.496403381166;2104.084723145437;2110.9261175858924;29901;30175.245618859484;30225.848870755726;30247.092587222418;30278.66934637188;6643.202815662152;6807.421369183675;6846.383825455733;6948.895766563505;6985.301469852974;19470.80529194718;19553.511162221057;19567.412977610693;19598.314059008153;19609.117589708498;7961.36309095271;8091.676332946734;8132.227438393344;8143.633536490872;8152.714654987047;7095.325944035309;7149.714011439484;7240.05879235696;7241.239669834592;7402.1487528933785;5099.97450012755;5265.236540701577;5272.446393128743;5273.736313184326;5307.044731948209;1581.4069723853554;1582.8100627924723;1586.2306781211103;1593;1607.638281386702;769.3960241210734;922.3267015078895;928.9163975242126;937.2595649436869;973;8776.297896168291;8776.297896168291;8953.462792232487;8958.372913895964;8969.103089691109;1059.8092343378112;1073.4739977411168;1075.2849355178719;1093.0272057868503;1102.525913857049;5455.754491047913;5468.6171967962655;5486.972565137149;5678.205051292823;5894.764209431661;24244.757552424602;24481.38796530101;25124.24627261185;25173.748262517507;25351;24846.254612361296;24909.501809963698;25014.374640633767;25061.62407563888;25070.373240668763;10138.645147419953;10890.29213101146;11015.724606884733;11153.10775137987;11205.495752691148;9553.713388598075;9617.326787124834;9672.177864881283;9717.514124293899;9882.357646752938;20944.895275524133;20973.475663108544;21185.470363241042;21375.893120534296;21836.89081554582;21844.672329914745;21869.56260874742;22012.119515219212;22054.66917996199;22143.335699929026;12082.577109801116;12213.206141600767;12220.327881966577;12224.205426647239;12229.633111006684;15250;15504;15617.843821561639;15626.296816643051;15650.13924234178;11974.880251197725;12026;12064.638060857837;12148.635540933787;12320.691982700504;11737.354445505238;11752.941235293769;11834.230774999598;11843.763124737628;12072.879271207175;10151.695449136538;10160.898391015995;10186.643467478603;10214.489275536342;10243.282970192015;7887.723929662434;8093.109757926741;8121.269085782308;8146.429749917449;8251.95874020626;8000.679972801023;8160.673573057249;8191.139930307232;8206.138355472589;8296.253337199681 12:07:23 INFO - PID 20665 | |4;prototype.html;524.4702850121378;534.1960349673737;555.7499125393573;563.6111083352484;580.4891695308131;6086.208792856928;6138.600990935592;6159.384061593838;6209.472194863442;6247.2503299603995;6071.7874874379295;6087.573869829113;6096.177016102824;6098.969505152468;6113.144159817618;4972.850814475553;5012.4736902625245;5013.3482647255805;5026.421961474441;5029.924551131745;4983.8504844854715;5000.549950504454;5001.99960007998;5027.824026159085;5048.29323894655;4759.452662943754;4951.480094590071;4967.900641987158;4985.900281994358;4991.201407774757;4834.709917404949;4842.2252439609665;4868.878278043042;4874.122657921573;4909.852704418873;4433.645308375322;4435.157320109169;4455.977720111411;4470.441194850644;4477.597016268552;5950.880982380371;5986.910196347058;6001;6018.548608854353;6112.572119951606;5721.914171287434;5722.570807189478;5743.282089738783;5765.394633563499;5783.363829978699;6489.4483968862705;6533.7713180038945;6569.343065693441;6576.704048317837;6604.108445359863;4705.341252224691;4911.5088491150955;4929.3345398371475;4936.160852655022;4976.2286845539;6649.900251496231;6655.700493477757;6670.599764014175;6677.666116694146;6774.898376524356;5004.199328107558;5030.572401345853;5038.017586570657;5063.670861394071;5079.822206222764;5083.872903177376;5103.9281750832;5119.8720031998755;5134.485326828594;5157.303763991888;5662.631928924607;5729;5749.798757043483;5755.366909639936;5757.884842303214;6544.345565443513;6582.967085164543;6589.341065893468;6599.47204223661;6602.306757790363;1730.4722059771639;1765.7792775903013;1770.8140645232322;1773.5211492896847;1780.64387122576;1199.1006744941294;1218.5369559567307;1231.759806837658;1233.8210959411015;1239.900807935363;5862.443067908542;5885.529157667376;5890.263717035371;5905.143754155623;6022.668753218528;6301.180846489927;6388.8083357499345;6442.581232219891;6528.967355163194;6593.175853018372;5824.650520968671;5955.731992060368;5965.940340596625;5984.790532331347;6009.519238460913;3420.931581368359;3422.606400263952;3430.3996800559803;3443.466262729281;3471.930561388758;6421.903671444932;6768.492363072691;6817.318268173143;6818.897716534256;6859.451243900476;6529.804105876831;6531.7263133688475;6572.474202063823;6643.833904152339;6703.3296670332575;6733.744195694399;6744;6746.865062698718;6840.144981877265;6851.760188393382;6432.517561182836;6476.773312934025;6478.190226221723;6579.901301480578;6580.901286480611;6465.3857883501;6508.186476690414;6520.706568204348;6564.4420224281475;6617.139771829824;6741.426978706865;6791.966040169767;6834.965825170842;6897.379235868796;6932.410745086522;4933.9506604933495;4967.850964471072;4973.278874563096;4977.64009293718;4992.176290911959;6401.135846660642;6534.771283005072;6621.205455345389;6680.365365290289;6687.665616719242;6397.744090236339;6399.6800159992745;6428.550001500037;6433.163688720437;6457.6771161442675;6366.840828979127;6377.266614339224;6391.936080639134;6407.1350367701625;6415.1981002374705;6378.170837791057;6384.808455746335;6392.520560957853;6404.295527491879;6444.13004244421;6391.456726178327;6440.967795160994;6451.483881289391;6481.708323125376;6515.2833188348295;6267.749290028531;6273.96863015682;6309.400606942333;6324.114623952558;6343.4608058313715 12:07:23 INFO - PID 20665 | |5;yui.html;950.795578950525;987.3039507147462;989.8020395920815;1017.7710015246565;1021.0708255487508;19785.307514236985;20570.691439628397;20593.38219853405;20836.8958155209;24017.879910600466;21575.67636485454;21615.891920540376;21648;21712.565748685058;21724.13103475859;1061.0927656853376;1074.0119090436779;1074.248026381532;1074.457399013497;1076.8438576406415;970.4419958523877;1067.226260960805;1071.871375434949;1078.6763970808727;1092.2408925796574;1124.0333313350511;1129.6046383765658;1132.399828091113;1133.880942501038;1145.2384164530577;1125.8648962124516;1126.7802778458204;1130.8473356096904;1133.3596517967321;1138.174823253139;836.2682652678906;839.0099682374795;839.6935118681698;840.5083026429546;841.7685136587427;19976.200951961902;20197.596048078954;20643.483912902146;20707.792922070737;21134.15463381463;22313.330600082023;22778.54442911149;22977.655335169984;23008.539829203488;23024.194153204724;16310.266038028318;16398.426055088014;16435.83564164355;16594.08732519711;16616.169191540495;3796.8671096511766;3881.5536213335545;3966.861159859391;3991.4212439196444;4025.75845449274;156444;156703;156995.2150239253;158783;159654.20172899062;17860.9106954467;17995.100244987698;18238.63522729538;18247.72628410575;18257.81742182588;32701.67298327034;33023;34418.82790586031;34507.482387764205;34732;8021.157778433298;8078.23256790604;8095.514269143752;8101.473404228706;8136.22705842944;4206.558311377323;4226.281532139544;4228.640565551963;4273.829046838154;4276.31578947367;6033.728482218311;6208.410201030895;6223.844403889939;6229.657368844757;6268.435840774261;1232.9260244385366;1258.936198911918;1260.697432616184;1272.6245757501374;1273.121546133165;716.7419728897593;725.1696807155777;730.204077555467;739.7706710919524;750.0586763611633;12582;12953.935230323788;13191.274479903506;14017.789733154012;14480.203588802506;714.6248219684603;742.2614498573846;745.5005146551823;753.4951582439778;763.9923600763922;6097.057433524879;6116.235470566179;6194.194754681863;6214;6299.433051025429;141868.29065854813;145145;145674;146782;148839;127621.3618931918;130387;130797.34601326933;132470;135709.32145339408;115127.42436287932;116098;117536;117691.41154294345;118032;11594.072474201876;11717.76564468723;11747.941260293645;11849.881501184878;11938.462769175581;52765.472345277594;53333;53831;53857.73071134776;54872;69751.65124174347;69865.30134698791;70220;70535;84174;18344.449666510027;19163.80836191676;19352.516187094872;19371.128299226286;19458.124384402454;20136.49658758543;20243.19027238953;20278.59442811165;20320.898395507927;20449.2842750503;18510;18544.350947716764;18569.44291671252;18630.06849657539;18667.626647467245;19885.204591816164;20094.59810803805;20334.186632534533;20586.382408527767;20602.27892023772;19734;19782.802171978095;19850.10674519621;19852.801471985673;19998.1000854959;14188.503402380868;14342.856571434151;14448.27758612044;14703.491069068508;14712.411503539739;14154.541742602984;14184.148951062969;14189.219592922489;14201.147931124166;14206.715865682421 12:07:23 INFO - PID 20665 | __end_tp_report 12:07:23 INFO - PID 20665 | __start_cc_report 12:07:23 INFO - PID 20665 | _x_x_mozilla_cycle_collect,353 12:07:23 INFO - PID 20665 | __end_cc_report 12:07:23 INFO - PID 20665 | __startTimestamp1505243243583__endTimestamp 12:07:23 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | ------- Summary: start ------- 12:07:23 INFO - PID 20665 | Number of tests: 6 12:07:23 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | [#0] dojo.html Cycles:165 Average:6140.65 Median:6414.58 stddev:846.86 (13.2%) stddev-sans-first:830.34 12:07:23 INFO - PID 20665 | Values: 3859.5 3860.8 3861.4 3865.0 3878.8 6097.0 6116.1 6185.0 6224.4 6253.9 6116.7 6132.9 6202.0 6245.6 6291.3 5515.5 5553.6 5583.7 5628.1 5641.8 332.5 5495.2 5498.1 5530.6 5652.9 5535.2 5599.4 5605.8 5612.7 5622.9 5524.9 5532.0 5599.9 5604.9 5605.2 5500.8 5538.1 5603.2 5603.7 5606.9 6113.9 6169.4 6265.0 6269.8 6301.0 6541.4 6637.0 6670.4 6711.0 6746.7 6767.6 6780.8 6842.2 6843.8 6847.9 6261.2 6267.6 6334.8 6346.1 6350.2 6682.9 6769.5 6831.1 6879.3 6968.4 6508.7 6508.8 6558.8 6573.9 6603.4 6539.5 6651.1 6671.2 6681.1 6735.9 6553.5 6556.4 6631.3 6657.7 6747.3 6494.9 6564.9 6663.9 6694.3 6717.7 4850.9 4860.4 4898.5 4964.9 4966.2 4469.3 4477.5 4487.6 4493.6 4519.4 6169.1 6181.5 6251.4 6256.7 6262.8 6560.0 6696.4 6700.1 6732.6 6773.0 6218.4 6224.2 6235.4 6240.2 6270.7 5398.1 5470.8 5472.2 5472.4 5491.2 6842.6 6929.5 6934.5 7033.2 7036.4 6676.5 6715.1 6729.9 6743.9 6750.6 6929.2 6994.3 7025.6 7026.8 7040.2 6549.6 6625.2 6631.4 6719.6 6723.3 6529.9 6619.2 6634.8 6636.0 6637.3 6453.6 6525.5 6551.9 6566.0 6576.1 6417.5 6555.3 6581.8 6591.0 6597.3 6414.6 6431.4 6501.0 6508.7 6515.5 6316.9 6392.4 6427.7 6526.0 6572.5 6268.5 6313.5 6320.1 6325.7 6345.5 12:07:23 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | [#1] ext.html Cycles:180 Average:43179.72 Median:38024.21 stddev:64639.35 (170.0%) stddev-sans-first:64742.85 12:07:23 INFO - PID 20665 | Values: 934.5 949.0 967.5 1002.1 1007.1 44122.8 45295.3 45329.8 45330.8 45545.1 45606.8 45953.0 45990.8 46041.0 46117.5 8046.2 8181.7 8182.3 8185.9 8190.3 7714.6 7774.8 7776.3 7778.3 7778.8 7788.8 7794.5 7797.1 7804.8 7817.6 7723.8 7724.6 7732.0 7733.3 7759.6 7989.1 8033.1 8049.4 8056.8 8063.3 40721.6 41184.4 41285.2 41351.4 41403.6 3720.1 3726.4 3728.1 3740.7 3747.8 33129.3 33154.7 33258.0 33271.0 33311.0 5292.1 5417.2 5417.5 5437.5 5500.4 207775.0 209248.0 209648.0 215352.0 218963.0 53584.5 54321.0 54370.9 54375.2 54384.0 55699.0 55777.4 55786.2 55826.7 55868.4 16471.5 16570.8 16577.6 16580.1 16752.5 13541.6 13572.3 13605.7 13631.7 13633.3 13886.9 13953.7 14007.3 14021.8 14086.7 5625.9 5633.4 5646.4 5669.3 5792.3 1111.3 1119.0 1120.3 1121.9 1126.2 25817.9 25839.0 25930.9 25937.4 25998.9 1192.9 1210.2 1215.2 1218.7 1239.1 13758.5 13783.9 13820.3 14000.5 14092.2 289943.0 291142.0 293169.0 293396.0 293545.0 58113.4 58185.7 58234.0 58324.1 58464.7 1519.5 1531.4 1542.8 1551.7 1563.3 25221.4 25520.5 25544.5 25615.2 25892.2 40469.8 40549.6 40561.0 40603.6 40639.0 232990.0 233145.0 234001.0 234072.0 234517.3 36499.5 38042.8 39136.6 39196.8 39246.4 51161.5 51749.2 52110.0 52201.0 52423.0 37418.0 37679.8 37912.2 37940.2 38150.2 37680.2 37850.4 37857.2 38005.6 38044.2 42243.6 43932.3 43973.1 44014.0 44367.1 36036.0 36167.0 36245.8 36326.8 36361.8 27090.3 27182.6 27234.9 27404.2 27534.2 12:07:23 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | [#2] jquery.html Cycles:180 Average:39740.89 Median:23862.84 stddev:101422.74 (425.0%) stddev-sans-first:101664.57 12:07:23 INFO - PID 20665 | Values: 553.4 568.5 574.8 588.5 604.5 23544.5 24181.2 24362.3 24365.1 24372.3 25029.5 25740.2 26476.9 26611.2 26635.9 6692.8 6797.6 6831.1 6840.3 6847.2 6541.0 6699.7 6770.8 6778.2 6786.8 6762.5 6764.9 6771.1 6771.4 6774.1 6493.8 6780.6 6782.1 6782.6 6784.3 6227.8 6231.4 6234.9 6249.5 6251.7 28779.4 29340.3 29365.0 29371.6 29373.4 2082.6 2088.9 2090.5 2096.0 2103.0 20054.1 20466.9 21045.8 21133.3 21144.6 2539.3 2550.9 2554.4 2557.1 2590.2 128825.4 135486.3 146873.0 154348.0 156719.0 15368.4 15401.3 15632.1 15905.8 16147.6 25048.2 25091.5 25106.7 25123.9 25170.7 10246.9 10551.1 10615.3 10679.4 10737.6 9465.9 9475.2 9637.1 9661.5 9662.2 9523.2 9550.0 9582.3 9914.8 9988.3 2672.0 2715.5 2837.8 2863.1 2906.6 1002.9 1039.9 1049.3 1049.9 1054.1 20840.8 20950.2 20976.8 21406.3 21439.6 1084.3 1085.5 1089.3 1091.6 1107.3 11268.5 11616.4 11757.1 11785.0 11823.4 595472.0 605926.0 610387.0 610689.0 615407.0 125935.0 126415.4 128699.0 130266.0 130449.0 1108.9 1211.4 1218.5 1262.1 1273.7 21671.5 22024.0 22137.6 22200.2 22455.0 64261.7 64852.7 65592.7 65817.0 67805.7 79515.6 79965.2 81009.6 81073.2 81264.0 15301.4 15513.8 15531.8 15598.7 15634.2 24325.8 24380.1 24393.4 24419.8 24558.1 19641.9 19708.4 19742.3 20151.7 20155.6 17377.0 17484.4 17700.6 17894.5 18041.0 20682.7 20730.2 20744.4 20906.1 20950.8 14305.0 15253.7 15264.7 15347.4 15464.3 20054.1 20205.2 20208.8 20241.2 20246.3 12:07:23 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | [#3] mootools.html Cycles:180 Average:10202.01 Median:25038.00 stddev:7706.69 (30.8%) stddev-sans-first:7700.26 12:07:23 INFO - PID 20665 | Values: 1449.4 1530.1 1530.5 1548.1 1550.9 16277.2 16820.7 16856.9 16859.9 16863.4 16526.7 16609.4 16621.0 16626.8 16681.8 2691.8 2745.7 2754.2 2775.2 2793.2 2646.1 2653.9 2674.5 2675.5 2677.5 2498.7 2568.0 2572.4 2579.3 2583.7 2683.3 2702.3 2723.7 2729.5 2734.8 2414.3 2441.8 2444.8 2445.3 2449.1 16310.3 16656.7 16724.7 16746.9 16763.1 7846.5 8116.1 8127.4 8156.9 8163.0 5272.0 5370.2 5561.6 5565.8 5577.4 2009.1 2049.8 2055.5 2104.1 2110.9 29901.0 30175.2 30225.8 30247.1 30278.7 6643.2 6807.4 6846.4 6948.9 6985.3 19470.8 19553.5 19567.4 19598.3 19609.1 7961.4 8091.7 8132.2 8143.6 8152.7 7095.3 7149.7 7240.1 7241.2 7402.1 5100.0 5265.2 5272.4 5273.7 5307.0 1581.4 1582.8 1586.2 1593.0 1607.6 769.4 922.3 928.9 937.3 973.0 8776.3 8776.3 8953.5 8958.4 8969.1 1059.8 1073.5 1075.3 1093.0 1102.5 5455.8 5468.6 5487.0 5678.2 5894.8 24244.8 24481.4 25124.2 25173.7 25351.0 24846.3 24909.5 25014.4 25061.6 25070.4 10138.6 10890.3 11015.7 11153.1 11205.5 9553.7 9617.3 9672.2 9717.5 9882.4 20944.9 20973.5 21185.5 21375.9 21836.9 21844.7 21869.6 22012.1 22054.7 22143.3 12082.6 12213.2 12220.3 12224.2 12229.6 15250.0 15504.0 15617.8 15626.3 15650.1 11974.9 12026.0 12064.6 12148.6 12320.7 11737.4 11752.9 11834.2 11843.8 12072.9 10151.7 10160.9 10186.6 10214.5 10243.3 7887.7 8093.1 8121.3 8146.4 8252.0 8000.7 8160.7 8191.1 8206.1 8296.3 12:07:23 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | [#4] prototype.html Cycles:180 Average:5492.49 Median:6086.89 stddev:1531.69 (25.2%) stddev-sans-first:1489.91 12:07:23 INFO - PID 20665 | Values: 524.5 534.2 555.7 563.6 580.5 6086.2 6138.6 6159.4 6209.5 6247.3 6071.8 6087.6 6096.2 6099.0 6113.1 4972.9 5012.5 5013.3 5026.4 5029.9 4983.9 5000.5 5002.0 5027.8 5048.3 4759.5 4951.5 4967.9 4985.9 4991.2 4834.7 4842.2 4868.9 4874.1 4909.9 4433.6 4435.2 4456.0 4470.4 4477.6 5950.9 5986.9 6001.0 6018.5 6112.6 5721.9 5722.6 5743.3 5765.4 5783.4 6489.4 6533.8 6569.3 6576.7 6604.1 4705.3 4911.5 4929.3 4936.2 4976.2 6649.9 6655.7 6670.6 6677.7 6774.9 5004.2 5030.6 5038.0 5063.7 5079.8 5083.9 5103.9 5119.9 5134.5 5157.3 5662.6 5729.0 5749.8 5755.4 5757.9 6544.3 6583.0 6589.3 6599.5 6602.3 1730.5 1765.8 1770.8 1773.5 1780.6 1199.1 1218.5 1231.8 1233.8 1239.9 5862.4 5885.5 5890.3 5905.1 6022.7 6301.2 6388.8 6442.6 6529.0 6593.2 5824.7 5955.7 5965.9 5984.8 6009.5 3420.9 3422.6 3430.4 3443.5 3471.9 6421.9 6768.5 6817.3 6818.9 6859.5 6529.8 6531.7 6572.5 6643.8 6703.3 6733.7 6744.0 6746.9 6840.1 6851.8 6432.5 6476.8 6478.2 6579.9 6580.9 6465.4 6508.2 6520.7 6564.4 6617.1 6741.4 6792.0 6835.0 6897.4 6932.4 4934.0 4967.9 4973.3 4977.6 4992.2 6401.1 6534.8 6621.2 6680.4 6687.7 6397.7 6399.7 6428.6 6433.2 6457.7 6366.8 6377.3 6391.9 6407.1 6415.2 6378.2 6384.8 6392.5 6404.3 6444.1 6391.5 6441.0 6451.5 6481.7 6515.3 6267.7 6274.0 6309.4 6324.1 6343.5 12:07:23 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | [#5] yui.html Cycles:180 Average:28405.03 Median:19869.00 stddev:41842.91 (210.6%) stddev-sans-first:41909.51 12:07:23 INFO - PID 20665 | Values: 950.8 987.3 989.8 1017.8 1021.1 19785.3 20570.7 20593.4 20836.9 24017.9 21575.7 21615.9 21648.0 21712.6 21724.1 1061.1 1074.0 1074.2 1074.5 1076.8 970.4 1067.2 1071.9 1078.7 1092.2 1124.0 1129.6 1132.4 1133.9 1145.2 1125.9 1126.8 1130.8 1133.4 1138.2 836.3 839.0 839.7 840.5 841.8 19976.2 20197.6 20643.5 20707.8 21134.2 22313.3 22778.5 22977.7 23008.5 23024.2 16310.3 16398.4 16435.8 16594.1 16616.2 3796.9 3881.6 3966.9 3991.4 4025.8 156444.0 156703.0 156995.2 158783.0 159654.2 17860.9 17995.1 18238.6 18247.7 18257.8 32701.7 33023.0 34418.8 34507.5 34732.0 8021.2 8078.2 8095.5 8101.5 8136.2 4206.6 4226.3 4228.6 4273.8 4276.3 6033.7 6208.4 6223.8 6229.7 6268.4 1232.9 1258.9 1260.7 1272.6 1273.1 716.7 725.2 730.2 739.8 750.1 12582.0 12953.9 13191.3 14017.8 14480.2 714.6 742.3 745.5 753.5 764.0 6097.1 6116.2 6194.2 6214.0 6299.4 141868.3 145145.0 145674.0 146782.0 148839.0 127621.4 130387.0 130797.3 132470.0 135709.3 115127.4 116098.0 117536.0 117691.4 118032.0 11594.1 11717.8 11747.9 11849.9 11938.5 52765.5 53333.0 53831.0 53857.7 54872.0 69751.7 69865.3 70220.0 70535.0 84174.0 18344.4 19163.8 19352.5 19371.1 19458.1 20136.5 20243.2 20278.6 20320.9 20449.3 18510.0 18544.4 18569.4 18630.1 18667.6 19885.2 20094.6 20334.2 20586.4 20602.3 19734.0 19782.8 19850.1 19852.8 19998.1 14188.5 14342.9 14448.3 14703.5 14712.4 14154.5 14184.1 14189.2 14201.1 14206.7 12:07:23 INFO - PID 20665 | -------- Summary: end -------- 12:07:23 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | 12:07:23 INFO - PID 20665 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 12:07:23 INFO - PID 20665 | 12:07:24 INFO - TEST-INFO | 20665: exit 0 12:07:24 INFO - TEST-OK | dromaeo_css | took 1107022ms 12:07:24 INFO - TEST-START | kraken 12:07:24 INFO - Initialising browser for kraken test... 12:07:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35597/getInfo.html -profile /tmp/tmppieU2H/profile 12:07:24 INFO - TEST-INFO | started process 21038 (/builds/slave/test/build/application/firefox/firefox http://localhost:35597/getInfo.html) 12:07:29 INFO - TEST-INFO | 21038: exit 0 12:07:29 INFO - Browser initialized. 12:07:29 INFO - Running cycle 1/1 for kraken test... 12:07:29 INFO - Using env: {'DISPLAY': ':0', 12:07:29 INFO - 'HOME': '/home/cltbld', 12:07:29 INFO - 'JSGC_DISABLE_POISONING': '1', 12:07:29 INFO - 'LANG': 'en_US.UTF-8', 12:07:29 INFO - 'LANGUAGE': 'en_US:en', 12:07:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:07:29 INFO - 'LOGNAME': 'cltbld', 12:07:29 INFO - 'MAIL': '/var/mail/cltbld', 12:07:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:07:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:07:29 INFO - 'MOZ_CRASHREPORTER': '1', 12:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:07:29 INFO - 'MOZ_NO_REMOTE': '1', 12:07:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:29 INFO - 'NO_EM_RESTART': '1', 12:07:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:29 INFO - 'PWD': '/builds/slave/test', 12:07:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:07:29 INFO - 'RUST_BACKTRACE': 'full', 12:07:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:07:29 INFO - 'SHELL': '/bin/bash', 12:07:29 INFO - 'SHLVL': '1', 12:07:29 INFO - 'STYLO_FORCE_DISABLED': '1', 12:07:29 INFO - 'TERM': 'linux', 12:07:29 INFO - 'TMOUT': '86400', 12:07:29 INFO - 'USER': 'cltbld', 12:07:29 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131', 12:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:29 INFO - '_': '/tools/buildbot/bin/python'} 12:07:29 INFO - TEST-INFO | started process 21239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppieU2H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:30 INFO - PID 21239 | 12:07:30 INFO - PID 21239 | (/builds/slave/test/build/application/firefox/firefox:21291): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:07:30 INFO - PID 21239 | 12:07:40 INFO - PID 21239 | RSS: Main: 163942400 12:07:40 INFO - PID 21239 | 12:07:43 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35597/tests/kraken/driver.html?testName=audio-beat-detection) 12:07:44 INFO - PID 21239 | RSS: Main: 168517632 12:07:44 INFO - PID 21239 | 12:07:46 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35597/tests/kraken/driver.html?testName=audio-dft) 12:07:47 INFO - PID 21239 | RSS: Main: 169525248 12:07:47 INFO - PID 21239 | 12:07:50 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35597/tests/kraken/driver.html?testName=audio-fft) 12:07:50 INFO - PID 21239 | RSS: Main: 164433920 12:07:50 INFO - PID 21239 | 12:07:52 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35597/tests/kraken/driver.html?testName=audio-oscillator) 12:07:53 INFO - PID 21239 | RSS: Main: 165715968 12:07:53 INFO - PID 21239 | 12:07:55 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:07:56 INFO - PID 21239 | RSS: Main: 165228544 12:07:56 INFO - PID 21239 | 12:07:59 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35597/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:59 INFO - PID 21239 | RSS: Main: 168431616 12:07:59 INFO - PID 21239 | 12:08:03 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35597/tests/kraken/driver.html?testName=imaging-desaturate) 12:08:04 INFO - PID 21239 | RSS: Main: 167886848 12:08:04 INFO - PID 21239 | 12:08:07 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35597/tests/kraken/driver.html?testName=json-parse-financial) 12:08:07 INFO - PID 21239 | RSS: Main: 167956480 12:08:07 INFO - PID 21239 | 12:08:09 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:08:09 INFO - PID 21239 | RSS: Main: 167714816 12:08:09 INFO - PID 21239 | 12:08:11 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35597/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:08:11 INFO - PID 21239 | RSS: Main: 167907328 12:08:11 INFO - PID 21239 | 12:08:13 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:08:14 INFO - PID 21239 | RSS: Main: 165224448 12:08:14 INFO - PID 21239 | 12:08:17 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:08:17 INFO - PID 21239 | RSS: Main: 164950016 12:08:17 INFO - PID 21239 | 12:08:20 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:08:21 INFO - PID 21239 | RSS: Main: 165408768 12:08:21 INFO - PID 21239 | 12:08:22 INFO - PID 21239 | Cycle 1(1): loaded http://localhost:35597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35597/tests/kraken/driver.html?testName=ai-astar) 12:08:23 INFO - PID 21239 | RSS: Main: 167170048 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | __start_tp_report 12:08:23 INFO - PID 21239 | _x_x_mozilla_page_load 12:08:23 INFO - PID 21239 | _x_x_mozilla_page_load_details 12:08:23 INFO - PID 21239 | |i|pagename|runs| 12:08:23 INFO - PID 21239 | |0;ai-astar;105;106;105;105;107;108;94;105;106;105 12:08:23 INFO - PID 21239 | |1;audio-beat-detection;113;112;115;112;113;111;111;113;113;111 12:08:23 INFO - PID 21239 | |2;audio-dft;160;161;161;160;163;162;164;161;167;167 12:08:23 INFO - PID 21239 | |3;audio-fft;74;73;73;73;73;82;73;73;73;83 12:08:23 INFO - PID 21239 | |4;audio-oscillator;91;78;78;83;77;78;79;81;82;86 12:08:23 INFO - PID 21239 | |5;imaging-gaussian-blur;110;115;113;113;114;114;114;114;113;113 12:08:23 INFO - PID 21239 | |6;imaging-darkroom;150;148;149;150;152;151;151;152;150;152 12:08:23 INFO - PID 21239 | |7;imaging-desaturate;93;93;94;93;93;94;94;94;95;95 12:08:23 INFO - PID 21239 | |8;json-parse-financial;45;44;45;44;45;45;44;44;53;55 12:08:23 INFO - PID 21239 | |9;json-stringify-tinderbox;37;38;37;36;37;37;37;37;37;38 12:08:23 INFO - PID 21239 | |10;stanford-crypto-aes;72;76;74;70;73;73;75;70;73;73 12:08:23 INFO - PID 21239 | |11;stanford-crypto-ccm;104;108;108;103;108;106;106;107;102;110 12:08:23 INFO - PID 21239 | |12;stanford-crypto-pbkdf2;152;159;162;166;152;152;157;157;154;149 12:08:23 INFO - PID 21239 | |13;stanford-crypto-sha256-iterative;59;65;58;59;64;81;60;57;60;58 12:08:23 INFO - PID 21239 | __end_tp_report 12:08:23 INFO - PID 21239 | __start_cc_report 12:08:23 INFO - PID 21239 | _x_x_mozilla_cycle_collect,873 12:08:23 INFO - PID 21239 | __end_cc_report 12:08:23 INFO - PID 21239 | __startTimestamp1505243303012__endTimestamp 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | ------- Summary: start ------- 12:08:23 INFO - PID 21239 | Number of tests: 14 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#0] ai-astar Cycles:10 Average:104.60 Median:106.00 stddev:3.86 (3.6%) stddev-sans-first:4.10 12:08:23 INFO - PID 21239 | Values: 105.0 106.0 105.0 105.0 107.0 108.0 94.0 105.0 106.0 105.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#1] audio-beat-detection Cycles:10 Average:112.40 Median:113.00 stddev:1.26 (1.1%) stddev-sans-first:1.32 12:08:23 INFO - PID 21239 | Values: 113.0 112.0 115.0 112.0 113.0 111.0 111.0 113.0 113.0 111.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:2.63 (1.6%) stddev-sans-first:2.62 12:08:23 INFO - PID 21239 | Values: 160.0 161.0 161.0 160.0 163.0 162.0 164.0 161.0 167.0 167.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#3] audio-fft Cycles:10 Average:75.00 Median:73.00 stddev:3.97 (5.4%) stddev-sans-first:4.20 12:08:23 INFO - PID 21239 | Values: 74.0 73.0 73.0 73.0 73.0 82.0 73.0 73.0 73.0 83.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:81.50 stddev:4.42 (5.4%) stddev-sans-first:2.99 12:08:23 INFO - PID 21239 | Values: 91.0 78.0 78.0 83.0 77.0 78.0 79.0 81.0 82.0 86.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:0.71 12:08:23 INFO - PID 21239 | Values: 110.0 115.0 113.0 113.0 114.0 114.0 114.0 114.0 113.0 113.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 12:08:23 INFO - PID 21239 | Values: 150.0 148.0 149.0 150.0 152.0 151.0 151.0 152.0 150.0 152.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 12:08:23 INFO - PID 21239 | Values: 93.0 93.0 94.0 93.0 93.0 94.0 94.0 94.0 95.0 95.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#8] json-parse-financial Cycles:10 Average:46.40 Median:45.00 stddev:4.06 (9.0%) stddev-sans-first:4.28 12:08:23 INFO - PID 21239 | Values: 45.0 44.0 45.0 44.0 45.0 45.0 44.0 44.0 53.0 55.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#9] json-stringify-tinderbox Cycles:10 Average:37.10 Median:37.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 12:08:23 INFO - PID 21239 | Values: 37.0 38.0 37.0 36.0 37.0 37.0 37.0 37.0 37.0 38.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.91 (2.6%) stddev-sans-first:2.00 12:08:23 INFO - PID 21239 | Values: 72.0 76.0 74.0 70.0 73.0 73.0 75.0 70.0 73.0 73.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#11] stanford-crypto-ccm Cycles:10 Average:106.20 Median:107.50 stddev:2.53 (2.4%) stddev-sans-first:2.55 12:08:23 INFO - PID 21239 | Values: 104.0 108.0 108.0 103.0 108.0 106.0 106.0 107.0 102.0 110.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:157.00 stddev:5.25 (3.3%) stddev-sans-first:5.36 12:08:23 INFO - PID 21239 | Values: 152.0 159.0 162.0 166.0 152.0 152.0 157.0 157.0 154.0 149.0 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:60.00 stddev:7.13 (11.9%) stddev-sans-first:7.47 12:08:23 INFO - PID 21239 | Values: 59.0 65.0 58.0 59.0 64.0 81.0 60.0 57.0 60.0 58.0 12:08:23 INFO - PID 21239 | -------- Summary: end -------- 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 12:08:23 INFO - PID 21239 | 12:08:23 INFO - PID 21239 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:08:23 INFO - TEST-INFO | 21239: exit 0 12:08:23 INFO - TEST-OK | kraken | took 59363ms 12:08:23 INFO - SUITE-END | took 1166s 12:08:23 INFO - Completed test suite (00:19:26) 12:08:23 INFO - javascript benchmark 12:08:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8985.257322053338, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3859.517560304962, 3860.7683538987662, 3861.4400911867774, 3865.014421322562, 3878.7866667333287, 6096.969515152429, 6116.082587611855, 6185.0, 6224.439800417961, 6253.906191407133, 6116.724747386367, 6132.877342453148, 6202.0, 6245.594036387632, 6291.307956124834, 5515.4760297771645, 5553.611247212697, 5583.748731307101, 5628.0713682242385, 5641.802536911209, 332.4722428180799, 5495.230667706524, 5498.0653288940775, 5530.640508366943, 5652.943470565303, 5535.169724541331, 5599.356074051496, 5605.831825045255, 5612.747426365823, 5622.943770562283, 5524.861878453031, 5532.031894418501, 5599.916001259984, 5604.915926261109, 5605.215269862222, 5500.80747173851, 5538.086215774432, 5603.215549823028, 5603.7478313475585, 5606.887862242773, 6113.938860611382, 6169.3522180170885, 6264.9686751566405, 6269.811905642838, 6301.023341382093, 6541.411272985454, 6637.037629543737, 6670.39966403026, 6710.966445167792, 6746.730130794763, 6767.593944363354, 6780.762673306411, 6842.247352791189, 6843.794686159423, 6847.897281540781, 6261.24865016201, 6267.62394256346, 6334.809955701337, 6346.143270658448, 6350.237971443456, 6682.863913134779, 6769.458443324522, 6831.146106736658, 6879.258326839625, 6968.442524598121, 6508.739650414025, 6508.837279068061, 6558.803235902835, 6573.901391479131, 6603.405693487609, 6539.5422320438065, 6651.102101216274, 6671.199456065303, 6681.064650948871, 6735.932640673628, 6553.541252112306, 6556.409923106943, 6631.33686631333, 6657.73369065232, 6747.291534388916, 6494.870102597922, 6564.868702626016, 6663.933360666331, 6694.263631000586, 6717.731290748413, 4850.854474365775, 4860.3681521401995, 4898.461169271377, 4964.875878103004, 4966.205407134841, 4469.262571675637, 4477.485089214717, 4487.640988720895, 4493.573110554557, 4519.412476378116, 6169.136320915076, 6181.536384771161, 6251.437370636664, 6256.6871656417, 6262.812115636538, 6559.967200163968, 6696.397324240842, 6700.095487109178, 6732.562383445061, 6773.017912402674, 6218.440340369389, 6224.190855188887, 6235.376462353819, 6240.188775459162, 6270.717817698214, 5398.082326004589, 5470.8085217017215, 5472.2338872557875, 5472.398036216013, 5491.2312276281355, 6842.574913882058, 6929.480288978246, 6934.549254298455, 7033.226345102034, 7036.437085033185, 6676.532642714963, 6715.059891615276, 6729.932700673126, 6743.9325606743305, 6750.594964302158, 6929.1684997800585, 6994.33553812387, 7025.613591252531, 7026.824329391806, 7040.190378106583, 6549.574277671936, 6625.238097618835, 6631.436327912182, 6719.563228390139, 6723.26044135135, 6529.8694026120165, 6619.205695316593, 6634.83412914681, 6635.966820165868, 6637.336266373324, 6453.645049522322, 6525.543211975306, 6551.901721474277, 6565.967170164118, 6576.112224849584, 6417.518686098655, 6555.344465553597, 6581.769638062645, 6590.9670451647435, 6597.2742998271115, 6414.583052101599, 6431.421172094534, 6501.0, 6508.674566271762, 6515.511336649675, 6316.873662526816, 6392.3927226913365, 6427.710753016219, 6526.0, 6572.455472963754, 6268.529860260407, 6313.463355614824, 6320.115183874169, 6325.652089135142, 6345.4923606112325], "value": 6086.334015601311, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [934.5327336331834, 948.9762755931101, 967.5404183013068, 1002.0780881588937, 1007.0936157458286, 44122.779386103066, 45295.32057019147, 45329.77335113328, 45330.77334613326, 45545.08909821806, 45606.77196614012, 45953.0, 45990.7700461498, 46041.0, 46117.53882461174, 8046.155153708864, 8181.67273309067, 8182.263596276334, 8185.918140818605, 8190.303824174952, 7714.6142692865415, 7774.766756997271, 7776.261255180749, 7778.261065198825, 7778.80552986177, 7788.766337009899, 7794.532328060306, 7797.142314345418, 7804.76585702427, 7817.648205830723, 7723.806904827368, 7724.575148366837, 7732.0, 7733.304002639733, 7759.573223472707, 7989.121196668362, 8033.1163572007035, 8049.396295277819, 8056.8388632227025, 8063.314618257456, 40721.592784072076, 41184.38223426651, 41285.1742965139, 41351.379729304084, 41403.58596414058, 3720.1257704439704, 3726.4037753959237, 3728.1425272187275, 3740.738148329618, 3747.775133491999, 33129.337413251844, 33154.6684533154, 33258.0, 33271.0, 33311.00066997994, 5292.073887069748, 5417.187421886709, 5417.51242388187, 5437.537809286176, 5500.4499550045075, 207775.0, 209248.0, 209648.0, 215352.0, 218963.0, 53584.46415535795, 54321.0, 54370.91258174814, 54375.18437223445, 54384.0, 55699.0, 55777.44222557804, 55786.16320755192, 55826.72086639541, 55868.44131558714, 16471.505854824376, 16570.83429165717, 16577.585560361087, 16580.088095154882, 16752.49742507727, 13541.59375218745, 13572.321383930765, 13605.659858503617, 13631.659208519866, 13633.25017124048, 13886.93056534711, 13953.65115872091, 14007.319121705257, 14021.789673154912, 14086.71826563463, 5625.915611265835, 5633.408492108351, 5646.4353564644025, 5669.262995810518, 5792.333881603585, 1111.261011427408, 1119.043218048573, 1120.2718233148519, 1121.8878112188715, 1126.2397881430002, 25817.870910645328, 25839.0, 25930.870345648153, 25937.35156621062, 25998.87000564985, 1192.9343886086176, 1210.2012671636678, 1215.197969340231, 1218.6648671615376, 1239.070696977267, 13758.518451854337, 13783.862161378258, 13820.308984550933, 14000.509982150576, 14092.224927629079, 289943.0, 291142.0, 293169.0, 293396.0, 293545.0, 58113.41886581165, 58185.709071454374, 58234.0, 58324.125138122115, 58464.707676461345, 1519.4985654733912, 1531.3721374236732, 1542.8071491063617, 1551.6974190032836, 1563.335582377485, 25221.369465763502, 25520.489590208465, 25544.489110218063, 25615.23154305374, 25892.22323330303, 40469.797651011555, 40549.594504054585, 40561.0, 40603.59396405998, 40639.0, 232990.0, 233145.0, 234001.0, 234072.0, 234517.30965380254, 36499.45250821186, 38042.80978595089, 39136.608633913296, 39196.80401597974, 39246.4113038299, 51161.48838511716, 51749.22376164436, 52110.0, 52201.0, 52423.0, 37418.0, 37679.81160094182, 37912.24175516529, 37940.241195176495, 38150.23699526049, 37680.24639507139, 37850.43224351692, 37857.24285514219, 38005.619943801314, 38044.23911521699, 42243.57756422397, 43932.341014884165, 43973.12053758971, 44014.0, 44367.11265774731, 36036.0, 36167.0, 36245.78662205709, 36326.81836590906, 36361.818190908874, 27090.32274193161, 27182.592261115704, 27234.863825680746, 27404.177874663794, 27534.173974780788], "value": 18813.075153580692, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.4133818152758, 568.454283887468, 574.8246784730655, 588.4556784973898, 604.4831668923069, 23544.529109417803, 24181.153659621916, 24362.269131926027, 24365.14721984731, 24372.268831935027, 25029.499410011787, 25740.22779316619, 26476.867615661944, 26611.201663950065, 26635.86682066587, 6692.832679183023, 6797.592144471348, 6831.146106736658, 6840.315968403144, 6847.2125705544, 6541.0, 6699.698513566901, 6770.830729231784, 6778.22050464198, 6786.796396108125, 6762.526623136382, 6764.898526522106, 6771.119754431917, 6771.390574848263, 6774.119364482635, 6493.805185844432, 6780.559263647847, 6782.084418603475, 6782.559133656321, 6784.253732089466, 6227.813165605039, 6231.40801623845, 6234.906476402857, 6249.468795152417, 6251.687415629201, 28779.424411511864, 29340.266493337836, 29365.0, 29371.55942660862, 29373.412531749458, 2082.5834833033455, 2088.9268875589432, 2090.5087304483436, 2095.9790402095937, 2103.0, 20054.097565609583, 20466.897665511726, 21045.789542104536, 21133.260335888324, 21144.577108457746, 2539.263613552086, 2550.872456377192, 2554.441790507789, 2557.105013245368, 2590.1581985854486, 128825.35587322003, 135486.32256838752, 146873.0, 154348.0, 156719.0, 15368.385264589291, 15401.30694118745, 15632.06207627546, 15905.80706446998, 16147.596310092107, 25048.248552543453, 25091.4981700365, 25106.748932510807, 25123.874380627978, 25170.74829251684, 10246.897531024744, 10551.050405463546, 10615.31000484966, 10679.412632305297, 10737.570497180026, 9465.90534094664, 9475.194608458358, 9637.132658060807, 9661.516924153764, 9662.227021838236, 9523.238140948708, 9550.044995500533, 9582.28132890036, 9914.752131196778, 9988.250881183794, 2672.0380662961707, 2715.4704832557463, 2837.7587905028304, 2863.141057682687, 2906.593076969226, 1002.9498525073717, 1039.8648175737105, 1049.3284298049255, 1049.9265051446478, 1054.1092776603757, 20840.791592084188, 20950.161993520087, 20976.79023209779, 21406.25078122258, 21439.57120857574, 1084.3385534823751, 1085.5006696919506, 1089.330062011857, 1091.5633746501305, 1107.2802678259195, 11268.477826608103, 11616.419179041182, 11757.059435245159, 11785.0, 11823.408829558488, 595472.0, 605926.0, 610387.0, 610689.0, 615407.0, 125935.0, 126415.36792316164, 128699.0, 130266.0, 130449.0, 1108.933463992163, 1211.4064108586729, 1218.4760552962312, 1262.1228246368685, 1273.7134144817342, 21671.45821354479, 22024.0, 22137.557248855253, 22200.222992195195, 22455.0, 64261.67869160624, 64852.6757366229, 65592.67203663952, 65817.0, 67805.66097169483, 79515.60242198984, 79965.2003479981, 81009.59495202487, 81073.18926810657, 81264.0, 15301.387944482096, 15513.84486155124, 15531.767023494882, 15598.688026239184, 15634.218289085273, 24325.756742433055, 24380.146694865594, 24393.390165245302, 24419.755802442458, 24558.14046508435, 19641.901790491527, 19708.40874773759, 19742.30901918426, 20151.69772453385, 20155.59688806245, 17377.0, 17484.388046418313, 17700.645987080443, 17894.463166105037, 18041.0, 20682.689759653316, 20730.170793168105, 20744.377668669964, 20906.05922733511, 20950.790492094882, 14305.0, 15253.703435208132, 15264.694706106038, 15347.386104556139, 15464.304106315018, 20054.097565609292, 20205.19179232873, 20208.79791202069, 20241.19035238633, 20246.291379801638], "value": 12752.692995613423, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.434720459021, 1530.081950829503, 1530.4872867589354, 1548.0634216299145, 1550.8836837237202, 16277.186140692962, 16820.747688784664, 16856.915715421423, 16859.915700421512, 16863.40978065768, 16526.669466610692, 16609.418670346542, 16621.0, 16626.83373166268, 16681.83318166818, 2691.838489690615, 2745.7117002714726, 2754.1737478756395, 2775.1951933939135, 2793.1760130761472, 2646.073874144053, 2653.907113251027, 2674.545327294355, 2675.54515732326, 2677.531431999392, 2498.650188973545, 2567.9743202568015, 2572.3954870605394, 2579.2520169150926, 2583.7416258374105, 2683.302341391233, 2702.2974026753086, 2723.72762723728, 2729.495043416964, 2734.753872151506, 2414.311921102495, 2441.841280316774, 2444.7677470640438, 2445.254197469771, 2449.09383528094, 16310.347586096543, 16656.6668666626, 16724.66550668992, 16746.916265418717, 16763.078030708308, 7846.5292082475235, 8116.107228204893, 8127.3904457165945, 8156.877646835303, 8162.959185204096, 5271.973640131813, 5370.22131790892, 5561.610687251894, 5565.777368905239, 5577.386487486373, 2009.136071489259, 2049.836013118962, 2055.496403381166, 2104.084723145437, 2110.9261175858924, 29901.0, 30175.245618859484, 30225.848870755726, 30247.092587222418, 30278.66934637188, 6643.202815662152, 6807.421369183675, 6846.383825455733, 6948.895766563505, 6985.301469852974, 19470.80529194718, 19553.511162221057, 19567.412977610693, 19598.314059008153, 19609.117589708498, 7961.36309095271, 8091.676332946734, 8132.227438393344, 8143.633536490872, 8152.714654987047, 7095.325944035309, 7149.714011439484, 7240.05879235696, 7241.239669834592, 7402.1487528933785, 5099.97450012755, 5265.236540701577, 5272.446393128743, 5273.736313184326, 5307.044731948209, 1581.4069723853554, 1582.8100627924723, 1586.2306781211103, 1593.0, 1607.638281386702, 769.3960241210734, 922.3267015078895, 928.9163975242126, 937.2595649436869, 973.0, 8776.297896168291, 8776.297896168291, 8953.462792232487, 8958.372913895964, 8969.103089691109, 1059.8092343378112, 1073.4739977411168, 1075.2849355178719, 1093.0272057868503, 1102.525913857049, 5455.754491047913, 5468.6171967962655, 5486.972565137149, 5678.205051292823, 5894.764209431661, 24244.757552424602, 24481.38796530101, 25124.24627261185, 25173.748262517507, 25351.0, 24846.254612361296, 24909.501809963698, 25014.374640633767, 25061.62407563888, 25070.373240668763, 10138.645147419953, 10890.29213101146, 11015.724606884733, 11153.10775137987, 11205.495752691148, 9553.713388598075, 9617.326787124834, 9672.177864881283, 9717.514124293899, 9882.357646752938, 20944.895275524133, 20973.475663108544, 21185.470363241042, 21375.893120534296, 21836.89081554582, 21844.672329914745, 21869.56260874742, 22012.119515219212, 22054.66917996199, 22143.335699929026, 12082.577109801116, 12213.206141600767, 12220.327881966577, 12224.205426647239, 12229.633111006684, 15250.0, 15504.0, 15617.843821561639, 15626.296816643051, 15650.13924234178, 11974.880251197725, 12026.0, 12064.638060857837, 12148.635540933787, 12320.691982700504, 11737.354445505238, 11752.941235293769, 11834.230774999598, 11843.763124737628, 12072.879271207175, 10151.695449136538, 10160.898391015995, 10186.643467478603, 10214.489275536342, 10243.282970192015, 7887.723929662434, 8093.109757926741, 8121.269085782308, 8146.429749917449, 8251.95874020626, 8000.679972801023, 8160.673573057249, 8191.139930307232, 8206.138355472589, 8296.253337199681], "value": 7095.547149215911, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.4702850121378, 534.1960349673737, 555.7499125393573, 563.6111083352484, 580.4891695308131, 6086.208792856928, 6138.600990935592, 6159.384061593838, 6209.472194863442, 6247.2503299603995, 6071.7874874379295, 6087.573869829113, 6096.177016102824, 6098.969505152468, 6113.144159817618, 4972.850814475553, 5012.4736902625245, 5013.3482647255805, 5026.421961474441, 5029.924551131745, 4983.8504844854715, 5000.549950504454, 5001.99960007998, 5027.824026159085, 5048.29323894655, 4759.452662943754, 4951.480094590071, 4967.900641987158, 4985.900281994358, 4991.201407774757, 4834.709917404949, 4842.2252439609665, 4868.878278043042, 4874.122657921573, 4909.852704418873, 4433.645308375322, 4435.157320109169, 4455.977720111411, 4470.441194850644, 4477.597016268552, 5950.880982380371, 5986.910196347058, 6001.0, 6018.548608854353, 6112.572119951606, 5721.914171287434, 5722.570807189478, 5743.282089738783, 5765.394633563499, 5783.363829978699, 6489.4483968862705, 6533.7713180038945, 6569.343065693441, 6576.704048317837, 6604.108445359863, 4705.341252224691, 4911.5088491150955, 4929.3345398371475, 4936.160852655022, 4976.2286845539, 6649.900251496231, 6655.700493477757, 6670.599764014175, 6677.666116694146, 6774.898376524356, 5004.199328107558, 5030.572401345853, 5038.017586570657, 5063.670861394071, 5079.822206222764, 5083.872903177376, 5103.9281750832, 5119.8720031998755, 5134.485326828594, 5157.303763991888, 5662.631928924607, 5729.0, 5749.798757043483, 5755.366909639936, 5757.884842303214, 6544.345565443513, 6582.967085164543, 6589.341065893468, 6599.47204223661, 6602.306757790363, 1730.4722059771639, 1765.7792775903013, 1770.8140645232322, 1773.5211492896847, 1780.64387122576, 1199.1006744941294, 1218.5369559567307, 1231.759806837658, 1233.8210959411015, 1239.900807935363, 5862.443067908542, 5885.529157667376, 5890.263717035371, 5905.143754155623, 6022.668753218528, 6301.180846489927, 6388.8083357499345, 6442.581232219891, 6528.967355163194, 6593.175853018372, 5824.650520968671, 5955.731992060368, 5965.940340596625, 5984.790532331347, 6009.519238460913, 3420.931581368359, 3422.606400263952, 3430.3996800559803, 3443.466262729281, 3471.930561388758, 6421.903671444932, 6768.492363072691, 6817.318268173143, 6818.897716534256, 6859.451243900476, 6529.804105876831, 6531.7263133688475, 6572.474202063823, 6643.833904152339, 6703.3296670332575, 6733.744195694399, 6744.0, 6746.865062698718, 6840.144981877265, 6851.760188393382, 6432.517561182836, 6476.773312934025, 6478.190226221723, 6579.901301480578, 6580.901286480611, 6465.3857883501, 6508.186476690414, 6520.706568204348, 6564.4420224281475, 6617.139771829824, 6741.426978706865, 6791.966040169767, 6834.965825170842, 6897.379235868796, 6932.410745086522, 4933.9506604933495, 4967.850964471072, 4973.278874563096, 4977.64009293718, 4992.176290911959, 6401.135846660642, 6534.771283005072, 6621.205455345389, 6680.365365290289, 6687.665616719242, 6397.744090236339, 6399.6800159992745, 6428.550001500037, 6433.163688720437, 6457.6771161442675, 6366.840828979127, 6377.266614339224, 6391.936080639134, 6407.1350367701625, 6415.1981002374705, 6378.170837791057, 6384.808455746335, 6392.520560957853, 6404.295527491879, 6444.13004244421, 6391.456726178327, 6440.967795160994, 6451.483881289391, 6481.708323125376, 6515.2833188348295, 6267.749290028531, 6273.96863015682, 6309.400606942333, 6324.114623952558, 6343.4608058313715], "value": 5050.045135252829, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [950.795578950525, 987.3039507147462, 989.8020395920815, 1017.7710015246565, 1021.0708255487508, 19785.307514236985, 20570.691439628397, 20593.38219853405, 20836.8958155209, 24017.879910600466, 21575.67636485454, 21615.891920540376, 21648.0, 21712.565748685058, 21724.13103475859, 1061.0927656853376, 1074.0119090436779, 1074.248026381532, 1074.457399013497, 1076.8438576406415, 970.4419958523877, 1067.226260960805, 1071.871375434949, 1078.6763970808727, 1092.2408925796574, 1124.0333313350511, 1129.6046383765658, 1132.399828091113, 1133.880942501038, 1145.2384164530577, 1125.8648962124516, 1126.7802778458204, 1130.8473356096904, 1133.3596517967321, 1138.174823253139, 836.2682652678906, 839.0099682374795, 839.6935118681698, 840.5083026429546, 841.7685136587427, 19976.200951961902, 20197.596048078954, 20643.483912902146, 20707.792922070737, 21134.15463381463, 22313.330600082023, 22778.54442911149, 22977.655335169984, 23008.539829203488, 23024.194153204724, 16310.266038028318, 16398.426055088014, 16435.83564164355, 16594.08732519711, 16616.169191540495, 3796.8671096511766, 3881.5536213335545, 3966.861159859391, 3991.4212439196444, 4025.75845449274, 156444.0, 156703.0, 156995.2150239253, 158783.0, 159654.20172899062, 17860.9106954467, 17995.100244987698, 18238.63522729538, 18247.72628410575, 18257.81742182588, 32701.67298327034, 33023.0, 34418.82790586031, 34507.482387764205, 34732.0, 8021.157778433298, 8078.23256790604, 8095.514269143752, 8101.473404228706, 8136.22705842944, 4206.558311377323, 4226.281532139544, 4228.640565551963, 4273.829046838154, 4276.31578947367, 6033.728482218311, 6208.410201030895, 6223.844403889939, 6229.657368844757, 6268.435840774261, 1232.9260244385366, 1258.936198911918, 1260.697432616184, 1272.6245757501374, 1273.121546133165, 716.7419728897593, 725.1696807155777, 730.204077555467, 739.7706710919524, 750.0586763611633, 12582.0, 12953.935230323788, 13191.274479903506, 14017.789733154012, 14480.203588802506, 714.6248219684603, 742.2614498573846, 745.5005146551823, 753.4951582439778, 763.9923600763922, 6097.057433524879, 6116.235470566179, 6194.194754681863, 6214.0, 6299.433051025429, 141868.29065854813, 145145.0, 145674.0, 146782.0, 148839.0, 127621.3618931918, 130387.0, 130797.34601326933, 132470.0, 135709.32145339408, 115127.42436287932, 116098.0, 117536.0, 117691.41154294345, 118032.0, 11594.072474201876, 11717.76564468723, 11747.941260293645, 11849.881501184878, 11938.462769175581, 52765.472345277594, 53333.0, 53831.0, 53857.73071134776, 54872.0, 69751.65124174347, 69865.30134698791, 70220.0, 70535.0, 84174.0, 18344.449666510027, 19163.80836191676, 19352.516187094872, 19371.128299226286, 19458.124384402454, 20136.49658758543, 20243.19027238953, 20278.59442811165, 20320.898395507927, 20449.2842750503, 18510.0, 18544.350947716764, 18569.44291671252, 18630.06849657539, 18667.626647467245, 19885.204591816164, 20094.59810803805, 20334.186632534533, 20586.382408527767, 20602.27892023772, 19734.0, 19782.802171978095, 19850.10674519621, 19852.801471985673, 19998.1000854959, 14188.503402380868, 14342.856571434151, 14448.27758612044, 14703.491069068508, 14712.411503539739, 14154.541742602984, 14184.148951062969, 14189.219592922489, 14201.147931124166, 14206.715865682421], "value": 10056.702738220272, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1374.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 105.0, 105.0, 107.0, 108.0, 94.0, 105.0, 106.0, 105.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 115.0, 112.0, 113.0, 111.0, 111.0, 113.0, 113.0, 111.0], "value": 112.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 163.0, 162.0, 164.0, 161.0, 167.0, 167.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 82.0, 73.0, 73.0, 73.0, 83.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 78.0, 78.0, 83.0, 77.0, 78.0, 79.0, 81.0, 82.0, 86.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 149.0, 150.0, 152.0, 151.0, 151.0, 152.0, 150.0, 152.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 45.0, 44.0, 45.0, 45.0, 44.0, 44.0, 53.0, 55.0], "value": 46.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 36.0, 37.0, 37.0, 37.0, 37.0, 37.0, 38.0], "value": 37.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 74.0, 70.0, 73.0, 73.0, 75.0, 70.0, 73.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 108.0, 108.0, 103.0, 108.0, 106.0, 106.0, 107.0, 102.0, 110.0], "value": 106.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 159.0, 162.0, 166.0, 152.0, 152.0, 157.0, 157.0, 154.0, 149.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 65.0, 58.0, 59.0, 64.0, 81.0, 60.0, 57.0, 60.0, 58.0], "value": 62.1, "unit": "score"}]}]} 12:08:23 INFO - Return code: 0 12:08:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:08:23 INFO - # TBPL SUCCESS # 12:08:23 INFO - Running post-action listener: _package_coverage_data 12:08:23 INFO - Running post-action listener: _resource_record_post_action 12:08:23 INFO - [mozharness: 2017-09-12 19:08:23.839042Z] Finished run-tests step (success) 12:08:23 INFO - Running post-run listener: _resource_record_post_run 12:08:23 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284844032; Read time: 216; Write time: 181224 12:08:23 INFO - TinderboxPrint: CPU usage
13.0% 12:08:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 216 12:08:23 INFO - TinderboxPrint: I/O write bytes / time
284,844,032 / 181,224 12:08:23 INFO - TinderboxPrint: CPU idle
8,199.7 (86.9%) 12:08:23 INFO - TinderboxPrint: CPU user
1,183.8 (12.6%) 12:08:23 INFO - TinderboxPrint: Swap in / out
0 / 0 12:08:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20598784; Read time: 0; Write time: 11352 12:08:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:08:23 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 263299072; Read time: 216; Write time: 169804 12:08:24 INFO - Running post-run listener: _upload_blobber_files 12:08:24 INFO - Blob upload gear active. 12:08:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:08:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:08:24 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:08:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:08:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:31 INFO - (blobuploader) - INFO - Done attempting. 12:08:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:08:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:32 INFO - (blobuploader) - INFO - Done attempting. 12:08:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:08:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:08:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:33 INFO - (blobuploader) - INFO - Done attempting. 12:08:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:08:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:08:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:34 INFO - (blobuploader) - INFO - Done attempting. 12:08:34 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:34 INFO - Return code: 0 12:08:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:08:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53312cbdc5bf078e0788c1e46967ae57f251fa487f10aacd04c61384c47c880a1200a9680ddcb06ddd132e9379d0eb752f284aceb73a7540c5cd7969c7ba1574", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/977c3e12e6104fdaccb8fc0db7c12f9995bd1b7fdd3bcf6ba87e609ff592e98c8e3a44ff4585d06ad15e2eea97e010c414536a96567f3ff964b5081e4face499", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f384d441916a306b5ea27fe1e6ff7845b7b990086effd77cf5ef30425fa6e16229f1c834416922d4fac5ee02caf863fbab3fc603f3633bc577da1491c421aa11", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e47c6c131fa475a2f5281334d6ba46e9e546f81e67018e3f3969d18bff5ed3922c1daeb72d67b0774bb6a621d0745f37117381f4937fb799d7fa0218ce776e78"} 12:08:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:08:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:08:34 INFO - Contents: 12:08:34 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53312cbdc5bf078e0788c1e46967ae57f251fa487f10aacd04c61384c47c880a1200a9680ddcb06ddd132e9379d0eb752f284aceb73a7540c5cd7969c7ba1574", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/977c3e12e6104fdaccb8fc0db7c12f9995bd1b7fdd3bcf6ba87e609ff592e98c8e3a44ff4585d06ad15e2eea97e010c414536a96567f3ff964b5081e4face499", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f384d441916a306b5ea27fe1e6ff7845b7b990086effd77cf5ef30425fa6e16229f1c834416922d4fac5ee02caf863fbab3fc603f3633bc577da1491c421aa11", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e47c6c131fa475a2f5281334d6ba46e9e546f81e67018e3f3969d18bff5ed3922c1daeb72d67b0774bb6a621d0745f37117381f4937fb799d7fa0218ce776e78"} 12:08:34 INFO - Running post-run listener: copy_logs_to_upload_dir 12:08:34 INFO - Copying logs to upload dir... 12:08:34 INFO - mkdir: /builds/slave/test/build/upload/logs 12:08:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.084645 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-12 12:08:34.516923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 12:08:34.521792) ========= 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=199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53312cbdc5bf078e0788c1e46967ae57f251fa487f10aacd04c61384c47c880a1200a9680ddcb06ddd132e9379d0eb752f284aceb73a7540c5cd7969c7ba1574", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/977c3e12e6104fdaccb8fc0db7c12f9995bd1b7fdd3bcf6ba87e609ff592e98c8e3a44ff4585d06ad15e2eea97e010c414536a96567f3ff964b5081e4face499", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f384d441916a306b5ea27fe1e6ff7845b7b990086effd77cf5ef30425fa6e16229f1c834416922d4fac5ee02caf863fbab3fc603f3633bc577da1491c421aa11", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e47c6c131fa475a2f5281334d6ba46e9e546f81e67018e3f3969d18bff5ed3922c1daeb72d67b0774bb6a621d0745f37117381f4937fb799d7fa0218ce776e78"} build_url:https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/WIyyaxl_SfCVWW1rKMtdsA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53312cbdc5bf078e0788c1e46967ae57f251fa487f10aacd04c61384c47c880a1200a9680ddcb06ddd132e9379d0eb752f284aceb73a7540c5cd7969c7ba1574", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/977c3e12e6104fdaccb8fc0db7c12f9995bd1b7fdd3bcf6ba87e609ff592e98c8e3a44ff4585d06ad15e2eea97e010c414536a96567f3ff964b5081e4face499", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f384d441916a306b5ea27fe1e6ff7845b7b990086effd77cf5ef30425fa6e16229f1c834416922d4fac5ee02caf863fbab3fc603f3633bc577da1491c421aa11", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e47c6c131fa475a2f5281334d6ba46e9e546f81e67018e3f3969d18bff5ed3922c1daeb72d67b0774bb6a621d0745f37117381f4937fb799d7fa0218ce776e78"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 12:08:34.551698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 12:08:34.552036) ========= 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=199fb4c72b90437b990b419b000001c5-1505242070.921197-1148321131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 12:08:34.634069) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 12:08:34.634386) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 12:08:34.634680) ========= ========= Total master_lag: 0.19 =========