builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1502709037.84 results: success (0) revision: f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:37.837293) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:37.837818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:37.838111) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:37.850261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:37.850574) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 04:10:37-- 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% 43.0M=0s 2017-08-14 04:10:37 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:37.974429) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:37.974765) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016197 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:38.109003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:38.109367) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf --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 f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 04:10:38,071 truncating revision to first 12 chars 2017-08-14 04:10:38,071 Setting DEBUG logging. 2017-08-14 04:10:38,071 attempt 1/10 2017-08-14 04:10:38,071 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f667fdab3ac0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 04:10:38,540 unpacking tar archive at: mozilla-central-f667fdab3ac0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.780723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:38.909158) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:38.909565) ========= script_repo_revision: f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:38.909995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:38.910264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:38.924681) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-08-14 04:10:38.925047) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:10:38 INFO - MultiFileLogger online at 20170814 04:10:38 in /builds/slave/test 04:10:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:10:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:10:38 INFO - {'append_to_log': False, 04:10:38 INFO - 'base_work_dir': '/builds/slave/test', 04:10:38 INFO - 'blob_upload_branch': 'Firefox', 04:10:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:10:38 INFO - 'branch': 'Firefox', 04:10:38 INFO - 'buildbot_json_path': 'buildprops.json', 04:10:38 INFO - 'code_coverage': False, 04:10:38 INFO - 'config_files': ('talos/linux_config.py',), 04:10:38 INFO - 'default_actions': ('clobber', 04:10:38 INFO - 'read-buildbot-config', 04:10:38 INFO - 'download-and-extract', 04:10:38 INFO - 'populate-webroot', 04:10:38 INFO - 'create-virtualenv', 04:10:38 INFO - 'install', 04:10:38 INFO - 'setup-mitmproxy', 04:10:38 INFO - 'run-tests'), 04:10:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:10:38 INFO - 'disable_ccov_upload': False, 04:10:38 INFO - 'download_minidump_stackwalk': True, 04:10:38 INFO - 'download_symbols': 'ondemand', 04:10:38 INFO - 'enable_stylo': False, 04:10:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:10:38 INFO - 'tooltool.py': '/tools/tooltool.py', 04:10:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:10:38 INFO - '/tools/misc-python/virtualenv.py')}, 04:10:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:10:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:10:38 INFO - 'gecko_profile': False, 04:10:38 INFO - 'gecko_profile_interval': 0, 04:10:38 INFO - 'installer_path': 'installer.exe', 04:10:38 INFO - 'log_level': 'info', 04:10:38 INFO - 'log_name': 'talos', 04:10:38 INFO - 'log_to_console': True, 04:10:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:10:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:10:38 INFO - 'opt_config_files': (), 04:10:38 INFO - 'pip_index': False, 04:10:38 INFO - 'suite': 'dromaeojs-e10s', 04:10:38 INFO - 'system_bits': '32', 04:10:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:10:38 INFO - 'title': 'talos-linux64-ix-029', 04:10:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:10:38 INFO - 'use_talos_json': True, 04:10:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:10:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:10:38 INFO - 'work_dir': 'build'} 04:10:38 INFO - [mozharness: 2017-08-14 11:10:38.987341Z] Running clobber step. 04:10:38 INFO - Running pre-action listener: _resource_record_pre_action 04:10:38 INFO - Running main action method: clobber 04:10:38 INFO - rmtree: /builds/slave/test/build 04:10:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:10:40 INFO - Running post-action listener: _resource_record_post_action 04:10:40 INFO - [mozharness: 2017-08-14 11:10:40.055746Z] Finished clobber step (success) 04:10:40 INFO - [mozharness: 2017-08-14 11:10:40.055848Z] Running read-buildbot-config step. 04:10:40 INFO - Running pre-action listener: _resource_record_pre_action 04:10:40 INFO - Running main action method: read_buildbot_config 04:10:40 INFO - Using buildbot properties: 04:10:40 INFO - { 04:10:40 INFO - "project": "", 04:10:40 INFO - "product": "firefox", 04:10:40 INFO - "who": "archaeopteryx@coole-files.de", 04:10:40 INFO - "installer_path": "public/build/target.tar.bz2", 04:10:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:10:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:10:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 04:10:40 INFO - "stage_platform": "linux64-pgo", 04:10:40 INFO - "basedir": "/builds/slave/test", 04:10:40 INFO - "buildnumber": 110, 04:10:40 INFO - "platform": "ubuntu64_hw", 04:10:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:10:40 INFO - "slavebuilddir": "test", 04:10:40 INFO - "taskId": "VQkWDjX9TviAx-sWoRvgsg", 04:10:40 INFO - "branch": "mozilla-central", 04:10:40 INFO - "script_repo_revision": "production", 04:10:40 INFO - "revision": "f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf", 04:10:40 INFO - "slavename": "talos-linux64-ix-029", 04:10:40 INFO - "repo_path": "mozilla-central" 04:10:40 INFO - } 04:10:40 INFO - Finding installer, test and symbols from parent task. 04:10:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VQkWDjX9TviAx-sWoRvgsg'}, attempt #1 04:10:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VQkWDjX9TviAx-sWoRvgsg'}, attempt #1 04:10:40 INFO - Task dependencies: ZB0kav9bRV-063CH8DVBog 04:10:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog'}, attempt #1 04:10:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.tar.bz2 04:10:41 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.test_packages.json 04:10:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.crashreporter-symbols.zip 04:10:41 INFO - Running post-action listener: _resource_record_post_action 04:10:41 INFO - [mozharness: 2017-08-14 11:10:41.395848Z] Finished read-buildbot-config step (success) 04:10:41 INFO - [mozharness: 2017-08-14 11:10:41.396072Z] Running download-and-extract step. 04:10:41 INFO - Running pre-action listener: _resource_record_pre_action 04:10:41 INFO - Running main action method: download_and_extract 04:10:41 INFO - mkdir: /builds/slave/test/build/tests 04:10:41 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')]} 04:10:41 INFO - trying https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.test_packages.json 04:10:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:10:41 INFO - Downloaded 989 bytes. 04:10:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:10:41 INFO - Using the following test package requirements: 04:10:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:10:41 INFO - u'common': [u'target.common.tests.zip'], 04:10:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:10:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:10:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:10:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:10:41 INFO - u'mozbase': [u'target.common.tests.zip'], 04:10:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:10:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:10:41 INFO - u'web-platform': [u'target.common.tests.zip', 04:10:41 INFO - u'target.web-platform.tests.tar.gz'], 04:10:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:10:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:10:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.common.tests.zip 04:10:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:10:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.common.tests.zip into memory 04:10:43 INFO - Content-Length response header: 54648559 04:10:43 INFO - Bytes received: 54648559 04:10:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:10:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.common.tests.zip 04:10:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:10:54 INFO - Fetch https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.common.tests.zip into memory 04:10:55 INFO - Content-Length response header: 54648559 04:10:55 INFO - Bytes received: 54648559 04:11:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.talos.tests.zip 04:11:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:11:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.talos.tests.zip into memory 04:11:12 INFO - Content-Length response header: 14496050 04:11:12 INFO - Bytes received: 14496050 04:11:12 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')]} 04:11:12 INFO - trying https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.tar.bz2 04:11:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:11:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:11:14 INFO - Downloaded 62581600 bytes. 04:11:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.tar.bz2 04:11:14 INFO - mkdir: /builds/slave/test/properties 04:11:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:14 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:14 INFO - Contents: 04:11:14 INFO - build_url:https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.tar.bz2 04:11:14 INFO - Running post-action listener: _resource_record_post_action 04:11:14 INFO - Running post-action listener: set_extra_try_arguments 04:11:14 INFO - [mozharness: 2017-08-14 11:11:14.023221Z] Finished download-and-extract step (success) 04:11:14 INFO - [mozharness: 2017-08-14 11:11:14.023320Z] Running populate-webroot step. 04:11:14 INFO - Running pre-action listener: _resource_record_pre_action 04:11:14 INFO - Running main action method: populate_webroot 04:11:14 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:11:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:11:14 INFO - 'tests': ['damp', 'tps']}, 04:11:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:11:14 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:11:14 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:11:14 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:14 INFO - 'ts_paint', 04:11:14 INFO - 'tpaint', 04:11:14 INFO - 'sessionrestore', 04:11:14 INFO - 'sessionrestore_many_windows', 04:11:14 INFO - 'sessionrestore_no_auto_restore', 04:11:14 INFO - 'tabpaint']}, 04:11:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:11:14 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:11:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:14 INFO - 'tsvgr_opacity', 04:11:14 INFO - 'tart', 04:11:14 INFO - 'tscrollx', 04:11:14 INFO - 'tsvg_static']}, 04:11:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:11:14 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:11:14 INFO - 'talos_options': ['--mitmproxy', 04:11:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:11:14 INFO - '--firstNonBlankPaint'], 04:11:14 INFO - 'tests': ['tp6_google', 04:11:14 INFO - 'tp6_youtube', 04:11:14 INFO - 'tp6_amazon', 04:11:14 INFO - 'tp6_facebook']}, 04:11:14 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:11:14 INFO - 'talos_options': ['--stylo', 04:11:14 INFO - '--mitmproxy', 04:11:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:11:14 INFO - '--firstNonBlankPaint'], 04:11:14 INFO - 'tests': ['tp6_google', 04:11:14 INFO - 'tp6_youtube', 04:11:14 INFO - 'tp6_amazon', 04:11:14 INFO - 'tp6_facebook']}, 04:11:14 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:11:14 INFO - 'talos_options': ['--stylo', 04:11:14 INFO - '--stylo-threads=1', 04:11:14 INFO - '--mitmproxy', 04:11:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:11:14 INFO - '--firstNonBlankPaint'], 04:11:14 INFO - 'tests': ['tp6_google', 04:11:14 INFO - 'tp6_youtube', 04:11:14 INFO - 'tp6_amazon', 04:11:14 INFO - 'tp6_facebook']}, 04:11:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:11:14 INFO - 'talos_options': ['--xperf_path', 04:11:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:14 INFO - 'tests': ['tp5n']}}} 04:11:14 INFO - Running post-action listener: _resource_record_post_action 04:11:14 INFO - [mozharness: 2017-08-14 11:11:14.031746Z] Finished populate-webroot step (success) 04:11:14 INFO - [mozharness: 2017-08-14 11:11:14.031837Z] Running create-virtualenv step. 04:11:14 INFO - Running pre-action listener: _resource_record_pre_action 04:11:14 INFO - Running main action method: create_virtualenv 04:11:14 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:11:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:14 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:11:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:14 INFO - Using real prefix '/usr' 04:11:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:14 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:16 INFO - Installing pip.................done. 04:11:16 INFO - Return code: 0 04:11:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:11:16 INFO - Reading from file tmpfile_stdout 04:11:16 INFO - Output received: 04:11:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:11:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:16 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')]} 04:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:16 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')]} 04:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:16 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 0x9ee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5bb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:16 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 04:11:16 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 04:11:16 INFO - Using env: {'DISPLAY': ':0', 04:11:16 INFO - 'HOME': '/home/cltbld', 04:11:16 INFO - 'LANG': 'en_US.UTF-8', 04:11:16 INFO - 'LANGUAGE': 'en_US:en', 04:11:16 INFO - 'LOGNAME': 'cltbld', 04:11:16 INFO - 'MAIL': '/var/mail/cltbld', 04:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:16 INFO - 'MOZ_NO_REMOTE': '1', 04:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:16 INFO - 'NO_EM_RESTART': '1', 04:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:16 INFO - 'PWD': '/builds/slave/test', 04:11:16 INFO - 'SHELL': '/bin/bash', 04:11:16 INFO - 'SHLVL': '1', 04:11:16 INFO - 'TERM': 'linux', 04:11:16 INFO - 'TMOUT': '86400', 04:11:16 INFO - 'USER': 'cltbld', 04:11:16 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:16 INFO - '_': '/tools/buildbot/bin/python'} 04:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:11:16 INFO - Cleaning up... 04:11:16 INFO - Return code: 0 04:11:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:11:16 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')]} 04:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:16 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')]} 04:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:17 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 0x9ee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5bb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:17 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 04:11:17 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 04:11:17 INFO - Using env: {'DISPLAY': ':0', 04:11:17 INFO - 'HOME': '/home/cltbld', 04:11:17 INFO - 'LANG': 'en_US.UTF-8', 04:11:17 INFO - 'LANGUAGE': 'en_US:en', 04:11:17 INFO - 'LOGNAME': 'cltbld', 04:11:17 INFO - 'MAIL': '/var/mail/cltbld', 04:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:17 INFO - 'MOZ_NO_REMOTE': '1', 04:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:17 INFO - 'NO_EM_RESTART': '1', 04:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:17 INFO - 'PWD': '/builds/slave/test', 04:11:17 INFO - 'SHELL': '/bin/bash', 04:11:17 INFO - 'SHLVL': '1', 04:11:17 INFO - 'TERM': 'linux', 04:11:17 INFO - 'TMOUT': '86400', 04:11:17 INFO - 'USER': 'cltbld', 04:11:17 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:17 INFO - '_': '/tools/buildbot/bin/python'} 04:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:17 INFO - Downloading/unpacking psutil>=3.1.1 04:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:18 INFO - Installing collected packages: psutil 04:11:18 INFO - Running setup.py install for psutil 04:11:18 INFO - building 'psutil._psutil_linux' extension 04:11:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:11:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:11:18 INFO - building 'psutil._psutil_posix' extension 04:11:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:11:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:11:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:18 INFO - Successfully installed psutil 04:11:18 INFO - Cleaning up... 04:11:18 INFO - Return code: 0 04:11:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11: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')]} 04:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9ee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5bb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:11: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 mozsystemmonitor==0.3 04:11:18 INFO - Using env: {'DISPLAY': ':0', 04:11:18 INFO - 'HOME': '/home/cltbld', 04:11:18 INFO - 'LANG': 'en_US.UTF-8', 04:11:18 INFO - 'LANGUAGE': 'en_US:en', 04:11:18 INFO - 'LOGNAME': 'cltbld', 04:11:18 INFO - 'MAIL': '/var/mail/cltbld', 04:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:18 INFO - 'MOZ_NO_REMOTE': '1', 04:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:18 INFO - 'NO_EM_RESTART': '1', 04:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:18 INFO - 'PWD': '/builds/slave/test', 04:11:18 INFO - 'SHELL': '/bin/bash', 04:11:18 INFO - 'SHLVL': '1', 04:11:18 INFO - 'TERM': 'linux', 04:11:18 INFO - 'TMOUT': '86400', 04:11:18 INFO - 'USER': 'cltbld', 04:11:18 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:18 INFO - '_': '/tools/buildbot/bin/python'} 04:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:11:20 INFO - Installing collected packages: mozsystemmonitor 04:11:20 INFO - Running setup.py install for mozsystemmonitor 04:11:20 INFO - Successfully installed mozsystemmonitor 04:11:20 INFO - Cleaning up... 04:11:20 INFO - Return code: 0 04:11:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:11:20 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')]} 04:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:20 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')]} 04:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:20 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 0x9ee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5bb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:20 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 04:11:20 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 04:11:20 INFO - Using env: {'DISPLAY': ':0', 04:11:20 INFO - 'HOME': '/home/cltbld', 04:11:20 INFO - 'LANG': 'en_US.UTF-8', 04:11:20 INFO - 'LANGUAGE': 'en_US:en', 04:11:20 INFO - 'LOGNAME': 'cltbld', 04:11:20 INFO - 'MAIL': '/var/mail/cltbld', 04:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:20 INFO - 'MOZ_NO_REMOTE': '1', 04:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:20 INFO - 'NO_EM_RESTART': '1', 04:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:20 INFO - 'PWD': '/builds/slave/test', 04:11:20 INFO - 'SHELL': '/bin/bash', 04:11:20 INFO - 'SHLVL': '1', 04:11:20 INFO - 'TERM': 'linux', 04:11:20 INFO - 'TMOUT': '86400', 04:11:20 INFO - 'USER': 'cltbld', 04:11:20 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:20 INFO - '_': '/tools/buildbot/bin/python'} 04:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:20 INFO - Downloading/unpacking jsonschema==2.5.1 04:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:11:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:11:21 INFO - warning: no files found matching '*.txt' 04:11:21 INFO - no previously-included directories found matching 'build' 04:11:21 INFO - no previously-included directories found matching 'dist' 04:11:21 INFO - no previously-included directories found matching '.git*' 04:11:21 INFO - Installing collected packages: jsonschema, functools32 04:11:21 INFO - Running setup.py install for functools32 04:11:22 INFO - warning: no files found matching '*.txt' 04:11:22 INFO - no previously-included directories found matching 'build' 04:11:22 INFO - no previously-included directories found matching 'dist' 04:11:22 INFO - no previously-included directories found matching '.git*' 04:11:22 INFO - Successfully installed jsonschema functools32 04:11:22 INFO - Cleaning up... 04:11:22 INFO - Return code: 0 04:11:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11: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')]} 04:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11: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 0x9ee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5bb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11: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 04:11: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 04:11:22 INFO - Using env: {'DISPLAY': ':0', 04:11:22 INFO - 'HOME': '/home/cltbld', 04:11:22 INFO - 'LANG': 'en_US.UTF-8', 04:11:22 INFO - 'LANGUAGE': 'en_US:en', 04:11:22 INFO - 'LOGNAME': 'cltbld', 04:11:22 INFO - 'MAIL': '/var/mail/cltbld', 04:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:22 INFO - 'MOZ_NO_REMOTE': '1', 04:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:22 INFO - 'NO_EM_RESTART': '1', 04:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:22 INFO - 'PWD': '/builds/slave/test', 04:11:22 INFO - 'SHELL': '/bin/bash', 04:11:22 INFO - 'SHLVL': '1', 04:11:22 INFO - 'TERM': 'linux', 04:11:22 INFO - 'TMOUT': '86400', 04:11:22 INFO - 'USER': 'cltbld', 04:11:22 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:22 INFO - '_': '/tools/buildbot/bin/python'} 04:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:11:22 INFO - Cleaning up... 04:11:22 INFO - Return code: 0 04:11:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11: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')]} 04:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11: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 0x9ee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5bb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11: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 04:11: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 04:11:22 INFO - Using env: {'DISPLAY': ':0', 04:11:22 INFO - 'HOME': '/home/cltbld', 04:11:22 INFO - 'LANG': 'en_US.UTF-8', 04:11:22 INFO - 'LANGUAGE': 'en_US:en', 04:11:22 INFO - 'LOGNAME': 'cltbld', 04:11:22 INFO - 'MAIL': '/var/mail/cltbld', 04:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:22 INFO - 'MOZ_NO_REMOTE': '1', 04:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:22 INFO - 'NO_EM_RESTART': '1', 04:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:22 INFO - 'PWD': '/builds/slave/test', 04:11:22 INFO - 'SHELL': '/bin/bash', 04:11:22 INFO - 'SHLVL': '1', 04:11:22 INFO - 'TERM': 'linux', 04:11:22 INFO - 'TMOUT': '86400', 04:11:22 INFO - 'USER': 'cltbld', 04:11:22 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:22 INFO - '_': '/tools/buildbot/bin/python'} 04:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:23 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:24 INFO - Downloading docopt-0.6.1.tar.gz 04:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:24 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:24 INFO - Running setup.py install for blobuploader 04:11:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:24 INFO - Running setup.py install for requests 04:11:24 INFO - Running setup.py install for docopt 04:11:24 INFO - Successfully installed blobuploader requests docopt 04:11:24 INFO - Cleaning up... 04:11:24 INFO - Return code: 0 04:11:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:24 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')]} 04:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:24 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')]} 04:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:24 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 0x9ee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5bb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:24 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 04:11:24 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 04:11:24 INFO - Using env: {'DISPLAY': ':0', 04:11:24 INFO - 'HOME': '/home/cltbld', 04:11:24 INFO - 'LANG': 'en_US.UTF-8', 04:11:24 INFO - 'LANGUAGE': 'en_US:en', 04:11:24 INFO - 'LOGNAME': 'cltbld', 04:11:24 INFO - 'MAIL': '/var/mail/cltbld', 04:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:24 INFO - 'MOZ_NO_REMOTE': '1', 04:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:24 INFO - 'NO_EM_RESTART': '1', 04:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:24 INFO - 'PWD': '/builds/slave/test', 04:11:24 INFO - 'SHELL': '/bin/bash', 04:11:24 INFO - 'SHLVL': '1', 04:11:24 INFO - 'TERM': 'linux', 04:11:24 INFO - 'TMOUT': '86400', 04:11:24 INFO - 'USER': 'cltbld', 04:11:24 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:24 INFO - '_': '/tools/buildbot/bin/python'} 04:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:25 INFO - Running setup.py (path:/tmp/pip-sBNYOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:25 INFO - Running setup.py (path:/tmp/pip-gE09P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:25 INFO - Running setup.py (path:/tmp/pip-uic2I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:25 INFO - Running setup.py (path:/tmp/pip-240D3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:25 INFO - Running setup.py (path:/tmp/pip-REtMDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:25 INFO - Running setup.py (path:/tmp/pip-k4Ub47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:25 INFO - Running setup.py (path:/tmp/pip-4jR5YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:25 INFO - Running setup.py (path:/tmp/pip-QVprPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:25 INFO - Running setup.py (path:/tmp/pip-NL_Sw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:25 INFO - Running setup.py (path:/tmp/pip-OJsvbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:25 INFO - Running setup.py (path:/tmp/pip-dOsz8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:25 INFO - Running setup.py (path:/tmp/pip-hlc4B8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:25 INFO - Running setup.py (path:/tmp/pip-hgHuDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:25 INFO - Running setup.py (path:/tmp/pip-lSPDv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:26 INFO - Running setup.py (path:/tmp/pip-2NxvGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:26 INFO - Running setup.py (path:/tmp/pip-lUyOfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:26 INFO - Running setup.py (path:/tmp/pip-pUR9y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:26 INFO - Running setup.py install for manifestparser 04:11:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:26 INFO - Running setup.py install for mozcrash 04:11:26 INFO - Running setup.py install for mozdebug 04:11:26 INFO - Running setup.py install for mozdevice 04:11:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:26 INFO - Running setup.py install for mozfile 04:11:26 INFO - Running setup.py install for mozhttpd 04:11:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:26 INFO - Running setup.py install for mozinfo 04:11:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:26 INFO - Running setup.py install for mozInstall 04:11:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:27 INFO - Running setup.py install for mozleak 04:11:27 INFO - Running setup.py install for mozlog 04:11:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:27 INFO - Running setup.py install for moznetwork 04:11:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:27 INFO - Running setup.py install for mozprocess 04:11:27 INFO - Running setup.py install for mozprofile 04:11:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:27 INFO - Running setup.py install for mozrunner 04:11:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:27 INFO - Running setup.py install for mozscreenshot 04:11:27 INFO - Running setup.py install for moztest 04:11:27 INFO - Running setup.py install for mozversion 04:11:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:28 INFO - Cleaning up... 04:11:28 INFO - Return code: 0 04:11:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:28 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')]} 04:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:28 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')]} 04:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:28 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 0x9ee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5bb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:28 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 04:11:28 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 04:11:28 INFO - Using env: {'DISPLAY': ':0', 04:11:28 INFO - 'HOME': '/home/cltbld', 04:11:28 INFO - 'LANG': 'en_US.UTF-8', 04:11:28 INFO - 'LANGUAGE': 'en_US:en', 04:11:28 INFO - 'LOGNAME': 'cltbld', 04:11:28 INFO - 'MAIL': '/var/mail/cltbld', 04:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:28 INFO - 'MOZ_NO_REMOTE': '1', 04:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:28 INFO - 'NO_EM_RESTART': '1', 04:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:28 INFO - 'PWD': '/builds/slave/test', 04:11:28 INFO - 'SHELL': '/bin/bash', 04:11:28 INFO - 'SHLVL': '1', 04:11:28 INFO - 'TERM': 'linux', 04:11:28 INFO - 'TMOUT': '86400', 04:11:28 INFO - 'USER': 'cltbld', 04:11:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:28 INFO - '_': '/tools/buildbot/bin/python'} 04:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:28 INFO - Running setup.py (path:/tmp/pip-w28uUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:28 INFO - Running setup.py (path:/tmp/pip-0vaMmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:28 INFO - Running setup.py (path:/tmp/pip-KeWISn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:28 INFO - Running setup.py (path:/tmp/pip-iqu0Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:28 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)) 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:28 INFO - Running setup.py (path:/tmp/pip-h1HC6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:28 INFO - Running setup.py (path:/tmp/pip-V6XPR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:28 INFO - Running setup.py (path:/tmp/pip-aG1OmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:28 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)) 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:28 INFO - Running setup.py (path:/tmp/pip-Wpf755-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:28 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)) 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:28 INFO - Running setup.py (path:/tmp/pip-iZjL6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:28 INFO - Running setup.py (path:/tmp/pip-6HKMZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:28 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)) 04:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:28 INFO - Running setup.py (path:/tmp/pip-hjPw82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:29 INFO - Running setup.py (path:/tmp/pip-0oZp6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:29 INFO - Running setup.py (path:/tmp/pip-V3XeIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:29 INFO - Running setup.py (path:/tmp/pip-nbB645-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:29 INFO - Running setup.py (path:/tmp/pip-u9PXll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:29 INFO - Running setup.py (path:/tmp/pip-a5k5qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:29 INFO - Running setup.py (path:/tmp/pip-8lm0nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): 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)) 04:11:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:30 INFO - Downloading blessings-1.6.tar.gz 04:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:11:30 INFO - Installing collected packages: blessings 04:11:30 INFO - Running setup.py install for blessings 04:11:30 INFO - Successfully installed blessings 04:11:30 INFO - Cleaning up... 04:11:30 INFO - Return code: 0 04:11:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:31 INFO - Reading from file tmpfile_stdout 04:11:31 INFO - Current package versions: 04:11:31 INFO - argparse == 1.2.1 04:11:31 INFO - blessings == 1.6 04:11:31 INFO - blobuploader == 1.2.4 04:11:31 INFO - docopt == 0.6.1 04:11:31 INFO - functools32 == 3.2.3-2 04:11:31 INFO - jsonschema == 2.5.1 04:11:31 INFO - manifestparser == 1.1 04:11:31 INFO - mozInstall == 1.13 04:11:31 INFO - mozcrash == 1.0 04:11:31 INFO - mozdebug == 0.1 04:11:31 INFO - mozdevice == 0.51 04:11:31 INFO - mozfile == 1.2 04:11:31 INFO - mozhttpd == 0.7 04:11:31 INFO - mozinfo == 0.10 04:11:31 INFO - mozleak == 0.1 04:11:31 INFO - mozlog == 3.5 04:11:31 INFO - moznetwork == 0.27 04:11:31 INFO - mozprocess == 0.25 04:11:31 INFO - mozprofile == 0.28 04:11:31 INFO - mozrunner == 6.13 04:11:31 INFO - mozscreenshot == 0.1 04:11:31 INFO - mozsystemmonitor == 0.3 04:11:31 INFO - moztest == 0.8 04:11:31 INFO - mozversion == 1.4 04:11:31 INFO - psutil == 3.1.1 04:11:31 INFO - requests == 1.2.3 04:11:31 INFO - wsgiref == 0.1.2 04:11:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:31 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')]} 04:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:31 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')]} 04:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:31 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 0x9ee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5bb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:31 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 04:11:31 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 04:11:31 INFO - Using env: {'DISPLAY': ':0', 04:11:31 INFO - 'HOME': '/home/cltbld', 04:11:31 INFO - 'LANG': 'en_US.UTF-8', 04:11:31 INFO - 'LANGUAGE': 'en_US:en', 04:11:31 INFO - 'LOGNAME': 'cltbld', 04:11:31 INFO - 'MAIL': '/var/mail/cltbld', 04:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:31 INFO - 'MOZ_NO_REMOTE': '1', 04:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:31 INFO - 'NO_EM_RESTART': '1', 04:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:31 INFO - 'PWD': '/builds/slave/test', 04:11:31 INFO - 'SHELL': '/bin/bash', 04:11:31 INFO - 'SHLVL': '1', 04:11:31 INFO - 'TERM': 'linux', 04:11:31 INFO - 'TMOUT': '86400', 04:11:31 INFO - 'USER': 'cltbld', 04:11:31 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:31 INFO - '_': '/tools/buildbot/bin/python'} 04:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:11:31 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:11:32 INFO - Installing collected packages: simplejson 04:11:32 INFO - Running setup.py install for simplejson 04:11:32 INFO - building 'simplejson._speedups' extension 04:11:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:11:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:11:33 INFO - Successfully installed simplejson 04:11:33 INFO - Cleaning up... 04:11:33 INFO - Return code: 0 04:11:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:11:33 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')]} 04:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:33 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')]} 04:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:33 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 0x9ee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbbaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5bb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:33 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 04:11:33 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 04:11:33 INFO - Using env: {'DISPLAY': ':0', 04:11:33 INFO - 'HOME': '/home/cltbld', 04:11:33 INFO - 'LANG': 'en_US.UTF-8', 04:11:33 INFO - 'LANGUAGE': 'en_US:en', 04:11:33 INFO - 'LOGNAME': 'cltbld', 04:11:33 INFO - 'MAIL': '/var/mail/cltbld', 04:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:33 INFO - 'MOZ_NO_REMOTE': '1', 04:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:33 INFO - 'NO_EM_RESTART': '1', 04:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:33 INFO - 'PWD': '/builds/slave/test', 04:11:33 INFO - 'SHELL': '/bin/bash', 04:11:33 INFO - 'SHLVL': '1', 04:11:33 INFO - 'TERM': 'linux', 04:11:33 INFO - 'TMOUT': '86400', 04:11:33 INFO - 'USER': 'cltbld', 04:11:33 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:33 INFO - '_': '/tools/buildbot/bin/python'} 04:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:11:33 INFO - Cleaning up... 04:11:33 INFO - Return code: 0 04:11:33 INFO - Running post-action listener: _resource_record_post_action 04:11:33 INFO - Running post-action listener: _start_resource_monitoring 04:11:33 INFO - Starting resource monitoring. 04:11:33 INFO - [mozharness: 2017-08-14 11:11:33.732100Z] Finished create-virtualenv step (success) 04:11:33 INFO - [mozharness: 2017-08-14 11:11:33.732559Z] Running install step. 04:11:33 INFO - Running pre-action listener: _resource_record_pre_action 04:11:33 INFO - Running main action method: install 04:11:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:33 INFO - Reading from file tmpfile_stdout 04:11:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:11:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:11:34 INFO - Reading from file tmpfile_stdout 04:11:34 INFO - Output received: 04:11:34 INFO - Usage: mozinstall [options] installer 04:11:34 INFO - Options: 04:11:34 INFO - -h, --help show this help message and exit 04:11:34 INFO - -d DEST, --destination=DEST 04:11:34 INFO - Directory to install application into. [default: 04:11:34 INFO - "/builds/slave/test"] 04:11:34 INFO - --app=APP Application being installed. [default: firefox] 04:11:34 INFO - mkdir: /builds/slave/test/build/application 04:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:11:51 INFO - Reading from file tmpfile_stdout 04:11:51 INFO - Output received: 04:11:51 INFO - /builds/slave/test/build/application/firefox/firefox 04:11:51 INFO - Running post-action listener: _resource_record_post_action 04:11:51 INFO - [mozharness: 2017-08-14 11:11:51.841260Z] Finished install step (success) 04:11:51 INFO - [mozharness: 2017-08-14 11:11:51.841476Z] Running setup-mitmproxy step. 04:11:51 INFO - Running pre-action listener: _resource_record_pre_action 04:11:51 INFO - Running main action method: setup_mitmproxy 04:11:51 INFO - Skipping: mitmproxy is not required 04:11:51 INFO - Running post-action listener: _resource_record_post_action 04:11:51 INFO - [mozharness: 2017-08-14 11:11:51.842619Z] Finished setup-mitmproxy step (success) 04:11:51 INFO - [mozharness: 2017-08-14 11:11:51.842852Z] Running run-tests step. 04:11:51 INFO - Running pre-action listener: _resource_record_pre_action 04:11:51 INFO - Running pre-action listener: _set_gcov_prefix 04:11:51 INFO - Running main action method: run_tests 04:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:11:51 INFO - Python 2.7.3 04:11:51 INFO - Return code: 0 04:11:51 INFO - grabbing minidump binary from tooltool 04:11:51 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')]} 04:11:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5ef00>, '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 0xd59ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5a050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:11:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:11:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:11:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:11:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:11:51 INFO - Return code: 0 04:11:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:11:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:11:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:11:51 INFO - ENV: RUST_BACKTRACE is now full 04:11:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:11:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:11:51 INFO - Using env: {'DISPLAY': ':0', 04:11:51 INFO - 'HOME': '/home/cltbld', 04:11:51 INFO - 'LANG': 'en_US.UTF-8', 04:11:51 INFO - 'LANGUAGE': 'en_US:en', 04:11:51 INFO - 'LOGNAME': 'cltbld', 04:11:51 INFO - 'MAIL': '/var/mail/cltbld', 04:11:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:11:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:51 INFO - 'MOZ_NO_REMOTE': '1', 04:11:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:51 INFO - 'NO_EM_RESTART': '1', 04:11:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:51 INFO - 'PWD': '/builds/slave/test', 04:11:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:11:51 INFO - 'RUST_BACKTRACE': 'full', 04:11:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:11:51 INFO - 'SHELL': '/bin/bash', 04:11:51 INFO - 'SHLVL': '1', 04:11:51 INFO - 'TERM': 'linux', 04:11:51 INFO - 'TMOUT': '86400', 04:11:51 INFO - 'USER': 'cltbld', 04:11:51 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308', 04:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:51 INFO - '_': '/tools/buildbot/bin/python'} 04:11:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:11:52 INFO - mozversion application_buildid: 20170814095311 04:11:52 INFO - mozversion application_changeset: f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf 04:11:52 INFO - mozversion application_display_name: Nightly 04:11:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:11:52 INFO - mozversion application_name: Firefox 04:11:52 INFO - mozversion application_remotingname: firefox 04:11:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:11:52 INFO - mozversion application_vendor: Mozilla 04:11:52 INFO - mozversion application_version: 57.0a1 04:11:52 INFO - mozversion platform_buildid: 20170814095311 04:11:52 INFO - mozversion platform_changeset: f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf 04:11:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:11:52 INFO - mozversion platform_version: 57.0a1 04:11:52 INFO - using testdate: 1502709112 04:11:52 INFO - actual date: 1502709112 04:11:52 INFO - starting webserver on 'localhost:57153' 04:11:52 INFO - SUITE-START | Running 2 tests 04:11:52 INFO - TEST-START | dromaeo_css 04:11:52 INFO - Initialising browser for dromaeo_css test... 04:11:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57153/getInfo.html -profile /tmp/tmp65lkn1/profile 04:11:52 INFO - TEST-INFO | started process 4821 (/builds/slave/test/build/application/firefox/firefox http://localhost:57153/getInfo.html) 04:11:58 INFO - TEST-INFO | 4821: exit 0 04:11:58 INFO - Browser initialized. 04:11:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:11:58 INFO - TEST-INFO | started process 5031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65lkn1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:59 INFO - PID 5031 | 04:11:59 INFO - PID 5031 | (/builds/slave/test/build/application/firefox/firefox:5079): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:11:59 INFO - PID 5031 | 04:12:09 INFO - PID 5031 | RSS: Main: 161783808 04:12:09 INFO - PID 5031 | 04:15:08 INFO - PID 5031 | Cycle 1(1): loaded http://localhost:57153/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57153/tests/dromaeo/cssquery-ext.html) 04:15:09 INFO - PID 5031 | RSS: Main: 166838272 04:15:09 INFO - PID 5031 | 04:18:10 INFO - PID 5031 | Cycle 1(1): loaded http://localhost:57153/tests/dromaeo/cssquery-ext.html (next: http://localhost:57153/tests/dromaeo/cssquery-jquery.html) 04:18:11 INFO - PID 5031 | RSS: Main: 163471360 04:18:11 INFO - PID 5031 | 04:21:12 INFO - PID 5031 | Cycle 1(1): loaded http://localhost:57153/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57153/tests/dromaeo/cssquery-mootools.html) 04:21:13 INFO - PID 5031 | RSS: Main: 165265408 04:21:13 INFO - PID 5031 | 04:24:15 INFO - PID 5031 | Cycle 1(1): loaded http://localhost:57153/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57153/tests/dromaeo/cssquery-prototype.html) 04:24:15 INFO - PID 5031 | RSS: Main: 164171776 04:24:15 INFO - PID 5031 | 04:27:19 INFO - PID 5031 | Cycle 1(1): loaded http://localhost:57153/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57153/tests/dromaeo/cssquery-yui.html) 04:27:19 INFO - PID 5031 | RSS: Main: 167886848 04:27:19 INFO - PID 5031 | 04:30:21 INFO - PID 5031 | Cycle 1(1): loaded http://localhost:57153/tests/dromaeo/cssquery-yui.html (next: http://localhost:57153/tests/dromaeo/cssquery-dojo.html) 04:30:21 INFO - PID 5031 | RSS: Main: 168361984 04:30:21 INFO - PID 5031 | 04:30:21 INFO - PID 5031 | __start_tp_report 04:30:21 INFO - PID 5031 | _x_x_mozilla_page_load 04:30:21 INFO - PID 5031 | _x_x_mozilla_page_load_details 04:30:21 INFO - PID 5031 | |i|pagename|runs| 04:30:21 INFO - PID 5031 | |0;dojo.html;3463.5670541182353;3495.283466889288;3504.9649503504966;3531.50558921751;3535.0455377048215;6162.630242185472;6166.506679465643;6217.067439884014;6244.625322480654;6253.405926436987;6192.566520343577;6248.781292654758;6250.281217659959;6253.218347706536;6256.874862502758;5436.374816896068;5447.019536483432;5458.426865179149;5458.754356053987;5466.098093814516;5529.225908372831;5585.134304182838;5590.496855283024;5604.551635869121;5646.887062258752;5493.423190564973;5563.082091454905;5568.888622227553;5607.355154157263;5641.069223578104;5364.946350536484;5410.756515956791;5415.0523658359625;5467.5625949923915;5550.028744969654;5443.319585051869;5464.371597266326;5509.449055094498;5531.557475401958;5533.916991245134;6165.630062196283;6193.5045196384635;6226.159468471744;6249.656268905208;6269.62382257066;6808.455323574102;6814.761483348108;6851.314868513158;6879.6216208108535;6885.414739747128;6871.4502839772695;6873.20958089821;6940.201876784184;6969.2682268362105;6970.860582788367;6353.237611486651;6360.872782544323;6413.390727880844;6425.7750978715985;6448.903266451054;6823.28355522663;6909.1018167637885;6923.757668481579;6984.79045628632;7021.859562808715;6694.062831203635;6745.5952642841585;6773.966130169416;6777.796666100025;6783.660816959133;6725.6973436195485;6791.694373753193;6841.076454678555;6876.724931002704;6879.724811007503;6718.093057437183;6747.865042699119;6797.864042719118;6798.116244888231;6806.897896531556;6803.217629972518;6836.4530837532875;6862.656867156722;6874.896876546856;6878.58728476293;4847.175980083394;4856.077345304381;4913.140200464904;4915.336429582032;4938.728369939688;4325.870223893288;4343.087951530151;4346.261135606955;4366.868993930188;4458.643308535309;6407.615543067431;6447.387498187664;6451.806445806634;6468.611883287018;6482.708278127496;6749.257581666013;6760.492963027793;6790.626515541692;6859.348361905611;6864.485163612749;6257.342978987232;6331;6354.491640668735;6388.84027899297;6438.967805160944;5459;5496.1755736639825;5518.227448157261;5524;5526.944730552643;7132.286771322826;7132.28677132293;7214.134303883568;7218.133823941055;7220.602866842269;6482.546221764431;6817;6820.113385259884;6822.3859852613505;6905.136857892763;7103;7112.395446387115;7114.608696521741;7121.501494895308;7122.893156602759;6645.036469711961;6689.163854518185;6692.230393504809;6695.698693558899;6739.258681545124;6825.52221344521;6866;6942.06282151903;6945.861082778417;6971.755988540377;6600.669966501559;6604.768833090819;6661.800145995628;6689.46484281266;6696.330366963265;6547.377999090078;6607.372299631527;6640.402363787282;6641.568298060611;6661.900071498834;6604.471642268511;6620.106285651375;6656.36764507371;6686.465082793462;6727.798166055026;6620.834479137868;6653.933460665331;6744.0895479109695;6749.73001079971;6754.93245067543;6278.874422511615;6348.079528468438;6372.171617689671;6454.0641606967665;6469.45009674183 04:30:21 INFO - PID 5031 | |1;ext.html;910.5856835140012;916.5737931861687;947.7346343023953;973.6884197056941;974.5955428497174;42003.57996420035;43882.34176487351;43931.12137757251;43947.78026109869;44129.33805992913;41752.58247417525;42050.369244461355;42083.15833683324;42119.78940105303;42122.57877421225;7134.678939447737;7244.311790379906;7244.746433874815;7246.058012458373;7247;7087.468439867005;7193.42452603793;7194.208637049946;7197.460190485708;7197.856042879139;7109.289071092901;7175.677094530733;7199.640017999105;7202.279772022808;7202.963985180067;7125;7126.679299431512;7131.46514011446;7138.072050633436;7139.964300178492;6611.900821487681;6652.767153149665;6658.201015878077;6661.533692641517;6672.099266598995;35809.82095089534;36070.819645901865;36096;36132.63867361319;36214.45678314827;3362.8822991195434;3365.394229038772;3397.184675677844;3397.69420752131;3398.065531978701;28040.85979570089;28337.149885503466;28392.574111388345;28393.29016774597;28432.715672843213;4584.747838868894;4707.45864225615;4711.1519926413575;4715.127701375222;4742.3123647071325;207678;208811;211099;214289;220535;54153.45846541484;54409.45590544123;54428.72785636046;54521.45478545243;54650.453495464535;56695.716521417955;56852.43147568554;57016;57041;57108;16128.75806862898;16234;16235.59411014734;16248.512544623443;17000.48998530046;13878.791818122736;13881.652958676113;13891.513797017056;13951.372188251553;13961.86038139626;15024.79801615868;15026.549203523911;15155.924220378827;15163.924180379248;15234.619134521505;5994.610350327215;5997.850053748692;6013.248343957005;6062.272527296753;6096.177016102769;1065.1159537583787;1093.912487001054;1097.078454098561;1101.3336931156696;1105.160078340467;24531.63202551963;24603.261902142964;24920.37699057538;24967.875160624444;24987;1185.25921299188;1198.9820152697716;1203.843500344967;1205.8854408831146;1207.0404028796952;13081.476740930257;13158.868411315956;13210.669733256553;13220.206787592775;13247.271400072896;264998;265644;266796;267740;267830;57816.42183578195;57887;57925.42074579284;58003.12995305074;58103.41896581065;1518.4533567915541;1533.7929379533844;1556.533040087969;1558.3299181351902;1565.0687840734745;24813.00747970061;29345.559816603196;30198.396032079676;30200;30729.231769205948;55015.44984550103;55064.44935550593;55281.44718552763;55318.170227445815;55383.44616553944;236804;239622;239681;239720;240110;36362.27275454423;36454;36775.448368275036;39895.60104398919;40276.597234027286;50986.23520647267;51145.7442712784;51363.743181283855;51435;52213.21680174724;36539.26921461503;36703.265934681694;36733;36753.08117296982;37279.81360093182;36054.4591831128;36274.455883161245;36546.451803222444;36831.44752828763;36875.63124368722;42486;43377.783111084245;43484.78257608818;43795.78102109469;43886.12227755491;36099;36211.45682814707;36276.638119896015;36329.81835090808;36473.27053458863;26888.193354199404;27048;27374.041908533105;27392.58911116295;27576.724232757417 04:30:21 INFO - PID 5031 | |2;jquery.html;576.4638885836171;578.878435528539;579.869529355895;588.273482249422;597.9461848433641;23036.539269214605;23764.16825411111;24551.75448245519;24569.877150614266;24588.631170532433;26406.867965660145;26696.19911402656;26955.86522067387;26966.325841853963;26971.190864274053;6433.09936608874;6557.704903279364;6562.606243625398;6565.441937435324;6570.967145164267;5906.852328691774;6378.4578310843635;6418.550701450877;6435.6782160892;6453.645049522274;6390.3609639036185;6391.392817682336;6393.840153996164;6395.648239346834;6401.16784817973;6386.07401926718;6387.5209359298005;6387.840303992414;6388.584741991779;6396.008618664115;5951.851203719942;5953.613015154045;5955.3151387590115;5955.34491205967;5968.31364393096;30215.697843021728;30900;30920.536191957137;30974.0707778767;31309.8434507826;2212.148322895681;2253.43664083979;2255.7969782719633;2256.0750092462013;2258.5144193998367;20062.297819576244;20554.38336849897;20559.5888082239;20615.38153855387;20661.79338206614;2434.8417352872007;2474.74015228402;2497.3756560859783;2530.93672658185;2591.740825917412;160865.19567402205;163182.18408908;163406;163812;164653;15229.466968656045;16008.919955400148;16100.470455306728;16164.838351616569;16269.67460650804;24222.273331800076;24276.757232427804;24280.392990175034;24286.14998475045;24374.39064023378;9656.37233579815;9918.30571859963;10051.949740251252;10282.383057016454;10520.158387328995;9186.86219706705;9206.76983075415;9213.585388657526;9254.213391861767;9325.114114159143;8492.702755403654;9455.52722363879;9674.613885140145;9756.170725488271;9830.262730295257;2660.2551285639665;2732.8087033907436;2745.341118131634;2747;2848.3875966667265;999.980000399988;1029.1355261580309;1031.4631199512671;1031.5873650539695;1047.8585390972273;20552.486187845425;20847.687284690743;20982.2656207032;21007.15971361159;21311.78688213129;1094.0591091661165;1098.9670309890716;1109.916756243285;1111.0556027376665;1119.8768135505088;11473.139514536444;11826.467808948619;11858.347790871412;11863.228890122115;11944.223625464318;532956;543666;552445;552723;554764;133484.33257833842;134119.32940335432;134218;134623.32688336496;135461;1235.6478403655094;1250.7811133051862;1264.5700461843016;1274.2609286613927;1275.152023904112;18455.07724613791;18744.250229991194;18753.812461875208;18771.155298011894;18911.810881891004;59377.21868343957;59736;60367.69816150891;60638.39361606504;61058.694706526185;76239.23760762322;76450;77032.2296777025;77336.22663773515;77629.61185194038;14634.487792927197;14815.18516481604;14815.777763333774;14837.554873353816;14891.106533608017;23650.29049128529;23683.881580591988;23975.52048959046;23975.76024239805;24060.759392405853;19112.713309300092;19234;19290.131944062832;19345.61308773845;19574.706379404037;16101.686453455133;16681.916590417455;16990.660186795947;17018;17408.912955435142;18531.536711582317;18678.439646810617;18778.436646900616;18807.247710091444;18888;14230.857691423367;14416.42334306616;14459.421623134956;14471.421143154155;14567.198804065454;18373.448796536126;18469;18511.444656660322;18548.258069677602;18633.254669813057 04:30:21 INFO - PID 5031 | |3;mootools.html;1420.75847105992;1447.3920953199656;1458.7009663019082;1461.101422625086;1466.516049703598;15385;15823.287952042157;16414.507564773077;16457.259423325948;16518;16515.66968660626;16845.91577042116;16873.915630421863;16887.24007419666;16944.576385590368;2558.7441255874355;2620.6069089636517;2682.061278552501;2683.597460380939;2684.0471632570448;2721.9591706124424;2751.119641714652;2755.6279902213146;2757.2555410039276;2758.089830355978;2441.426264827773;2473.727889932106;2483.4784695214025;2560.0655760647323;2570.3445621366527;2624.5144648240043;2632.9605055924176;2649.337665583604;2649.417128231786;2657.322382792395;2540.187140115164;2552.1067626330823;2578.6647735794413;2580.342012786746;2624.7637712605956;15767.29047192879;16052.197390130446;16079.11564863932;16110.919445402698;16114.75827862583;8112.6349314280405;8346.332293416512;8372.16278372164;8419.410641255115;8421.663133474654;5038.496150384969;5167.819126330561;5225.399079105913;5246.501582349671;5285.180796976437;1927.9036048197675;1950.71714601382;1952.2971730177126;1952.8256645787026;1991.1836147179731;28101.29746756327;28337.574936375764;28338.716612833814;28345.57481637777;28363.432731345463;7210.387117095001;7253.419726421874;7346.706131754777;7356.117265928123;7400.740974065882;18990.810091898904;19000;19034;19040.238390464503;19111.23555057782;8232.917670823335;8522.403431759842;8533.53065581399;8539.231469167804;8549.572521374032;6624.27133015368;6820.283870193657;7061.858762824818;7073.646317684095;7894.960525197337;5259.710715910585;5480.3971563128025;5483.670979741229;5522.944770552243;5586.776528938878;1546.6829299993474;1548.4116035906509;1566.749320108777;1568.090507505644;1590.5943984284165;936.9906300936904;961.8076384723083;962.3696478806393;976.3360914578013;978.7455261632027;8414.873776893352;8504.489730616182;8513.574321283912;8521.44610600309;8569.95715021421;703.2791388826494;705.8835292176733;726.3535453446436;742.0872327037774;750.7484992527455;4925.679830811057;5041.823536176216;5549.19536667181;5620.353659329229;5925.170476133345;21588.89205553962;23753.40616484567;24117.51764964726;24137.396565086012;24248.272551823473;22845.543089138126;23142.884285578803;23563.293101206993;23739.643905341432;23761.287161385186;12166.087543434101;12199.756004879853;12415.379231038412;12453.688657783447;12476.064295177897;8947.642094316154;9557.085089047629;9614.471204083842;9682;9840.950795246265;20620.27829025977;21033.789662103183;21126.366209013755;21130.260440884496;21364.465888352915;21091;21457.14171433125;21571;21794.782052179275;21884.89057554702;13393.330333483482;13709.383077761724;13711.245881476614;13712.52006179779;13714;14875.47935822241;15188.772168417261;15311.540653780405;15312;15332.923335383251;12479.939205167298;12481.56314528987;12500.687482813002;12783.87216127864;12899.226046437243;11582.71043223926;12196.390180491117;12243.632691019284;12294.323812190416;12440.626781196579;10799.946000269949;10802.08182304513;10898;10944.890551094388;10962.232643714864;8004.159563245776;8013.879791803244;8056.879146812686;8285.83428331418;8289.544075075928;8299.543525106177;8310.667573297;8350.540720260444;8359.164083591591;8392.32861371101 04:30:21 INFO - PID 5031 | |4;prototype.html;504.77789772500097;508.1919747601311;532.6857154278974;540.1357827476037;542.5496837624771;6195;6209.9068513972325;6246.5315101367405;6257.71840267188;6293.496520278378;5899.705014749266;6038.698065096739;6046.8488287792825;6074.787382441605;6154.87690246196;4806.279058141289;4820.445648750404;4824.4210694716685;4842.44311904132;4853.320535125068;4741.454732705749;4766;4775.474697783241;4792.161371759946;4813.927791083137;4796.856094317176;4797.208460603996;4823.589994850425;4837.7339246341435;4850.830220942268;4829.613630909536;4831.734254615994;4832.154372984731;4847.418309802811;4898.779554920037;4314.201872653569;4335.783210839477;4356.411884395598;4374.4531933508315;4379.781010949439;5998.340182579913;6053.667048312341;6057.697115144269;6098.878022439526;6136.263648362181;5694.6867922264255;5768.384852241337;5797.623154494944;5844.211031510734;5880.382559831199;6480.189976252968;6544.280129185786;6593.967030164867;6621.801345959629;6661.134052573183;4926.5812405945535;4949.876253093666;4983.9252411213865;4986.252062190664;4988.152014157602;6877.449804015717;6920.792376228621;6951.6871740771285;6976.604679064208;7052.788416347517;5020.171671674206;5024.196128619404;5027.874303142451;5047.974760126176;5097.541221290102;5133.743312834344;5135.820246291362;5183.481651834786;5188.325517682677;5200.401953775364;5686.232358631614;5751;5778.162166485836;5804.390538993429;5866.765329386777;6475.287718350977;6518.739250430024;6530;6547.9017814732815;6577;1697.9745303820453;1731.1690388613536;1733.956651083733;1737.1053907237783;1767.7967033791278;1222.9694257643453;1239.1945235596934;1248.9875101248872;1252.1798222164498;1255;6206.255249370014;6209.565330426917;6244.344343843922;6281.968590157111;6343.397377249154;6544.723778863076;6654.434373078343;6692.293465166352;6744.482491439485;6753.797386078426;6205.47253483459;6349.714262858182;6350.396712312323;6352.823588205897;6366.9681651591445;3552.6802587767224;3586.336527742324;3610.494530765695;3615.7468977171347;3632.9091772705365;7115.4105601886495;7122.964385178041;7125.928740712527;7167.319104685047;7179.317964793337;6895.482838787111;6932.480063995221;6947.444204463631;6976.51164418496;6983.89524157138;7101.325374089453;7105.360517553445;7121.67952442131;7128;7157.320054594805;6748.561343512656;6818.249992500921;6822.795316140524;6833.897491537531;6853.417459515997;6661.666916654245;6665.366790154928;6698.799036028927;6698.866022679616;6702.497312701469;6834.282400347892;6907.861842763217;6986.790396288119;7017.157941047107;7103.183133939663;5024.974875125601;5031.987205117982;5036.269740887624;5069;5076.213186956028;6458.289588145394;6683.164604424447;6706.329367063255;6727.192736871607;6787.185537735306;6174.351693072343;6399.232092148972;6399.55203135776;6402.615843049246;6575.868482630225;6361.936380636134;6373.864755307024;6395.296517383177;6402.6158430494315;6541.6075035498025;6419.876521608793;6430.967845160932;6452.451541619015;6534.869302614016;6579.111819904251;6445.2265728112925;6449.419552240321;6485.416312531895;6487.448566871869;6578.756701927326;6243.562950593415;6252.999520076766;6283.2774230962195;6338.809835704937;6338.936610633835 04:30:21 INFO - PID 5031 | |5;yui.html;941.9717408477748;952.190637957736;973.5132433783108;981.0581841432224;982.6167794560121;18061;18737;18767.812321876794;21041;21487.785122148773;19855.205791768312;20506.2822801202;20558.794412055875;20582.794172058275;20590.1763929443;1073.4310815267902;1092.901638852503;1098.8132017557034;1099.912007039435;1100.0759362135805;1008.6246888577405;1088.570014844136;1088.842117892905;1094.2996482251365;1102.597551893561;1141.0757286597882;1152.2107356460808;1153.117864833403;1153.3829401270323;1153.5155234801362;1134.1720544002883;1140.7832511822728;1145.1869172887218;1146.2033886448921;1146.9885301146965;830.5722552885269;835.1272919798824;836.3016880904452;840.5755093677715;842.5702891525304;20114.39656810298;20385.898070509553;20749.066292016745;21230.469238269012;21368.145274189013;20477.692834607344;20540;20888.5822283555;21747.782522174733;21962.231321903815;16764.580885477837;17064.658706825918;17179.742303865452;17246.65506689872;17384.652306953918;3714.1086139326635;3745.02629316377;3746.344389731786;3746.5691445483844;3747.45661879026;141194;146318;147197;150168;154711;16629.83370166283;16764.664706705797;16921.153942302837;17028.829711702725;17039.31842726277;27862.5820612691;28257.43485130286;28982.27544311409;29049.12852614425;29160.85419572931;9172.31207659415;9279.628814847465;9312.674056407994;9358.859617105749;9374.437533747998;4291.206126866539;4385.495667998221;4410.095930334273;4436.44544431946;4528.456585209796;5684.204211410406;5826.475617194473;5834.920539700169;5839.328477225174;5862.091375836752;1052.678932925465;1054.2409465185056;1060.9787804243872;1174.647605718281;1205.879412058787;713.0658836923543;744.3524134003452;744.4044764188627;762.2415696382135;768.2701433638066;12605.369731513387;12955.805662915063;13508.459661613426;13953.372098255602;14290.785638215435;732.571445704269;738.335498051747;757.7916073079837;763.091920614467;765.2271206081897;6207.720652570645;6338.334474880164;6436.613803171825;6450.741970321228;6474.967625161844;138699;142293.28853355875;145016.27491862472;145359.2732036354;147194;123943.38028309801;125142;125523.3723831375;128156;131900.3404982988;105867;105911;108583.45708271409;109267;110014.44992775146;13041.739165216453;13747.243901585109;13848.169109853441;13930.791038134234;14084.647883802578;50464.49535504598;51543.48456515387;51846.74076629593;52529.47470525246;53296.73351633217;87948;89319.55340223257;90301.54849225975;95732;96329.03670963201;20455.693164602246;20613.484662883548;20800.47998800042;21059.262925797524;21307.7869221312;20439.489012774204;20763.688544672143;20869;21121.128108981586;21415.464613384167;18407.631847363245;18527.444176674722;18628.068596569847;19313.51716207106;19734.50663733361;18245.54386140357;19225.807741922403;19356.903215484395;19443.70834437456;19529.414117576496;20328.390148295573;20578.58842823105;20813.479663008548;21778.891105545004;21796.237131700313;13930.164190148624;14048;14270.215138167501;14557.85442145565;14947.701045978802;14373.856261437251;14579.416823326948;14751.114933104049;15045.097294162386;15067.4726384576 04:30:21 INFO - PID 5031 | __end_tp_report 04:30:21 INFO - PID 5031 | __start_cc_report 04:30:21 INFO - PID 5031 | _x_x_mozilla_cycle_collect,345 04:30:21 INFO - PID 5031 | __end_cc_report 04:30:21 INFO - PID 5031 | __startTimestamp1502710221709__endTimestamp 04:30:21 INFO - PID 5031 | 04:30:21 INFO - PID 5031 | ------- Summary: start ------- 04:30:21 INFO - PID 5031 | Number of tests: 6 04:30:21 INFO - PID 5031 | 04:30:21 INFO - PID 5031 | [#0] dojo.html Cycles:165 Average:6245.73 Median:6600.67 stddev:826.07 (12.5%) stddev-sans-first:799.25 04:30:21 INFO - PID 5031 | Values: 3463.6 3495.3 3505.0 3531.5 3535.0 6162.6 6166.5 6217.1 6244.6 6253.4 6192.6 6248.8 6250.3 6253.2 6256.9 5436.4 5447.0 5458.4 5458.8 5466.1 5529.2 5585.1 5590.5 5604.6 5646.9 5493.4 5563.1 5568.9 5607.4 5641.1 5364.9 5410.8 5415.1 5467.6 5550.0 5443.3 5464.4 5509.4 5531.6 5533.9 6165.6 6193.5 6226.2 6249.7 6269.6 6808.5 6814.8 6851.3 6879.6 6885.4 6871.5 6873.2 6940.2 6969.3 6970.9 6353.2 6360.9 6413.4 6425.8 6448.9 6823.3 6909.1 6923.8 6984.8 7021.9 6694.1 6745.6 6774.0 6777.8 6783.7 6725.7 6791.7 6841.1 6876.7 6879.7 6718.1 6747.9 6797.9 6798.1 6806.9 6803.2 6836.5 6862.7 6874.9 6878.6 4847.2 4856.1 4913.1 4915.3 4938.7 4325.9 4343.1 4346.3 4366.9 4458.6 6407.6 6447.4 6451.8 6468.6 6482.7 6749.3 6760.5 6790.6 6859.3 6864.5 6257.3 6331.0 6354.5 6388.8 6439.0 5459.0 5496.2 5518.2 5524.0 5526.9 7132.3 7132.3 7214.1 7218.1 7220.6 6482.5 6817.0 6820.1 6822.4 6905.1 7103.0 7112.4 7114.6 7121.5 7122.9 6645.0 6689.2 6692.2 6695.7 6739.3 6825.5 6866.0 6942.1 6945.9 6971.8 6600.7 6604.8 6661.8 6689.5 6696.3 6547.4 6607.4 6640.4 6641.6 6661.9 6604.5 6620.1 6656.4 6686.5 6727.8 6620.8 6653.9 6744.1 6749.7 6754.9 6278.9 6348.1 6372.2 6454.1 6469.5 04:30:21 INFO - PID 5031 | 04:30:21 INFO - PID 5031 | [#1] ext.html Cycles:180 Average:42475.93 Median:36624.86 stddev:62593.65 (170.9%) stddev-sans-first:62691.44 04:30:21 INFO - PID 5031 | Values: 910.6 916.6 947.7 973.7 974.6 42003.6 43882.3 43931.1 43947.8 44129.3 41752.6 42050.4 42083.2 42119.8 42122.6 7134.7 7244.3 7244.7 7246.1 7247.0 7087.5 7193.4 7194.2 7197.5 7197.9 7109.3 7175.7 7199.6 7202.3 7203.0 7125.0 7126.7 7131.5 7138.1 7140.0 6611.9 6652.8 6658.2 6661.5 6672.1 35809.8 36070.8 36096.0 36132.6 36214.5 3362.9 3365.4 3397.2 3397.7 3398.1 28040.9 28337.1 28392.6 28393.3 28432.7 4584.7 4707.5 4711.2 4715.1 4742.3 207678.0 208811.0 211099.0 214289.0 220535.0 54153.5 54409.5 54428.7 54521.5 54650.5 56695.7 56852.4 57016.0 57041.0 57108.0 16128.8 16234.0 16235.6 16248.5 17000.5 13878.8 13881.7 13891.5 13951.4 13961.9 15024.8 15026.5 15155.9 15163.9 15234.6 5994.6 5997.9 6013.2 6062.3 6096.2 1065.1 1093.9 1097.1 1101.3 1105.2 24531.6 24603.3 24920.4 24967.9 24987.0 1185.3 1199.0 1203.8 1205.9 1207.0 13081.5 13158.9 13210.7 13220.2 13247.3 264998.0 265644.0 266796.0 267740.0 267830.0 57816.4 57887.0 57925.4 58003.1 58103.4 1518.5 1533.8 1556.5 1558.3 1565.1 24813.0 29345.6 30198.4 30200.0 30729.2 55015.4 55064.4 55281.4 55318.2 55383.4 236804.0 239622.0 239681.0 239720.0 240110.0 36362.3 36454.0 36775.4 39895.6 40276.6 50986.2 51145.7 51363.7 51435.0 52213.2 36539.3 36703.3 36733.0 36753.1 37279.8 36054.5 36274.5 36546.5 36831.4 36875.6 42486.0 43377.8 43484.8 43795.8 43886.1 36099.0 36211.5 36276.6 36329.8 36473.3 26888.2 27048.0 27374.0 27392.6 27576.7 04:30:21 INFO - PID 5031 | 04:30:21 INFO - PID 5031 | [#2] jquery.html Cycles:180 Average:38176.17 Median:23869.84 stddev:92856.25 (389.0%) stddev-sans-first:93073.82 04:30:21 INFO - PID 5031 | Values: 576.5 578.9 579.9 588.3 597.9 23036.5 23764.2 24551.8 24569.9 24588.6 26406.9 26696.2 26955.9 26966.3 26971.2 6433.1 6557.7 6562.6 6565.4 6571.0 5906.9 6378.5 6418.6 6435.7 6453.6 6390.4 6391.4 6393.8 6395.6 6401.2 6386.1 6387.5 6387.8 6388.6 6396.0 5951.9 5953.6 5955.3 5955.3 5968.3 30215.7 30900.0 30920.5 30974.1 31309.8 2212.1 2253.4 2255.8 2256.1 2258.5 20062.3 20554.4 20559.6 20615.4 20661.8 2434.8 2474.7 2497.4 2530.9 2591.7 160865.2 163182.2 163406.0 163812.0 164653.0 15229.5 16008.9 16100.5 16164.8 16269.7 24222.3 24276.8 24280.4 24286.1 24374.4 9656.4 9918.3 10051.9 10282.4 10520.2 9186.9 9206.8 9213.6 9254.2 9325.1 8492.7 9455.5 9674.6 9756.2 9830.3 2660.3 2732.8 2745.3 2747.0 2848.4 1000.0 1029.1 1031.5 1031.6 1047.9 20552.5 20847.7 20982.3 21007.2 21311.8 1094.1 1099.0 1109.9 1111.1 1119.9 11473.1 11826.5 11858.3 11863.2 11944.2 532956.0 543666.0 552445.0 552723.0 554764.0 133484.3 134119.3 134218.0 134623.3 135461.0 1235.6 1250.8 1264.6 1274.3 1275.2 18455.1 18744.3 18753.8 18771.2 18911.8 59377.2 59736.0 60367.7 60638.4 61058.7 76239.2 76450.0 77032.2 77336.2 77629.6 14634.5 14815.2 14815.8 14837.6 14891.1 23650.3 23683.9 23975.5 23975.8 24060.8 19112.7 19234.0 19290.1 19345.6 19574.7 16101.7 16681.9 16990.7 17018.0 17408.9 18531.5 18678.4 18778.4 18807.2 18888.0 14230.9 14416.4 14459.4 14471.4 14567.2 18373.4 18469.0 18511.4 18548.3 18633.3 04:30:21 INFO - PID 5031 | 04:30:21 INFO - PID 5031 | [#3] mootools.html Cycles:180 Average:10119.85 Median:2559.40 stddev:7397.70 (289.0%) stddev-sans-first:7389.59 04:30:21 INFO - PID 5031 | Values: 1420.8 1447.4 1458.7 1461.1 1466.5 15385.0 15823.3 16414.5 16457.3 16518.0 16515.7 16845.9 16873.9 16887.2 16944.6 2558.7 2620.6 2682.1 2683.6 2684.0 2722.0 2751.1 2755.6 2757.3 2758.1 2441.4 2473.7 2483.5 2560.1 2570.3 2624.5 2633.0 2649.3 2649.4 2657.3 2540.2 2552.1 2578.7 2580.3 2624.8 15767.3 16052.2 16079.1 16110.9 16114.8 8112.6 8346.3 8372.2 8419.4 8421.7 5038.5 5167.8 5225.4 5246.5 5285.2 1927.9 1950.7 1952.3 1952.8 1991.2 28101.3 28337.6 28338.7 28345.6 28363.4 7210.4 7253.4 7346.7 7356.1 7400.7 18990.8 19000.0 19034.0 19040.2 19111.2 8232.9 8522.4 8533.5 8539.2 8549.6 6624.3 6820.3 7061.9 7073.6 7895.0 5259.7 5480.4 5483.7 5522.9 5586.8 1546.7 1548.4 1566.7 1568.1 1590.6 937.0 961.8 962.4 976.3 978.7 8414.9 8504.5 8513.6 8521.4 8570.0 703.3 705.9 726.4 742.1 750.7 4925.7 5041.8 5549.2 5620.4 5925.2 21588.9 23753.4 24117.5 24137.4 24248.3 22845.5 23142.9 23563.3 23739.6 23761.3 12166.1 12199.8 12415.4 12453.7 12476.1 8947.6 9557.1 9614.5 9682.0 9841.0 20620.3 21033.8 21126.4 21130.3 21364.5 21091.0 21457.1 21571.0 21794.8 21884.9 13393.3 13709.4 13711.2 13712.5 13714.0 14875.5 15188.8 15311.5 15312.0 15332.9 12479.9 12481.6 12500.7 12783.9 12899.2 11582.7 12196.4 12243.6 12294.3 12440.6 10799.9 10802.1 10898.0 10944.9 10962.2 8004.2 8013.9 8056.9 8285.8 8289.5 8299.5 8310.7 8350.5 8359.2 8392.3 04:30:21 INFO - PID 5031 | 04:30:21 INFO - PID 5031 | [#4] prototype.html Cycles:180 Average:5573.20 Median:6226.73 stddev:1595.76 (25.6%) stddev-sans-first:1554.23 04:30:21 INFO - PID 5031 | Values: 504.8 508.2 532.7 540.1 542.5 6195.0 6209.9 6246.5 6257.7 6293.5 5899.7 6038.7 6046.8 6074.8 6154.9 4806.3 4820.4 4824.4 4842.4 4853.3 4741.5 4766.0 4775.5 4792.2 4813.9 4796.9 4797.2 4823.6 4837.7 4850.8 4829.6 4831.7 4832.2 4847.4 4898.8 4314.2 4335.8 4356.4 4374.5 4379.8 5998.3 6053.7 6057.7 6098.9 6136.3 5694.7 5768.4 5797.6 5844.2 5880.4 6480.2 6544.3 6594.0 6621.8 6661.1 4926.6 4949.9 4983.9 4986.3 4988.2 6877.4 6920.8 6951.7 6976.6 7052.8 5020.2 5024.2 5027.9 5048.0 5097.5 5133.7 5135.8 5183.5 5188.3 5200.4 5686.2 5751.0 5778.2 5804.4 5866.8 6475.3 6518.7 6530.0 6547.9 6577.0 1698.0 1731.2 1734.0 1737.1 1767.8 1223.0 1239.2 1249.0 1252.2 1255.0 6206.3 6209.6 6244.3 6282.0 6343.4 6544.7 6654.4 6692.3 6744.5 6753.8 6205.5 6349.7 6350.4 6352.8 6367.0 3552.7 3586.3 3610.5 3615.7 3632.9 7115.4 7123.0 7125.9 7167.3 7179.3 6895.5 6932.5 6947.4 6976.5 6983.9 7101.3 7105.4 7121.7 7128.0 7157.3 6748.6 6818.2 6822.8 6833.9 6853.4 6661.7 6665.4 6698.8 6698.9 6702.5 6834.3 6907.9 6986.8 7017.2 7103.2 5025.0 5032.0 5036.3 5069.0 5076.2 6458.3 6683.2 6706.3 6727.2 6787.2 6174.4 6399.2 6399.6 6402.6 6575.9 6361.9 6373.9 6395.3 6402.6 6541.6 6419.9 6431.0 6452.5 6534.9 6579.1 6445.2 6449.4 6485.4 6487.4 6578.8 6243.6 6253.0 6283.3 6338.8 6338.9 04:30:21 INFO - PID 5031 | 04:30:21 INFO - PID 5031 | [#5] yui.html Cycles:180 Average:28074.57 Median:20357.14 stddev:40678.93 (199.8%) stddev-sans-first:40742.03 04:30:21 INFO - PID 5031 | Values: 942.0 952.2 973.5 981.1 982.6 18061.0 18737.0 18767.8 21041.0 21487.8 19855.2 20506.3 20558.8 20582.8 20590.2 1073.4 1092.9 1098.8 1099.9 1100.1 1008.6 1088.6 1088.8 1094.3 1102.6 1141.1 1152.2 1153.1 1153.4 1153.5 1134.2 1140.8 1145.2 1146.2 1147.0 830.6 835.1 836.3 840.6 842.6 20114.4 20385.9 20749.1 21230.5 21368.1 20477.7 20540.0 20888.6 21747.8 21962.2 16764.6 17064.7 17179.7 17246.7 17384.7 3714.1 3745.0 3746.3 3746.6 3747.5 141194.0 146318.0 147197.0 150168.0 154711.0 16629.8 16764.7 16921.2 17028.8 17039.3 27862.6 28257.4 28982.3 29049.1 29160.9 9172.3 9279.6 9312.7 9358.9 9374.4 4291.2 4385.5 4410.1 4436.4 4528.5 5684.2 5826.5 5834.9 5839.3 5862.1 1052.7 1054.2 1061.0 1174.6 1205.9 713.1 744.4 744.4 762.2 768.3 12605.4 12955.8 13508.5 13953.4 14290.8 732.6 738.3 757.8 763.1 765.2 6207.7 6338.3 6436.6 6450.7 6475.0 138699.0 142293.3 145016.3 145359.3 147194.0 123943.4 125142.0 125523.4 128156.0 131900.3 105867.0 105911.0 108583.5 109267.0 110014.4 13041.7 13747.2 13848.2 13930.8 14084.6 50464.5 51543.5 51846.7 52529.5 53296.7 87948.0 89319.6 90301.5 95732.0 96329.0 20455.7 20613.5 20800.5 21059.3 21307.8 20439.5 20763.7 20869.0 21121.1 21415.5 18407.6 18527.4 18628.1 19313.5 19734.5 18245.5 19225.8 19356.9 19443.7 19529.4 20328.4 20578.6 20813.5 21778.9 21796.2 13930.2 14048.0 14270.2 14557.9 14947.7 14373.9 14579.4 14751.1 15045.1 15067.5 04:30:21 INFO - PID 5031 | -------- Summary: end -------- 04:30:21 INFO - PID 5031 | 04:30:22 INFO - TEST-INFO | 5031: exit 0 04:30:22 INFO - TEST-OK | dromaeo_css | took 1110180ms 04:30:22 INFO - TEST-START | kraken 04:30:22 INFO - Initialising browser for kraken test... 04:30:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57153/getInfo.html -profile /tmp/tmpJkTNdN/profile 04:30:22 INFO - TEST-INFO | started process 5395 (/builds/slave/test/build/application/firefox/firefox http://localhost:57153/getInfo.html) 04:30:29 INFO - TEST-INFO | 5395: exit 0 04:30:29 INFO - Browser initialized. 04:30:29 INFO - Running cycle 1/1 for kraken test... 04:30:29 INFO - TEST-INFO | started process 5610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJkTNdN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:30 INFO - PID 5610 | 04:30:30 INFO - PID 5610 | (/builds/slave/test/build/application/firefox/firefox:5658): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:30:30 INFO - PID 5610 | 04:30:40 INFO - PID 5610 | RSS: Main: 161574912 04:30:40 INFO - PID 5610 | 04:30:43 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57153/tests/kraken/driver.html?testName=audio-beat-detection) 04:30:44 INFO - PID 5610 | RSS: Main: 167575552 04:30:44 INFO - PID 5610 | 04:30:46 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57153/tests/kraken/driver.html?testName=audio-dft) 04:30:47 INFO - PID 5610 | RSS: Main: 171712512 04:30:47 INFO - PID 5610 | 04:30:50 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57153/tests/kraken/driver.html?testName=audio-fft) 04:30:51 INFO - PID 5610 | RSS: Main: 164823040 04:30:51 INFO - PID 5610 | 04:30:53 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57153/tests/kraken/driver.html?testName=audio-oscillator) 04:30:53 INFO - PID 5610 | RSS: Main: 165879808 04:30:53 INFO - PID 5610 | 04:30:55 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57153/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:30:56 INFO - PID 5610 | RSS: Main: 166080512 04:30:56 INFO - PID 5610 | 04:30:59 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57153/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:00 INFO - PID 5610 | RSS: Main: 166322176 04:31:00 INFO - PID 5610 | 04:31:03 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57153/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:04 INFO - PID 5610 | RSS: Main: 169508864 04:31:04 INFO - PID 5610 | 04:31:06 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57153/tests/kraken/driver.html?testName=json-parse-financial) 04:31:07 INFO - PID 5610 | RSS: Main: 168222720 04:31:07 INFO - PID 5610 | 04:31:09 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57153/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:09 INFO - PID 5610 | RSS: Main: 168202240 04:31:09 INFO - PID 5610 | 04:31:11 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57153/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:12 INFO - PID 5610 | RSS: Main: 167981056 04:31:12 INFO - PID 5610 | 04:31:14 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57153/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:14 INFO - PID 5610 | RSS: Main: 165400576 04:31:14 INFO - PID 5610 | 04:31:17 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:31:17 INFO - PID 5610 | RSS: Main: 165064704 04:31:17 INFO - PID 5610 | 04:31:20 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:31:21 INFO - PID 5610 | RSS: Main: 165715968 04:31:21 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | Cycle 1(1): loaded http://localhost:57153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57153/tests/kraken/driver.html?testName=ai-astar) 04:31:23 INFO - PID 5610 | RSS: Main: 167301120 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | __start_tp_report 04:31:23 INFO - PID 5610 | _x_x_mozilla_page_load 04:31:23 INFO - PID 5610 | _x_x_mozilla_page_load_details 04:31:23 INFO - PID 5610 | |i|pagename|runs| 04:31:23 INFO - PID 5610 | |0;ai-astar;98;105;100;106;106;107;108;100;108;107 04:31:23 INFO - PID 5610 | |1;audio-beat-detection;140;113;136;175;113;140;140;122;168;116 04:31:23 INFO - PID 5610 | |2;audio-dft;163;162;163;162;161;166;162;160;164;175 04:31:23 INFO - PID 5610 | |3;audio-fft;75;76;72;164;75;79;73;73;167;75 04:31:23 INFO - PID 5610 | |4;audio-oscillator;78;77;130;79;78;78;121;78;78;132 04:31:23 INFO - PID 5610 | |5;imaging-gaussian-blur;114;114;114;114;113;114;113;114;114;113 04:31:23 INFO - PID 5610 | |6;imaging-darkroom;146;149;147;147;150;148;147;147;148;148 04:31:23 INFO - PID 5610 | |7;imaging-desaturate;96;94;94;93;95;94;94;95;94;93 04:31:23 INFO - PID 5610 | |8;json-parse-financial;56;57;46;47;47;48;47;49;47;49 04:31:23 INFO - PID 5610 | |9;json-stringify-tinderbox;54;54;54;59;56;54;54;54;54;54 04:31:23 INFO - PID 5610 | |10;stanford-crypto-aes;78;74;74;74;72;77;74;73;73;73 04:31:23 INFO - PID 5610 | |11;stanford-crypto-ccm;117;124;114;117;121;129;113;123;115;167 04:31:23 INFO - PID 5610 | |12;stanford-crypto-pbkdf2;163;165;165;161;162;160;160;159;169;175 04:31:23 INFO - PID 5610 | |13;stanford-crypto-sha256-iterative;62;69;60;61;59;59;61;60;60;60 04:31:23 INFO - PID 5610 | __end_tp_report 04:31:23 INFO - PID 5610 | __start_cc_report 04:31:23 INFO - PID 5610 | _x_x_mozilla_cycle_collect,865 04:31:23 INFO - PID 5610 | __end_cc_report 04:31:23 INFO - PID 5610 | __startTimestamp1502710283290__endTimestamp 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | ------- Summary: start ------- 04:31:23 INFO - PID 5610 | Number of tests: 14 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#0] ai-astar Cycles:10 Average:104.50 Median:107.00 stddev:3.72 (3.5%) stddev-sans-first:3.11 04:31:23 INFO - PID 5610 | Values: 98.0 105.0 100.0 106.0 106.0 107.0 108.0 100.0 108.0 107.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:140.00 stddev:21.72 (15.5%) stddev-sans-first:23.00 04:31:23 INFO - PID 5610 | Values: 140.0 113.0 136.0 175.0 113.0 140.0 140.0 122.0 168.0 116.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:4.26 (2.6%) stddev-sans-first:4.51 04:31:23 INFO - PID 5610 | Values: 163.0 162.0 163.0 162.0 161.0 166.0 162.0 160.0 164.0 175.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:38.32 (51.1%) stddev-sans-first:40.09 04:31:23 INFO - PID 5610 | Values: 75.0 76.0 72.0 164.0 75.0 79.0 73.0 73.0 167.0 75.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:78.00 stddev:24.15 (31.0%) stddev-sans-first:25.01 04:31:23 INFO - PID 5610 | Values: 78.0 77.0 130.0 79.0 78.0 78.0 121.0 78.0 78.0 132.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:31:23 INFO - PID 5610 | Values: 114.0 114.0 114.0 114.0 113.0 114.0 113.0 114.0 114.0 113.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.05 04:31:23 INFO - PID 5610 | Values: 146.0 149.0 147.0 147.0 150.0 148.0 147.0 147.0 148.0 148.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.71 04:31:23 INFO - PID 5610 | Values: 96.0 94.0 94.0 93.0 95.0 94.0 94.0 95.0 94.0 93.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:48.50 stddev:3.92 (8.1%) stddev-sans-first:3.32 04:31:23 INFO - PID 5610 | Values: 56.0 57.0 46.0 47.0 47.0 48.0 47.0 49.0 47.0 49.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:54.00 stddev:1.64 (3.0%) stddev-sans-first:1.72 04:31:23 INFO - PID 5610 | Values: 54.0 54.0 54.0 59.0 56.0 54.0 54.0 54.0 54.0 54.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:1.87 (2.5%) stddev-sans-first:1.39 04:31:23 INFO - PID 5610 | Values: 78.0 74.0 74.0 74.0 72.0 77.0 74.0 73.0 73.0 73.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:122.00 stddev:15.93 (13.1%) stddev-sans-first:16.69 04:31:23 INFO - PID 5610 | Values: 117.0 124.0 114.0 117.0 121.0 129.0 113.0 123.0 115.0 167.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.00 stddev:4.93 (3.0%) stddev-sans-first:5.22 04:31:23 INFO - PID 5610 | Values: 163.0 165.0 165.0 161.0 162.0 160.0 160.0 159.0 169.0 175.0 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:60.50 stddev:2.92 (4.8%) stddev-sans-first:3.08 04:31:23 INFO - PID 5610 | Values: 62.0 69.0 60.0 61.0 59.0 59.0 61.0 60.0 60.0 60.0 04:31:23 INFO - PID 5610 | -------- Summary: end -------- 04:31:23 INFO - PID 5610 | 04:31:23 INFO - PID 5610 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:31:23 INFO - TEST-INFO | 5610: exit 0 04:31:24 INFO - TEST-OK | kraken | took 61648ms 04:31:24 INFO - SUITE-END | took 1171s 04:31:24 INFO - Completed test suite (00:19:32) 04:31:24 INFO - javascript benchmark 04:31:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8933.942712025731, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3463.5670541182353, 3495.283466889288, 3504.9649503504966, 3531.50558921751, 3535.0455377048215, 6162.630242185472, 6166.506679465643, 6217.067439884014, 6244.625322480654, 6253.405926436987, 6192.566520343577, 6248.781292654758, 6250.281217659959, 6253.218347706536, 6256.874862502758, 5436.374816896068, 5447.019536483432, 5458.426865179149, 5458.754356053987, 5466.098093814516, 5529.225908372831, 5585.134304182838, 5590.496855283024, 5604.551635869121, 5646.887062258752, 5493.423190564973, 5563.082091454905, 5568.888622227553, 5607.355154157263, 5641.069223578104, 5364.946350536484, 5410.756515956791, 5415.0523658359625, 5467.5625949923915, 5550.028744969654, 5443.319585051869, 5464.371597266326, 5509.449055094498, 5531.557475401958, 5533.916991245134, 6165.630062196283, 6193.5045196384635, 6226.159468471744, 6249.656268905208, 6269.62382257066, 6808.455323574102, 6814.761483348108, 6851.314868513158, 6879.6216208108535, 6885.414739747128, 6871.4502839772695, 6873.20958089821, 6940.201876784184, 6969.2682268362105, 6970.860582788367, 6353.237611486651, 6360.872782544323, 6413.390727880844, 6425.7750978715985, 6448.903266451054, 6823.28355522663, 6909.1018167637885, 6923.757668481579, 6984.79045628632, 7021.859562808715, 6694.062831203635, 6745.5952642841585, 6773.966130169416, 6777.796666100025, 6783.660816959133, 6725.6973436195485, 6791.694373753193, 6841.076454678555, 6876.724931002704, 6879.724811007503, 6718.093057437183, 6747.865042699119, 6797.864042719118, 6798.116244888231, 6806.897896531556, 6803.217629972518, 6836.4530837532875, 6862.656867156722, 6874.896876546856, 6878.58728476293, 4847.175980083394, 4856.077345304381, 4913.140200464904, 4915.336429582032, 4938.728369939688, 4325.870223893288, 4343.087951530151, 4346.261135606955, 4366.868993930188, 4458.643308535309, 6407.615543067431, 6447.387498187664, 6451.806445806634, 6468.611883287018, 6482.708278127496, 6749.257581666013, 6760.492963027793, 6790.626515541692, 6859.348361905611, 6864.485163612749, 6257.342978987232, 6331.0, 6354.491640668735, 6388.84027899297, 6438.967805160944, 5459.0, 5496.1755736639825, 5518.227448157261, 5524.0, 5526.944730552643, 7132.286771322826, 7132.28677132293, 7214.134303883568, 7218.133823941055, 7220.602866842269, 6482.546221764431, 6817.0, 6820.113385259884, 6822.3859852613505, 6905.136857892763, 7103.0, 7112.395446387115, 7114.608696521741, 7121.501494895308, 7122.893156602759, 6645.036469711961, 6689.163854518185, 6692.230393504809, 6695.698693558899, 6739.258681545124, 6825.52221344521, 6866.0, 6942.06282151903, 6945.861082778417, 6971.755988540377, 6600.669966501559, 6604.768833090819, 6661.800145995628, 6689.46484281266, 6696.330366963265, 6547.377999090078, 6607.372299631527, 6640.402363787282, 6641.568298060611, 6661.900071498834, 6604.471642268511, 6620.106285651375, 6656.36764507371, 6686.465082793462, 6727.798166055026, 6620.834479137868, 6653.933460665331, 6744.0895479109695, 6749.73001079971, 6754.93245067543, 6278.874422511615, 6348.079528468438, 6372.171617689671, 6454.0641606967665, 6469.45009674183], "value": 6181.208753202324, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.5856835140012, 916.5737931861687, 947.7346343023953, 973.6884197056941, 974.5955428497174, 42003.57996420035, 43882.34176487351, 43931.12137757251, 43947.78026109869, 44129.33805992913, 41752.58247417525, 42050.369244461355, 42083.15833683324, 42119.78940105303, 42122.57877421225, 7134.678939447737, 7244.311790379906, 7244.746433874815, 7246.058012458373, 7247.0, 7087.468439867005, 7193.42452603793, 7194.208637049946, 7197.460190485708, 7197.856042879139, 7109.289071092901, 7175.677094530733, 7199.640017999105, 7202.279772022808, 7202.963985180067, 7125.0, 7126.679299431512, 7131.46514011446, 7138.072050633436, 7139.964300178492, 6611.900821487681, 6652.767153149665, 6658.201015878077, 6661.533692641517, 6672.099266598995, 35809.82095089534, 36070.819645901865, 36096.0, 36132.63867361319, 36214.45678314827, 3362.8822991195434, 3365.394229038772, 3397.184675677844, 3397.69420752131, 3398.065531978701, 28040.85979570089, 28337.149885503466, 28392.574111388345, 28393.29016774597, 28432.715672843213, 4584.747838868894, 4707.45864225615, 4711.1519926413575, 4715.127701375222, 4742.3123647071325, 207678.0, 208811.0, 211099.0, 214289.0, 220535.0, 54153.45846541484, 54409.45590544123, 54428.72785636046, 54521.45478545243, 54650.453495464535, 56695.716521417955, 56852.43147568554, 57016.0, 57041.0, 57108.0, 16128.75806862898, 16234.0, 16235.59411014734, 16248.512544623443, 17000.48998530046, 13878.791818122736, 13881.652958676113, 13891.513797017056, 13951.372188251553, 13961.86038139626, 15024.79801615868, 15026.549203523911, 15155.924220378827, 15163.924180379248, 15234.619134521505, 5994.610350327215, 5997.850053748692, 6013.248343957005, 6062.272527296753, 6096.177016102769, 1065.1159537583787, 1093.912487001054, 1097.078454098561, 1101.3336931156696, 1105.160078340467, 24531.63202551963, 24603.261902142964, 24920.37699057538, 24967.875160624444, 24987.0, 1185.25921299188, 1198.9820152697716, 1203.843500344967, 1205.8854408831146, 1207.0404028796952, 13081.476740930257, 13158.868411315956, 13210.669733256553, 13220.206787592775, 13247.271400072896, 264998.0, 265644.0, 266796.0, 267740.0, 267830.0, 57816.42183578195, 57887.0, 57925.42074579284, 58003.12995305074, 58103.41896581065, 1518.4533567915541, 1533.7929379533844, 1556.533040087969, 1558.3299181351902, 1565.0687840734745, 24813.00747970061, 29345.559816603196, 30198.396032079676, 30200.0, 30729.231769205948, 55015.44984550103, 55064.44935550593, 55281.44718552763, 55318.170227445815, 55383.44616553944, 236804.0, 239622.0, 239681.0, 239720.0, 240110.0, 36362.27275454423, 36454.0, 36775.448368275036, 39895.60104398919, 40276.597234027286, 50986.23520647267, 51145.7442712784, 51363.743181283855, 51435.0, 52213.21680174724, 36539.26921461503, 36703.265934681694, 36733.0, 36753.08117296982, 37279.81360093182, 36054.4591831128, 36274.455883161245, 36546.451803222444, 36831.44752828763, 36875.63124368722, 42486.0, 43377.783111084245, 43484.78257608818, 43795.78102109469, 43886.12227755491, 36099.0, 36211.45682814707, 36276.638119896015, 36329.81835090808, 36473.27053458863, 26888.193354199404, 27048.0, 27374.041908533105, 27392.58911116295, 27576.724232757417], "value": 18335.3006665565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.4638885836171, 578.878435528539, 579.869529355895, 588.273482249422, 597.9461848433641, 23036.539269214605, 23764.16825411111, 24551.75448245519, 24569.877150614266, 24588.631170532433, 26406.867965660145, 26696.19911402656, 26955.86522067387, 26966.325841853963, 26971.190864274053, 6433.09936608874, 6557.704903279364, 6562.606243625398, 6565.441937435324, 6570.967145164267, 5906.852328691774, 6378.4578310843635, 6418.550701450877, 6435.6782160892, 6453.645049522274, 6390.3609639036185, 6391.392817682336, 6393.840153996164, 6395.648239346834, 6401.16784817973, 6386.07401926718, 6387.5209359298005, 6387.840303992414, 6388.584741991779, 6396.008618664115, 5951.851203719942, 5953.613015154045, 5955.3151387590115, 5955.34491205967, 5968.31364393096, 30215.697843021728, 30900.0, 30920.536191957137, 30974.0707778767, 31309.8434507826, 2212.148322895681, 2253.43664083979, 2255.7969782719633, 2256.0750092462013, 2258.5144193998367, 20062.297819576244, 20554.38336849897, 20559.5888082239, 20615.38153855387, 20661.79338206614, 2434.8417352872007, 2474.74015228402, 2497.3756560859783, 2530.93672658185, 2591.740825917412, 160865.19567402205, 163182.18408908, 163406.0, 163812.0, 164653.0, 15229.466968656045, 16008.919955400148, 16100.470455306728, 16164.838351616569, 16269.67460650804, 24222.273331800076, 24276.757232427804, 24280.392990175034, 24286.14998475045, 24374.39064023378, 9656.37233579815, 9918.30571859963, 10051.949740251252, 10282.383057016454, 10520.158387328995, 9186.86219706705, 9206.76983075415, 9213.585388657526, 9254.213391861767, 9325.114114159143, 8492.702755403654, 9455.52722363879, 9674.613885140145, 9756.170725488271, 9830.262730295257, 2660.2551285639665, 2732.8087033907436, 2745.341118131634, 2747.0, 2848.3875966667265, 999.980000399988, 1029.1355261580309, 1031.4631199512671, 1031.5873650539695, 1047.8585390972273, 20552.486187845425, 20847.687284690743, 20982.2656207032, 21007.15971361159, 21311.78688213129, 1094.0591091661165, 1098.9670309890716, 1109.916756243285, 1111.0556027376665, 1119.8768135505088, 11473.139514536444, 11826.467808948619, 11858.347790871412, 11863.228890122115, 11944.223625464318, 532956.0, 543666.0, 552445.0, 552723.0, 554764.0, 133484.33257833842, 134119.32940335432, 134218.0, 134623.32688336496, 135461.0, 1235.6478403655094, 1250.7811133051862, 1264.5700461843016, 1274.2609286613927, 1275.152023904112, 18455.07724613791, 18744.250229991194, 18753.812461875208, 18771.155298011894, 18911.810881891004, 59377.21868343957, 59736.0, 60367.69816150891, 60638.39361606504, 61058.694706526185, 76239.23760762322, 76450.0, 77032.2296777025, 77336.22663773515, 77629.61185194038, 14634.487792927197, 14815.18516481604, 14815.777763333774, 14837.554873353816, 14891.106533608017, 23650.29049128529, 23683.881580591988, 23975.52048959046, 23975.76024239805, 24060.759392405853, 19112.713309300092, 19234.0, 19290.131944062832, 19345.61308773845, 19574.706379404037, 16101.686453455133, 16681.916590417455, 16990.660186795947, 17018.0, 17408.912955435142, 18531.536711582317, 18678.439646810617, 18778.436646900616, 18807.247710091444, 18888.0, 14230.857691423367, 14416.42334306616, 14459.421623134956, 14471.421143154155, 14567.198804065454, 18373.448796536126, 18469.0, 18511.444656660322, 18548.258069677602, 18633.254669813057], "value": 12453.498645342534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.75847105992, 1447.3920953199656, 1458.7009663019082, 1461.101422625086, 1466.516049703598, 15385.0, 15823.287952042157, 16414.507564773077, 16457.259423325948, 16518.0, 16515.66968660626, 16845.91577042116, 16873.915630421863, 16887.24007419666, 16944.576385590368, 2558.7441255874355, 2620.6069089636517, 2682.061278552501, 2683.597460380939, 2684.0471632570448, 2721.9591706124424, 2751.119641714652, 2755.6279902213146, 2757.2555410039276, 2758.089830355978, 2441.426264827773, 2473.727889932106, 2483.4784695214025, 2560.0655760647323, 2570.3445621366527, 2624.5144648240043, 2632.9605055924176, 2649.337665583604, 2649.417128231786, 2657.322382792395, 2540.187140115164, 2552.1067626330823, 2578.6647735794413, 2580.342012786746, 2624.7637712605956, 15767.29047192879, 16052.197390130446, 16079.11564863932, 16110.919445402698, 16114.75827862583, 8112.6349314280405, 8346.332293416512, 8372.16278372164, 8419.410641255115, 8421.663133474654, 5038.496150384969, 5167.819126330561, 5225.399079105913, 5246.501582349671, 5285.180796976437, 1927.9036048197675, 1950.71714601382, 1952.2971730177126, 1952.8256645787026, 1991.1836147179731, 28101.29746756327, 28337.574936375764, 28338.716612833814, 28345.57481637777, 28363.432731345463, 7210.387117095001, 7253.419726421874, 7346.706131754777, 7356.117265928123, 7400.740974065882, 18990.810091898904, 19000.0, 19034.0, 19040.238390464503, 19111.23555057782, 8232.917670823335, 8522.403431759842, 8533.53065581399, 8539.231469167804, 8549.572521374032, 6624.27133015368, 6820.283870193657, 7061.858762824818, 7073.646317684095, 7894.960525197337, 5259.710715910585, 5480.3971563128025, 5483.670979741229, 5522.944770552243, 5586.776528938878, 1546.6829299993474, 1548.4116035906509, 1566.749320108777, 1568.090507505644, 1590.5943984284165, 936.9906300936904, 961.8076384723083, 962.3696478806393, 976.3360914578013, 978.7455261632027, 8414.873776893352, 8504.489730616182, 8513.574321283912, 8521.44610600309, 8569.95715021421, 703.2791388826494, 705.8835292176733, 726.3535453446436, 742.0872327037774, 750.7484992527455, 4925.679830811057, 5041.823536176216, 5549.19536667181, 5620.353659329229, 5925.170476133345, 21588.89205553962, 23753.40616484567, 24117.51764964726, 24137.396565086012, 24248.272551823473, 22845.543089138126, 23142.884285578803, 23563.293101206993, 23739.643905341432, 23761.287161385186, 12166.087543434101, 12199.756004879853, 12415.379231038412, 12453.688657783447, 12476.064295177897, 8947.642094316154, 9557.085089047629, 9614.471204083842, 9682.0, 9840.950795246265, 20620.27829025977, 21033.789662103183, 21126.366209013755, 21130.260440884496, 21364.465888352915, 21091.0, 21457.14171433125, 21571.0, 21794.782052179275, 21884.89057554702, 13393.330333483482, 13709.383077761724, 13711.245881476614, 13712.52006179779, 13714.0, 14875.47935822241, 15188.772168417261, 15311.540653780405, 15312.0, 15332.923335383251, 12479.939205167298, 12481.56314528987, 12500.687482813002, 12783.87216127864, 12899.226046437243, 11582.71043223926, 12196.390180491117, 12243.632691019284, 12294.323812190416, 12440.626781196579, 10799.946000269949, 10802.08182304513, 10898.0, 10944.890551094388, 10962.232643714864, 8004.159563245776, 8013.879791803244, 8056.879146812686, 8285.83428331418, 8289.544075075928, 8299.543525106177, 8310.667573297, 8350.540720260444, 8359.164083591591, 8392.32861371101], "value": 7023.6411852542915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.77789772500097, 508.1919747601311, 532.6857154278974, 540.1357827476037, 542.5496837624771, 6195.0, 6209.9068513972325, 6246.5315101367405, 6257.71840267188, 6293.496520278378, 5899.705014749266, 6038.698065096739, 6046.8488287792825, 6074.787382441605, 6154.87690246196, 4806.279058141289, 4820.445648750404, 4824.4210694716685, 4842.44311904132, 4853.320535125068, 4741.454732705749, 4766.0, 4775.474697783241, 4792.161371759946, 4813.927791083137, 4796.856094317176, 4797.208460603996, 4823.589994850425, 4837.7339246341435, 4850.830220942268, 4829.613630909536, 4831.734254615994, 4832.154372984731, 4847.418309802811, 4898.779554920037, 4314.201872653569, 4335.783210839477, 4356.411884395598, 4374.4531933508315, 4379.781010949439, 5998.340182579913, 6053.667048312341, 6057.697115144269, 6098.878022439526, 6136.263648362181, 5694.6867922264255, 5768.384852241337, 5797.623154494944, 5844.211031510734, 5880.382559831199, 6480.189976252968, 6544.280129185786, 6593.967030164867, 6621.801345959629, 6661.134052573183, 4926.5812405945535, 4949.876253093666, 4983.9252411213865, 4986.252062190664, 4988.152014157602, 6877.449804015717, 6920.792376228621, 6951.6871740771285, 6976.604679064208, 7052.788416347517, 5020.171671674206, 5024.196128619404, 5027.874303142451, 5047.974760126176, 5097.541221290102, 5133.743312834344, 5135.820246291362, 5183.481651834786, 5188.325517682677, 5200.401953775364, 5686.232358631614, 5751.0, 5778.162166485836, 5804.390538993429, 5866.765329386777, 6475.287718350977, 6518.739250430024, 6530.0, 6547.9017814732815, 6577.0, 1697.9745303820453, 1731.1690388613536, 1733.956651083733, 1737.1053907237783, 1767.7967033791278, 1222.9694257643453, 1239.1945235596934, 1248.9875101248872, 1252.1798222164498, 1255.0, 6206.255249370014, 6209.565330426917, 6244.344343843922, 6281.968590157111, 6343.397377249154, 6544.723778863076, 6654.434373078343, 6692.293465166352, 6744.482491439485, 6753.797386078426, 6205.47253483459, 6349.714262858182, 6350.396712312323, 6352.823588205897, 6366.9681651591445, 3552.6802587767224, 3586.336527742324, 3610.494530765695, 3615.7468977171347, 3632.9091772705365, 7115.4105601886495, 7122.964385178041, 7125.928740712527, 7167.319104685047, 7179.317964793337, 6895.482838787111, 6932.480063995221, 6947.444204463631, 6976.51164418496, 6983.89524157138, 7101.325374089453, 7105.360517553445, 7121.67952442131, 7128.0, 7157.320054594805, 6748.561343512656, 6818.249992500921, 6822.795316140524, 6833.897491537531, 6853.417459515997, 6661.666916654245, 6665.366790154928, 6698.799036028927, 6698.866022679616, 6702.497312701469, 6834.282400347892, 6907.861842763217, 6986.790396288119, 7017.157941047107, 7103.183133939663, 5024.974875125601, 5031.987205117982, 5036.269740887624, 5069.0, 5076.213186956028, 6458.289588145394, 6683.164604424447, 6706.329367063255, 6727.192736871607, 6787.185537735306, 6174.351693072343, 6399.232092148972, 6399.55203135776, 6402.615843049246, 6575.868482630225, 6361.936380636134, 6373.864755307024, 6395.296517383177, 6402.6158430494315, 6541.6075035498025, 6419.876521608793, 6430.967845160932, 6452.451541619015, 6534.869302614016, 6579.111819904251, 6445.2265728112925, 6449.419552240321, 6485.416312531895, 6487.448566871869, 6578.756701927326, 6243.562950593415, 6252.999520076766, 6283.2774230962195, 6338.809835704937, 6338.936610633835], "value": 5105.45863419095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [941.9717408477748, 952.190637957736, 973.5132433783108, 981.0581841432224, 982.6167794560121, 18061.0, 18737.0, 18767.812321876794, 21041.0, 21487.785122148773, 19855.205791768312, 20506.2822801202, 20558.794412055875, 20582.794172058275, 20590.1763929443, 1073.4310815267902, 1092.901638852503, 1098.8132017557034, 1099.912007039435, 1100.0759362135805, 1008.6246888577405, 1088.570014844136, 1088.842117892905, 1094.2996482251365, 1102.597551893561, 1141.0757286597882, 1152.2107356460808, 1153.117864833403, 1153.3829401270323, 1153.5155234801362, 1134.1720544002883, 1140.7832511822728, 1145.1869172887218, 1146.2033886448921, 1146.9885301146965, 830.5722552885269, 835.1272919798824, 836.3016880904452, 840.5755093677715, 842.5702891525304, 20114.39656810298, 20385.898070509553, 20749.066292016745, 21230.469238269012, 21368.145274189013, 20477.692834607344, 20540.0, 20888.5822283555, 21747.782522174733, 21962.231321903815, 16764.580885477837, 17064.658706825918, 17179.742303865452, 17246.65506689872, 17384.652306953918, 3714.1086139326635, 3745.02629316377, 3746.344389731786, 3746.5691445483844, 3747.45661879026, 141194.0, 146318.0, 147197.0, 150168.0, 154711.0, 16629.83370166283, 16764.664706705797, 16921.153942302837, 17028.829711702725, 17039.31842726277, 27862.5820612691, 28257.43485130286, 28982.27544311409, 29049.12852614425, 29160.85419572931, 9172.31207659415, 9279.628814847465, 9312.674056407994, 9358.859617105749, 9374.437533747998, 4291.206126866539, 4385.495667998221, 4410.095930334273, 4436.44544431946, 4528.456585209796, 5684.204211410406, 5826.475617194473, 5834.920539700169, 5839.328477225174, 5862.091375836752, 1052.678932925465, 1054.2409465185056, 1060.9787804243872, 1174.647605718281, 1205.879412058787, 713.0658836923543, 744.3524134003452, 744.4044764188627, 762.2415696382135, 768.2701433638066, 12605.369731513387, 12955.805662915063, 13508.459661613426, 13953.372098255602, 14290.785638215435, 732.571445704269, 738.335498051747, 757.7916073079837, 763.091920614467, 765.2271206081897, 6207.720652570645, 6338.334474880164, 6436.613803171825, 6450.741970321228, 6474.967625161844, 138699.0, 142293.28853355875, 145016.27491862472, 145359.2732036354, 147194.0, 123943.38028309801, 125142.0, 125523.3723831375, 128156.0, 131900.3404982988, 105867.0, 105911.0, 108583.45708271409, 109267.0, 110014.44992775146, 13041.739165216453, 13747.243901585109, 13848.169109853441, 13930.791038134234, 14084.647883802578, 50464.49535504598, 51543.48456515387, 51846.74076629593, 52529.47470525246, 53296.73351633217, 87948.0, 89319.55340223257, 90301.54849225975, 95732.0, 96329.03670963201, 20455.693164602246, 20613.484662883548, 20800.47998800042, 21059.262925797524, 21307.7869221312, 20439.489012774204, 20763.688544672143, 20869.0, 21121.128108981586, 21415.464613384167, 18407.631847363245, 18527.444176674722, 18628.068596569847, 19313.51716207106, 19734.50663733361, 18245.54386140357, 19225.807741922403, 19356.903215484395, 19443.70834437456, 19529.414117576496, 20328.390148295573, 20578.58842823105, 20813.479663008548, 21778.891105545004, 21796.237131700313, 13930.164190148624, 14048.0, 14270.215138167501, 14557.85442145565, 14947.701045978802, 14373.856261437251, 14579.416823326948, 14751.114933104049, 15045.097294162386, 15067.4726384576], "value": 10045.736984067667, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1473.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 105.0, 100.0, 106.0, 106.0, 107.0, 108.0, 100.0, 108.0, 107.0], "value": 104.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 113.0, 136.0, 175.0, 113.0, 140.0, 140.0, 122.0, 168.0, 116.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 161.0, 166.0, 162.0, 160.0, 164.0, 175.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 72.0, 164.0, 75.0, 79.0, 73.0, 73.0, 167.0, 75.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 130.0, 79.0, 78.0, 78.0, 121.0, 78.0, 78.0, 132.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 147.0, 147.0, 150.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 93.0, 95.0, 94.0, 94.0, 95.0, 94.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 46.0, 47.0, 47.0, 48.0, 47.0, 49.0, 47.0, 49.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 59.0, 56.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 74.0, 72.0, 77.0, 74.0, 73.0, 73.0, 73.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 124.0, 114.0, 117.0, 121.0, 129.0, 113.0, 123.0, 115.0, 167.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 161.0, 162.0, 160.0, 160.0, 159.0, 169.0, 175.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 60.0, 61.0, 59.0, 59.0, 61.0, 60.0, 60.0, 60.0], "value": 61.1, "unit": "score"}]}]} 04:31:24 INFO - Return code: 0 04:31:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:31:24 INFO - # TBPL SUCCESS # 04:31:24 INFO - Running post-action listener: _package_coverage_data 04:31:24 INFO - Running post-action listener: _resource_record_post_action 04:31:24 INFO - [mozharness: 2017-08-14 11:31:24.566432Z] Finished run-tests step (success) 04:31:24 INFO - Running post-run listener: _resource_record_post_run 04:31:24 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 45056; Write bytes: 432959488; Read time: 604; Write time: 445384 04:31:24 INFO - TinderboxPrint: CPU usage
13.1% 04:31:24 INFO - TinderboxPrint: I/O read bytes / time
45,056 / 604 04:31:24 INFO - TinderboxPrint: I/O write bytes / time
432,959,488 / 445,384 04:31:24 INFO - TinderboxPrint: CPU idle
8,247.7 (86.9%) 04:31:24 INFO - TinderboxPrint: CPU user
1,189.0 (12.5%) 04:31:24 INFO - TinderboxPrint: Swap in / out
0 / 0 04:31:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 118644736; Read time: 328; Write time: 124560 04:31:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:31:24 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 40960; Write bytes: 313942016; Read time: 276; Write time: 320824 04:31:25 INFO - Running post-run listener: _upload_blobber_files 04:31:25 INFO - Blob upload gear active. 04:31:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:31:25 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 04:31:25 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'] 04:31:25 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 04:31:26 INFO - (blobuploader) - INFO - Open directory for files ... 04:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:31:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:32 INFO - (blobuploader) - INFO - Done attempting. 04:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:37 INFO - (blobuploader) - INFO - Done attempting. 04:31:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:31:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:31:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:42 INFO - (blobuploader) - INFO - Done attempting. 04:31:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:31:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:52 INFO - (blobuploader) - INFO - Done attempting. 04:31:52 INFO - (blobuploader) - INFO - Iteration through files over. 04:31:52 INFO - Return code: 0 04:31:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:31:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:31:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc50e1177a5a5b40ef878bc4a259c5351b2c8461dae84f2611d9ee8a6b79504853ad4c99c85675d1aed1940b3ba6f979e00e7c794e34ad5da6a22d1e641b319d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d29f531c1b90dcf069ad8845cc757cfa585cb0619efe22119998143d4d01d46ed58e7e50ff349ad65c25a839587ce1e3bed469795ecc2d05fd3d5c2d137cccbf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b198fe91681b0e86540a286e62167c075e8c7a62c75cd0ca61fe2667c28212cd72fa9ca4c8f12aad870e1e3d14cb7db81dddc6c61de111b552dc4c16ccdfb1b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f208644d47ce6a482b725607b5b8a8360ef0d6c3f80b92fbe0a579450acd772385d3dc1c3649dbff0903dee8f09bbadb15f9334994200c005394819206714f7b"} 04:31:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:31:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:31:52 INFO - Contents: 04:31:52 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc50e1177a5a5b40ef878bc4a259c5351b2c8461dae84f2611d9ee8a6b79504853ad4c99c85675d1aed1940b3ba6f979e00e7c794e34ad5da6a22d1e641b319d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d29f531c1b90dcf069ad8845cc757cfa585cb0619efe22119998143d4d01d46ed58e7e50ff349ad65c25a839587ce1e3bed469795ecc2d05fd3d5c2d137cccbf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b198fe91681b0e86540a286e62167c075e8c7a62c75cd0ca61fe2667c28212cd72fa9ca4c8f12aad870e1e3d14cb7db81dddc6c61de111b552dc4c16ccdfb1b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f208644d47ce6a482b725607b5b8a8360ef0d6c3f80b92fbe0a579450acd772385d3dc1c3649dbff0903dee8f09bbadb15f9334994200c005394819206714f7b"} 04:31:52 INFO - Running post-run listener: copy_logs_to_upload_dir 04:31:52 INFO - Copying logs to upload dir... 04:31:52 INFO - mkdir: /builds/slave/test/build/upload/logs 04:31:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.462920 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-08-14 04:31:52.792362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2017-08-14 04:31:52.797160) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc50e1177a5a5b40ef878bc4a259c5351b2c8461dae84f2611d9ee8a6b79504853ad4c99c85675d1aed1940b3ba6f979e00e7c794e34ad5da6a22d1e641b319d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d29f531c1b90dcf069ad8845cc757cfa585cb0619efe22119998143d4d01d46ed58e7e50ff349ad65c25a839587ce1e3bed469795ecc2d05fd3d5c2d137cccbf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b198fe91681b0e86540a286e62167c075e8c7a62c75cd0ca61fe2667c28212cd72fa9ca4c8f12aad870e1e3d14cb7db81dddc6c61de111b552dc4c16ccdfb1b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f208644d47ce6a482b725607b5b8a8360ef0d6c3f80b92fbe0a579450acd772385d3dc1c3649dbff0903dee8f09bbadb15f9334994200c005394819206714f7b"} build_url:https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/ZB0kav9bRV-063CH8DVBog/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc50e1177a5a5b40ef878bc4a259c5351b2c8461dae84f2611d9ee8a6b79504853ad4c99c85675d1aed1940b3ba6f979e00e7c794e34ad5da6a22d1e641b319d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d29f531c1b90dcf069ad8845cc757cfa585cb0619efe22119998143d4d01d46ed58e7e50ff349ad65c25a839587ce1e3bed469795ecc2d05fd3d5c2d137cccbf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b198fe91681b0e86540a286e62167c075e8c7a62c75cd0ca61fe2667c28212cd72fa9ca4c8f12aad870e1e3d14cb7db81dddc6c61de111b552dc4c16ccdfb1b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f208644d47ce6a482b725607b5b8a8360ef0d6c3f80b92fbe0a579450acd772385d3dc1c3649dbff0903dee8f09bbadb15f9334994200c005394819206714f7b"}' ========= master_lag: 2.00 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2017-08-14 04:31:54.803741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-08-14 04:31:54.804088) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502709036.300299-1113720308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 2.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-08-14 04:31:56.829247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 04:31:56.829590) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 04:31:56.832916) ========= ========= Total master_lag: 4.57 =========