builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1502865740.92 results: success (0) revision: 9ab2470a3210324bc11320531b15d195aaf05051 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:20.918522) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:20.918971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:20.919303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.014578) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.014869) ========= 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=bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 23:42:21-- 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% 39.0M=0s 2017-08-15 23:42:21 (39.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112628 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.146605) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.147597) ========= 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=bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020748 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.199132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.199564) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ab2470a3210324bc11320531b15d195aaf05051 --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 9ab2470a3210324bc11320531b15d195aaf05051 --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=bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 23:42:21,692 truncating revision to first 12 chars 2017-08-15 23:42:21,692 Setting DEBUG logging. 2017-08-15 23:42:21,693 attempt 1/10 2017-08-15 23:42:21,693 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ab2470a3210?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 23:42:22,226 unpacking tar archive at: mozilla-central-9ab2470a3210/testing/mozharness/ program finished with exit code 0 elapsedTime=0.875929 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:22.091800) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:22.092176) ========= script_repo_revision: 9ab2470a3210324bc11320531b15d195aaf05051 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:22.092589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:22.092891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:22.110326) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-15 23:42:22.110656) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:42:22 INFO - MultiFileLogger online at 20170815 23:42:22 in /builds/slave/test 23:42:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 23:42:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:42:22 INFO - {'append_to_log': False, 23:42:22 INFO - 'base_work_dir': '/builds/slave/test', 23:42:22 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 23:42:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:42:22 INFO - 'branch': 'Firefox-Non-PGO', 23:42:22 INFO - 'buildbot_json_path': 'buildprops.json', 23:42:22 INFO - 'code_coverage': False, 23:42:22 INFO - 'config_files': ('talos/linux_config.py',), 23:42:22 INFO - 'default_actions': ('clobber', 23:42:22 INFO - 'read-buildbot-config', 23:42:22 INFO - 'download-and-extract', 23:42:22 INFO - 'populate-webroot', 23:42:22 INFO - 'create-virtualenv', 23:42:22 INFO - 'install', 23:42:22 INFO - 'setup-mitmproxy', 23:42:22 INFO - 'run-tests'), 23:42:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:42:22 INFO - 'disable_ccov_upload': False, 23:42:22 INFO - 'download_minidump_stackwalk': True, 23:42:22 INFO - 'download_symbols': 'ondemand', 23:42:22 INFO - 'enable_stylo': False, 23:42:22 INFO - 'enable_webrender': False, 23:42:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:42:22 INFO - 'tooltool.py': '/tools/tooltool.py', 23:42:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:42:22 INFO - '/tools/misc-python/virtualenv.py')}, 23:42:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:42:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:42:22 INFO - 'gecko_profile': False, 23:42:22 INFO - 'gecko_profile_interval': 0, 23:42:22 INFO - 'installer_path': 'installer.exe', 23:42:22 INFO - 'log_level': 'info', 23:42:22 INFO - 'log_name': 'talos', 23:42:22 INFO - 'log_to_console': True, 23:42:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:42:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:42:22 INFO - 'opt_config_files': (), 23:42:22 INFO - 'pip_index': False, 23:42:22 INFO - 'suite': 'dromaeojs-e10s', 23:42:22 INFO - 'system_bits': '32', 23:42:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:42:22 INFO - 'title': 'talos-linux64-ix-055', 23:42:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:42:22 INFO - 'use_talos_json': True, 23:42:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:42:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:42:22 INFO - 'work_dir': 'build'} 23:42:22 INFO - [mozharness: 2017-08-16 06:42:22.706832Z] Running clobber step. 23:42:22 INFO - Running pre-action listener: _resource_record_pre_action 23:42:22 INFO - Running main action method: clobber 23:42:22 INFO - rmtree: /builds/slave/test/build 23:42:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:42:23 INFO - Running post-action listener: _resource_record_post_action 23:42:23 INFO - [mozharness: 2017-08-16 06:42:23.739434Z] Finished clobber step (success) 23:42:23 INFO - [mozharness: 2017-08-16 06:42:23.739536Z] Running read-buildbot-config step. 23:42:23 INFO - Running pre-action listener: _resource_record_pre_action 23:42:23 INFO - Running main action method: read_buildbot_config 23:42:23 INFO - Using buildbot properties: 23:42:23 INFO - { 23:42:23 INFO - "project": "", 23:42:23 INFO - "product": "firefox", 23:42:23 INFO - "who": "asasaki@mozilla.com", 23:42:23 INFO - "installer_path": "public/build/target.tar.bz2", 23:42:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 23:42:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 23:42:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 23:42:23 INFO - "stage_platform": "linux64", 23:42:23 INFO - "basedir": "/builds/slave/test", 23:42:23 INFO - "buildnumber": 1080, 23:42:23 INFO - "platform": "ubuntu64_hw", 23:42:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:42:23 INFO - "slavebuilddir": "test", 23:42:23 INFO - "taskId": "Up9nYCZqSQadFZx7pDOpxQ", 23:42:23 INFO - "branch": "mozilla-central", 23:42:23 INFO - "script_repo_revision": "production", 23:42:23 INFO - "revision": "9ab2470a3210324bc11320531b15d195aaf05051", 23:42:23 INFO - "slavename": "talos-linux64-ix-055", 23:42:23 INFO - "repo_path": "mozilla-central" 23:42:23 INFO - } 23:42:23 INFO - Finding installer, test and symbols from parent task. 23:42:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Up9nYCZqSQadFZx7pDOpxQ'}, attempt #1 23:42:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Up9nYCZqSQadFZx7pDOpxQ'}, attempt #1 23:42:24 INFO - Task dependencies: d3FxelQfSZeBQxstE0lcrA 23:42:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA'}, attempt #1 23:42:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json 23:42:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip 23:42:25 INFO - Running post-action listener: _resource_record_post_action 23:42:25 INFO - [mozharness: 2017-08-16 06:42:25.098125Z] Finished read-buildbot-config step (success) 23:42:25 INFO - [mozharness: 2017-08-16 06:42:25.098345Z] Running download-and-extract step. 23:42:25 INFO - Running pre-action listener: _resource_record_pre_action 23:42:25 INFO - Running main action method: download_and_extract 23:42:25 INFO - mkdir: /builds/slave/test/build/tests 23:42:25 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')]} 23:42:25 INFO - trying https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json 23:42:25 INFO - Downloading https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 23:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 23:42:25 INFO - Downloaded 989 bytes. 23:42:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 23:42:25 INFO - Using the following test package requirements: 23:42:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 23:42:25 INFO - u'common': [u'target.common.tests.zip'], 23:42:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 23:42:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 23:42:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 23:42:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 23:42:25 INFO - u'mozbase': [u'target.common.tests.zip'], 23:42:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 23:42:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 23:42:25 INFO - u'web-platform': [u'target.common.tests.zip', 23:42:25 INFO - u'target.web-platform.tests.tar.gz'], 23:42:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 23:42:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 23:42:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip 23:42:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:42:25 INFO - Fetch https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip into memory 23:42:28 INFO - Content-Length response header: 54003984 23:42:28 INFO - Bytes received: 54003984 23:42:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 23:42:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip 23:42:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:42:38 INFO - Fetch https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip into memory 23:42:40 INFO - Content-Length response header: 54003984 23:42:40 INFO - Bytes received: 54003984 23:42:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.talos.tests.zip 23:42:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 23:42:52 INFO - Fetch https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.talos.tests.zip into memory 23:42:53 INFO - Content-Length response header: 14496050 23:42:53 INFO - Bytes received: 14496050 23:42:53 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')]} 23:42:53 INFO - trying https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:53 INFO - Downloading https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 23:42:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 23:42:55 INFO - Downloaded 61840933 bytes. 23:42:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:55 INFO - mkdir: /builds/slave/test/properties 23:42:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:42:55 INFO - Writing to file /builds/slave/test/properties/build_url 23:42:55 INFO - Contents: 23:42:55 INFO - build_url:https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:55 INFO - Running post-action listener: _resource_record_post_action 23:42:55 INFO - Running post-action listener: set_extra_try_arguments 23:42:55 INFO - [mozharness: 2017-08-16 06:42:55.204358Z] Finished download-and-extract step (success) 23:42:55 INFO - [mozharness: 2017-08-16 06:42:55.204566Z] Running populate-webroot step. 23:42:55 INFO - Running pre-action listener: _resource_record_pre_action 23:42:55 INFO - Running main action method: populate_webroot 23:42:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:42:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:42:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:42:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:42:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:42:55 INFO - 'tests': ['damp', 'tps']}, 23:42:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:42:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 23:42:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 23:42:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 23:42:55 INFO - 'other-e10s': {'tests': ['a11yr', 23:42:55 INFO - 'ts_paint', 23:42:55 INFO - 'tpaint', 23:42:55 INFO - 'sessionrestore', 23:42:55 INFO - 'sessionrestore_many_windows', 23:42:55 INFO - 'sessionrestore_no_auto_restore', 23:42:55 INFO - 'tabpaint']}, 23:42:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 23:42:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 23:42:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:42:55 INFO - 'tsvgr_opacity', 23:42:55 INFO - 'tart', 23:42:55 INFO - 'tscrollx', 23:42:55 INFO - 'tsvg_static']}, 23:42:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:42:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:42:55 INFO - 'talos_options': ['--mitmproxy', 23:42:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:42:55 INFO - '--firstNonBlankPaint'], 23:42:55 INFO - 'tests': ['tp6_google', 23:42:55 INFO - 'tp6_youtube', 23:42:55 INFO - 'tp6_amazon', 23:42:55 INFO - 'tp6_facebook']}, 23:42:55 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:42:55 INFO - 'talos_options': ['--stylo', 23:42:55 INFO - '--mitmproxy', 23:42:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:42:55 INFO - '--firstNonBlankPaint'], 23:42:55 INFO - 'tests': ['tp6_google', 23:42:55 INFO - 'tp6_youtube', 23:42:55 INFO - 'tp6_amazon', 23:42:55 INFO - 'tp6_facebook']}, 23:42:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:42:55 INFO - 'talos_options': ['--stylo', 23:42:55 INFO - '--stylo-threads=1', 23:42:55 INFO - '--mitmproxy', 23:42:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:42:55 INFO - '--firstNonBlankPaint'], 23:42:55 INFO - 'tests': ['tp6_google', 23:42:55 INFO - 'tp6_youtube', 23:42:55 INFO - 'tp6_amazon', 23:42:55 INFO - 'tp6_facebook']}, 23:42:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:42:55 INFO - 'talos_options': ['--xperf_path', 23:42:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:42:55 INFO - 'tests': ['tp5n']}}} 23:42:55 INFO - Running post-action listener: _resource_record_post_action 23:42:55 INFO - [mozharness: 2017-08-16 06:42:55.215910Z] Finished populate-webroot step (success) 23:42:55 INFO - [mozharness: 2017-08-16 06:42:55.216001Z] Running create-virtualenv step. 23:42:55 INFO - Running pre-action listener: _resource_record_pre_action 23:42:55 INFO - Running main action method: create_virtualenv 23:42:55 INFO - Creating virtualenv /builds/slave/test/build/venv 23:42:55 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 23:42:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:42:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 23:42:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:42:55 INFO - Using real prefix '/usr' 23:42:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:42:55 INFO - Installing distribute.............................................................................................................................................................................................done. 23:42:57 INFO - Installing pip.................done. 23:42:57 INFO - Return code: 0 23:42:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:42:57 INFO - Reading from file tmpfile_stdout 23:42:57 INFO - Output received: 23:42:57 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) 23:42:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:42:57 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')]} 23:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:57 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')]} 23:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x2a4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', '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 23:42:57 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 23:42:57 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 23:42:58 INFO - Using env: {'DISPLAY': ':0', 23:42:58 INFO - 'HOME': '/home/cltbld', 23:42:58 INFO - 'LANG': 'en_US.UTF-8', 23:42:58 INFO - 'LANGUAGE': 'en_US:en', 23:42:58 INFO - 'LOGNAME': 'cltbld', 23:42:58 INFO - 'MAIL': '/var/mail/cltbld', 23:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:58 INFO - 'MOZ_NO_REMOTE': '1', 23:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:58 INFO - 'NO_EM_RESTART': '1', 23:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:58 INFO - 'PWD': '/builds/slave/test', 23:42:58 INFO - 'SHELL': '/bin/bash', 23:42:58 INFO - 'SHLVL': '1', 23:42:58 INFO - 'TERM': 'linux', 23:42:58 INFO - 'TMOUT': '86400', 23:42:58 INFO - 'USER': 'cltbld', 23:42:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:58 INFO - '_': '/tools/buildbot/bin/python'} 23:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:58 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 23:42:58 INFO - Cleaning up... 23:42:58 INFO - Return code: 0 23:42:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:42:58 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')]} 23:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:58 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')]} 23:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x2a4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', '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 23:42:58 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 23:42:58 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 23:42:58 INFO - Using env: {'DISPLAY': ':0', 23:42:58 INFO - 'HOME': '/home/cltbld', 23:42:58 INFO - 'LANG': 'en_US.UTF-8', 23:42:58 INFO - 'LANGUAGE': 'en_US:en', 23:42:58 INFO - 'LOGNAME': 'cltbld', 23:42:58 INFO - 'MAIL': '/var/mail/cltbld', 23:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:58 INFO - 'MOZ_NO_REMOTE': '1', 23:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:58 INFO - 'NO_EM_RESTART': '1', 23:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:58 INFO - 'PWD': '/builds/slave/test', 23:42:58 INFO - 'SHELL': '/bin/bash', 23:42:58 INFO - 'SHLVL': '1', 23:42:58 INFO - 'TERM': 'linux', 23:42:58 INFO - 'TMOUT': '86400', 23:42:58 INFO - 'USER': 'cltbld', 23:42:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:58 INFO - '_': '/tools/buildbot/bin/python'} 23:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:58 INFO - Downloading/unpacking psutil>=3.1.1 23:42:58 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 23:42:58 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 23:42:58 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 23:42:58 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 23:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:42:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:42:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:42:59 INFO - Installing collected packages: psutil 23:42:59 INFO - Running setup.py install for psutil 23:42:59 INFO - building 'psutil._psutil_linux' extension 23:42:59 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 23:42:59 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 23:42:59 INFO - building 'psutil._psutil_posix' extension 23:42:59 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 23:43:00 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 23:43:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:43:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:43:00 INFO - Successfully installed psutil 23:43:00 INFO - Cleaning up... 23:43:00 INFO - Return code: 0 23:43:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:43:00 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')]} 23:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:00 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')]} 23:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x2a4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', '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 23:43:00 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 23:43:00 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 23:43:00 INFO - Using env: {'DISPLAY': ':0', 23:43:00 INFO - 'HOME': '/home/cltbld', 23:43:00 INFO - 'LANG': 'en_US.UTF-8', 23:43:00 INFO - 'LANGUAGE': 'en_US:en', 23:43:00 INFO - 'LOGNAME': 'cltbld', 23:43:00 INFO - 'MAIL': '/var/mail/cltbld', 23:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:00 INFO - 'MOZ_NO_REMOTE': '1', 23:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:00 INFO - 'NO_EM_RESTART': '1', 23:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:00 INFO - 'PWD': '/builds/slave/test', 23:43:00 INFO - 'SHELL': '/bin/bash', 23:43:00 INFO - 'SHLVL': '1', 23:43:00 INFO - 'TERM': 'linux', 23:43:00 INFO - 'TMOUT': '86400', 23:43:00 INFO - 'USER': 'cltbld', 23:43:00 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:00 INFO - '_': '/tools/buildbot/bin/python'} 23:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:43:01 INFO - Installing collected packages: mozsystemmonitor 23:43:01 INFO - Running setup.py install for mozsystemmonitor 23:43:01 INFO - Successfully installed mozsystemmonitor 23:43:01 INFO - Cleaning up... 23:43:01 INFO - Return code: 0 23:43:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:43:01 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')]} 23:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:01 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')]} 23:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:01 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 0x2a4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', '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 23:43:01 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 23:43:01 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 23:43:01 INFO - Using env: {'DISPLAY': ':0', 23:43:01 INFO - 'HOME': '/home/cltbld', 23:43:01 INFO - 'LANG': 'en_US.UTF-8', 23:43:01 INFO - 'LANGUAGE': 'en_US:en', 23:43:01 INFO - 'LOGNAME': 'cltbld', 23:43:01 INFO - 'MAIL': '/var/mail/cltbld', 23:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:01 INFO - 'MOZ_NO_REMOTE': '1', 23:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:01 INFO - 'NO_EM_RESTART': '1', 23:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:01 INFO - 'PWD': '/builds/slave/test', 23:43:01 INFO - 'SHELL': '/bin/bash', 23:43:01 INFO - 'SHLVL': '1', 23:43:01 INFO - 'TERM': 'linux', 23:43:01 INFO - 'TMOUT': '86400', 23:43:01 INFO - 'USER': 'cltbld', 23:43:01 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:01 INFO - '_': '/tools/buildbot/bin/python'} 23:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:01 INFO - Downloading/unpacking jsonschema==2.5.1 23:43:01 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 23:43:01 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 23:43:01 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 23:43:01 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 23:43:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:43:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:03 INFO - Downloading functools32-3.2.3-2.tar.gz 23:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:43:03 INFO - warning: no files found matching '*.txt' 23:43:03 INFO - no previously-included directories found matching 'build' 23:43:03 INFO - no previously-included directories found matching 'dist' 23:43:03 INFO - no previously-included directories found matching '.git*' 23:43:03 INFO - Installing collected packages: jsonschema, functools32 23:43:03 INFO - Running setup.py install for functools32 23:43:03 INFO - warning: no files found matching '*.txt' 23:43:03 INFO - no previously-included directories found matching 'build' 23:43:03 INFO - no previously-included directories found matching 'dist' 23:43:03 INFO - no previously-included directories found matching '.git*' 23:43:03 INFO - Successfully installed jsonschema functools32 23:43:03 INFO - Cleaning up... 23:43:03 INFO - Return code: 0 23:43:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:43:03 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')]} 23:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:03 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')]} 23:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x2a4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', '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 23:43:03 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 23:43:03 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 23:43:03 INFO - Using env: {'DISPLAY': ':0', 23:43:03 INFO - 'HOME': '/home/cltbld', 23:43:03 INFO - 'LANG': 'en_US.UTF-8', 23:43:03 INFO - 'LANGUAGE': 'en_US:en', 23:43:03 INFO - 'LOGNAME': 'cltbld', 23:43:03 INFO - 'MAIL': '/var/mail/cltbld', 23:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:03 INFO - 'MOZ_NO_REMOTE': '1', 23:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:03 INFO - 'NO_EM_RESTART': '1', 23:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:03 INFO - 'PWD': '/builds/slave/test', 23:43:03 INFO - 'SHELL': '/bin/bash', 23:43:03 INFO - 'SHLVL': '1', 23:43:03 INFO - 'TERM': 'linux', 23:43:03 INFO - 'TMOUT': '86400', 23:43:03 INFO - 'USER': 'cltbld', 23:43:03 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:03 INFO - '_': '/tools/buildbot/bin/python'} 23:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:43:03 INFO - Cleaning up... 23:43:03 INFO - Return code: 0 23:43:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:43:03 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')]} 23:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:03 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')]} 23:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x2a4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', '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 23:43:03 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 23:43:03 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 23:43:03 INFO - Using env: {'DISPLAY': ':0', 23:43:03 INFO - 'HOME': '/home/cltbld', 23:43:03 INFO - 'LANG': 'en_US.UTF-8', 23:43:03 INFO - 'LANGUAGE': 'en_US:en', 23:43:03 INFO - 'LOGNAME': 'cltbld', 23:43:03 INFO - 'MAIL': '/var/mail/cltbld', 23:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:03 INFO - 'MOZ_NO_REMOTE': '1', 23:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:03 INFO - 'NO_EM_RESTART': '1', 23:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:03 INFO - 'PWD': '/builds/slave/test', 23:43:03 INFO - 'SHELL': '/bin/bash', 23:43:03 INFO - 'SHLVL': '1', 23:43:03 INFO - 'TERM': 'linux', 23:43:03 INFO - 'TMOUT': '86400', 23:43:03 INFO - 'USER': 'cltbld', 23:43:03 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:03 INFO - '_': '/tools/buildbot/bin/python'} 23:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:03 INFO - Downloading/unpacking blobuploader==1.2.4 23:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:04 INFO - Downloading blobuploader-1.2.4.tar.gz 23:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:43:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:43:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:05 INFO - Downloading docopt-0.6.1.tar.gz 23:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:43:05 INFO - Installing collected packages: blobuploader, requests, docopt 23:43:05 INFO - Running setup.py install for blobuploader 23:43:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:43:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:43:05 INFO - Running setup.py install for requests 23:43:05 INFO - Running setup.py install for docopt 23:43:06 INFO - Successfully installed blobuploader requests docopt 23:43:06 INFO - Cleaning up... 23:43:06 INFO - Return code: 0 23:43:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:43:06 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')]} 23:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:06 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')]} 23:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x2a4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', '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 23:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:43:06 INFO - Using env: {'DISPLAY': ':0', 23:43:06 INFO - 'HOME': '/home/cltbld', 23:43:06 INFO - 'LANG': 'en_US.UTF-8', 23:43:06 INFO - 'LANGUAGE': 'en_US:en', 23:43:06 INFO - 'LOGNAME': 'cltbld', 23:43:06 INFO - 'MAIL': '/var/mail/cltbld', 23:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:06 INFO - 'MOZ_NO_REMOTE': '1', 23:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:06 INFO - 'NO_EM_RESTART': '1', 23:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:06 INFO - 'PWD': '/builds/slave/test', 23:43:06 INFO - 'SHELL': '/bin/bash', 23:43:06 INFO - 'SHLVL': '1', 23:43:06 INFO - 'TERM': 'linux', 23:43:06 INFO - 'TMOUT': '86400', 23:43:06 INFO - 'USER': 'cltbld', 23:43:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:06 INFO - '_': '/tools/buildbot/bin/python'} 23:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:43:06 INFO - Running setup.py (path:/tmp/pip-fSUXyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:43:06 INFO - Running setup.py (path:/tmp/pip-tOjV8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:43:06 INFO - Running setup.py (path:/tmp/pip-dmpI00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:43:06 INFO - Running setup.py (path:/tmp/pip-zYAavv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:43:06 INFO - Running setup.py (path:/tmp/pip-bvYeAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:43:06 INFO - Running setup.py (path:/tmp/pip-mhoWv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:43:06 INFO - Running setup.py (path:/tmp/pip-cvSknt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:43:06 INFO - Running setup.py (path:/tmp/pip-9l7v8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:43:06 INFO - Running setup.py (path:/tmp/pip-kzKcce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:43:06 INFO - Running setup.py (path:/tmp/pip-rERz8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:43:06 INFO - Running setup.py (path:/tmp/pip-586hum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:43:07 INFO - Running setup.py (path:/tmp/pip-sUQ7XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:43:07 INFO - Running setup.py (path:/tmp/pip-pRz_bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:43:07 INFO - Running setup.py (path:/tmp/pip-VytR_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:07 INFO - Running setup.py (path:/tmp/pip-FAvFmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:43:07 INFO - Running setup.py (path:/tmp/pip-tugUMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:43:07 INFO - Running setup.py (path:/tmp/pip-8zbIAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:43:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:43:07 INFO - Running setup.py install for manifestparser 23:43:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:43:07 INFO - Running setup.py install for mozcrash 23:43:07 INFO - Running setup.py install for mozdebug 23:43:07 INFO - Running setup.py install for mozdevice 23:43:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:43:07 INFO - Running setup.py install for mozfile 23:43:07 INFO - Running setup.py install for mozhttpd 23:43:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozinfo 23:43:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozInstall 23:43:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozleak 23:43:08 INFO - Running setup.py install for mozlog 23:43:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for moznetwork 23:43:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozprocess 23:43:08 INFO - Running setup.py install for mozprofile 23:43:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozrunner 23:43:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozscreenshot 23:43:09 INFO - Running setup.py install for moztest 23:43:09 INFO - Running setup.py install for mozversion 23:43:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:43:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:43:09 INFO - Cleaning up... 23:43:09 INFO - Return code: 0 23:43:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x2a4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', '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 23:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:43:09 INFO - Using env: {'DISPLAY': ':0', 23:43:09 INFO - 'HOME': '/home/cltbld', 23:43:09 INFO - 'LANG': 'en_US.UTF-8', 23:43:09 INFO - 'LANGUAGE': 'en_US:en', 23:43:09 INFO - 'LOGNAME': 'cltbld', 23:43:09 INFO - 'MAIL': '/var/mail/cltbld', 23:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:09 INFO - 'MOZ_NO_REMOTE': '1', 23:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:09 INFO - 'NO_EM_RESTART': '1', 23:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:09 INFO - 'PWD': '/builds/slave/test', 23:43:09 INFO - 'SHELL': '/bin/bash', 23:43:09 INFO - 'SHLVL': '1', 23:43:09 INFO - 'TERM': 'linux', 23:43:09 INFO - 'TMOUT': '86400', 23:43:09 INFO - 'USER': 'cltbld', 23:43:09 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:09 INFO - '_': '/tools/buildbot/bin/python'} 23:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:43:09 INFO - Running setup.py (path:/tmp/pip-c6xMad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:43:09 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)) 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:43:09 INFO - Running setup.py (path:/tmp/pip-rlClLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:43:09 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)) 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:43:09 INFO - Running setup.py (path:/tmp/pip-1NAr7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:43:09 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)) 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:43:09 INFO - Running setup.py (path:/tmp/pip-GxcVbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:43:09 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)) 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:43:09 INFO - Running setup.py (path:/tmp/pip-nF_B_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:43:09 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)) 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:43:09 INFO - Running setup.py (path:/tmp/pip-Mjj7Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:43:09 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)) 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:43:09 INFO - Running setup.py (path:/tmp/pip-MIPV8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:43:09 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)) 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:43:09 INFO - Running setup.py (path:/tmp/pip-pL1F9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:43:10 INFO - Running setup.py (path:/tmp/pip-nHpN7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:43:10 INFO - Running setup.py (path:/tmp/pip-_x0zso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:43:10 INFO - Running setup.py (path:/tmp/pip-YvKlaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:43:10 INFO - Running setup.py (path:/tmp/pip-qOxEvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:43:10 INFO - Running setup.py (path:/tmp/pip-6qMeNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:43:10 INFO - Running setup.py (path:/tmp/pip-Yy_iXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:10 INFO - Running setup.py (path:/tmp/pip-n1jxvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:43:10 INFO - Running setup.py (path:/tmp/pip-6TPXKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:43:10 INFO - Running setup.py (path:/tmp/pip-eiPjVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:43:10 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)) 23:43:10 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)) 23:43:10 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)) 23:43:10 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)) 23:43:10 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)) 23:43:10 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)) 23:43:10 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)) 23:43:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:43:10 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 23:43:10 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 23:43:10 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 23:43:10 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 23:43:11 INFO - Downloading blessings-1.6.tar.gz 23:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:43:11 INFO - Installing collected packages: blessings 23:43:11 INFO - Running setup.py install for blessings 23:43:11 INFO - Successfully installed blessings 23:43:11 INFO - Cleaning up... 23:43:12 INFO - Return code: 0 23:43:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:43:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:43:12 INFO - Reading from file tmpfile_stdout 23:43:12 INFO - Current package versions: 23:43:12 INFO - argparse == 1.2.1 23:43:12 INFO - blessings == 1.6 23:43:12 INFO - blobuploader == 1.2.4 23:43:12 INFO - docopt == 0.6.1 23:43:12 INFO - functools32 == 3.2.3-2 23:43:12 INFO - jsonschema == 2.5.1 23:43:12 INFO - manifestparser == 1.1 23:43:12 INFO - mozInstall == 1.13 23:43:12 INFO - mozcrash == 1.0 23:43:12 INFO - mozdebug == 0.1 23:43:12 INFO - mozdevice == 0.51 23:43:12 INFO - mozfile == 1.2 23:43:12 INFO - mozhttpd == 0.7 23:43:12 INFO - mozinfo == 0.10 23:43:12 INFO - mozleak == 0.1 23:43:12 INFO - mozlog == 3.5 23:43:12 INFO - moznetwork == 0.27 23:43:12 INFO - mozprocess == 0.25 23:43:12 INFO - mozprofile == 0.28 23:43:12 INFO - mozrunner == 6.13 23:43:12 INFO - mozscreenshot == 0.1 23:43:12 INFO - mozsystemmonitor == 0.3 23:43:12 INFO - moztest == 0.8 23:43:12 INFO - mozversion == 1.4 23:43:12 INFO - psutil == 3.1.1 23:43:12 INFO - requests == 1.2.3 23:43:12 INFO - wsgiref == 0.1.2 23:43:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:43: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')]} 23:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43: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')]} 23:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:12 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 0x2a4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', '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 23:43:12 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 23:43:12 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 23:43:12 INFO - Using env: {'DISPLAY': ':0', 23:43:12 INFO - 'HOME': '/home/cltbld', 23:43:12 INFO - 'LANG': 'en_US.UTF-8', 23:43:12 INFO - 'LANGUAGE': 'en_US:en', 23:43:12 INFO - 'LOGNAME': 'cltbld', 23:43:12 INFO - 'MAIL': '/var/mail/cltbld', 23:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:12 INFO - 'MOZ_NO_REMOTE': '1', 23:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:12 INFO - 'NO_EM_RESTART': '1', 23:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:12 INFO - 'PWD': '/builds/slave/test', 23:43:12 INFO - 'SHELL': '/bin/bash', 23:43:12 INFO - 'SHLVL': '1', 23:43:12 INFO - 'TERM': 'linux', 23:43:12 INFO - 'TMOUT': '86400', 23:43:12 INFO - 'USER': 'cltbld', 23:43:12 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:12 INFO - '_': '/tools/buildbot/bin/python'} 23:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 23:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 23:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:43:13 INFO - Installing collected packages: simplejson 23:43:13 INFO - Running setup.py install for simplejson 23:43:13 INFO - building 'simplejson._speedups' extension 23:43:13 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 23:43:14 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 23:43:14 INFO - Successfully installed simplejson 23:43:14 INFO - Cleaning up... 23:43:14 INFO - Return code: 0 23:43:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:43:14 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')]} 23:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:14 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')]} 23:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:14 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 0x2a4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', '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 23:43:14 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 23:43:14 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 23:43:14 INFO - Using env: {'DISPLAY': ':0', 23:43:14 INFO - 'HOME': '/home/cltbld', 23:43:14 INFO - 'LANG': 'en_US.UTF-8', 23:43:14 INFO - 'LANGUAGE': 'en_US:en', 23:43:14 INFO - 'LOGNAME': 'cltbld', 23:43:14 INFO - 'MAIL': '/var/mail/cltbld', 23:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:14 INFO - 'MOZ_NO_REMOTE': '1', 23:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:14 INFO - 'NO_EM_RESTART': '1', 23:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:14 INFO - 'PWD': '/builds/slave/test', 23:43:14 INFO - 'SHELL': '/bin/bash', 23:43:14 INFO - 'SHLVL': '1', 23:43:14 INFO - 'TERM': 'linux', 23:43:14 INFO - 'TMOUT': '86400', 23:43:14 INFO - 'USER': 'cltbld', 23:43:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:14 INFO - '_': '/tools/buildbot/bin/python'} 23:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:43:14 INFO - Cleaning up... 23:43:14 INFO - Return code: 0 23:43:14 INFO - Running post-action listener: _resource_record_post_action 23:43:14 INFO - Running post-action listener: _start_resource_monitoring 23:43:14 INFO - Starting resource monitoring. 23:43:14 INFO - [mozharness: 2017-08-16 06:43:14.989714Z] Finished create-virtualenv step (success) 23:43:14 INFO - [mozharness: 2017-08-16 06:43:14.990228Z] Running install step. 23:43:14 INFO - Running pre-action listener: _resource_record_pre_action 23:43:14 INFO - Running main action method: install 23:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:43:15 INFO - Reading from file tmpfile_stdout 23:43:15 INFO - Detecting whether we're running mozinstall >=1.0... 23:43:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:43:15 INFO - Reading from file tmpfile_stdout 23:43:15 INFO - Output received: 23:43:15 INFO - Usage: mozinstall [options] installer 23:43:15 INFO - Options: 23:43:15 INFO - -h, --help show this help message and exit 23:43:15 INFO - -d DEST, --destination=DEST 23:43:15 INFO - Directory to install application into. [default: 23:43:15 INFO - "/builds/slave/test"] 23:43:15 INFO - --app=APP Application being installed. [default: firefox] 23:43:15 INFO - mkdir: /builds/slave/test/build/application 23:43:15 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'] 23:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 23:43:33 INFO - Reading from file tmpfile_stdout 23:43:33 INFO - Output received: 23:43:33 INFO - /builds/slave/test/build/application/firefox/firefox 23:43:33 INFO - Running post-action listener: _resource_record_post_action 23:43:33 INFO - [mozharness: 2017-08-16 06:43:33.281766Z] Finished install step (success) 23:43:33 INFO - [mozharness: 2017-08-16 06:43:33.282051Z] Running setup-mitmproxy step. 23:43:33 INFO - Running pre-action listener: _resource_record_pre_action 23:43:33 INFO - Running main action method: setup_mitmproxy 23:43:33 INFO - Skipping: mitmproxy is not required 23:43:33 INFO - Running post-action listener: _resource_record_post_action 23:43:33 INFO - [mozharness: 2017-08-16 06:43:33.283210Z] Finished setup-mitmproxy step (success) 23:43:33 INFO - [mozharness: 2017-08-16 06:43:33.283432Z] Running run-tests step. 23:43:33 INFO - Running pre-action listener: _resource_record_pre_action 23:43:33 INFO - Running pre-action listener: _set_gcov_prefix 23:43:33 INFO - Running main action method: run_tests 23:43:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:43:33 INFO - Python 2.7.3 23:43:33 INFO - Return code: 0 23:43:33 INFO - grabbing minidump binary from tooltool 23:43: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')]} 23:43:33 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 0x2cf2bb0>, '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 0x2cf3ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3f40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:43:33 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 23:43:33 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 23:43:33 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 23:43:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:43:33 INFO - Return code: 0 23:43:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:43:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:43:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:43:33 INFO - ENV: RUST_BACKTRACE is now full 23:43:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:43:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:43:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 23:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 23:43:33 INFO - Using env: {'DISPLAY': ':0', 23:43:33 INFO - 'HOME': '/home/cltbld', 23:43:33 INFO - 'LANG': 'en_US.UTF-8', 23:43:33 INFO - 'LANGUAGE': 'en_US:en', 23:43:33 INFO - 'LOGNAME': 'cltbld', 23:43:33 INFO - 'MAIL': '/var/mail/cltbld', 23:43:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:43:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:33 INFO - 'MOZ_NO_REMOTE': '1', 23:43:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:43:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:33 INFO - 'NO_EM_RESTART': '1', 23:43:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:33 INFO - 'PWD': '/builds/slave/test', 23:43:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:43:33 INFO - 'RUST_BACKTRACE': 'full', 23:43:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:43:33 INFO - 'SHELL': '/bin/bash', 23:43:33 INFO - 'SHLVL': '1', 23:43:33 INFO - 'TERM': 'linux', 23:43:33 INFO - 'TMOUT': '86400', 23:43:33 INFO - 'USER': 'cltbld', 23:43:33 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352', 23:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:33 INFO - '_': '/tools/buildbot/bin/python'} 23:43:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 23:43:33 INFO - mozversion application_buildid: 20170816055606 23:43:33 INFO - mozversion application_changeset: 9ab2470a3210324bc11320531b15d195aaf05051 23:43:33 INFO - mozversion application_display_name: Nightly 23:43:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:43:33 INFO - mozversion application_name: Firefox 23:43:33 INFO - mozversion application_remotingname: firefox 23:43:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:43:33 INFO - mozversion application_vendor: Mozilla 23:43:33 INFO - mozversion application_version: 57.0a1 23:43:33 INFO - mozversion platform_buildid: 20170816055606 23:43:33 INFO - mozversion platform_changeset: 9ab2470a3210324bc11320531b15d195aaf05051 23:43:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:43:33 INFO - mozversion platform_version: 57.0a1 23:43:33 INFO - using testdate: 1502865813 23:43:33 INFO - actual date: 1502865813 23:43:33 INFO - starting webserver on 'localhost:38323' 23:43:33 INFO - SUITE-START | Running 2 tests 23:43:33 INFO - TEST-START | dromaeo_css 23:43:33 INFO - Initialising browser for dromaeo_css test... 23:43:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38323/getInfo.html -profile /tmp/tmpGC0niw/profile 23:43:33 INFO - TEST-INFO | started process 3412 (/builds/slave/test/build/application/firefox/firefox http://localhost:38323/getInfo.html) 23:43:39 INFO - TEST-INFO | 3412: exit 0 23:43:39 INFO - Browser initialized. 23:43:39 INFO - Running cycle 1/1 for dromaeo_css test... 23:43:39 INFO - TEST-INFO | started process 3582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGC0niw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:40 INFO - PID 3582 | 23:43:40 INFO - PID 3582 | (/builds/slave/test/build/application/firefox/firefox:3630): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:43:40 INFO - PID 3582 | 23:43:51 INFO - PID 3582 | RSS: Main: 164560896 23:43:51 INFO - PID 3582 | 23:46:50 INFO - PID 3582 | Cycle 1(1): loaded http://localhost:38323/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38323/tests/dromaeo/cssquery-ext.html) 23:46:51 INFO - PID 3582 | RSS: Main: 171982848 23:46:51 INFO - PID 3582 | 23:49:53 INFO - PID 3582 | Cycle 1(1): loaded http://localhost:38323/tests/dromaeo/cssquery-ext.html (next: http://localhost:38323/tests/dromaeo/cssquery-jquery.html) 23:49:53 INFO - PID 3582 | RSS: Main: 169459712 23:49:53 INFO - PID 3582 | 23:52:55 INFO - PID 3582 | Cycle 1(1): loaded http://localhost:38323/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38323/tests/dromaeo/cssquery-mootools.html) 23:52:56 INFO - PID 3582 | RSS: Main: 171352064 23:52:56 INFO - PID 3582 | 23:55:57 INFO - PID 3582 | Cycle 1(1): loaded http://localhost:38323/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38323/tests/dromaeo/cssquery-prototype.html) 23:55:58 INFO - PID 3582 | RSS: Main: 167837696 23:55:58 INFO - PID 3582 | 23:59:01 INFO - PID 3582 | Cycle 1(1): loaded http://localhost:38323/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38323/tests/dromaeo/cssquery-yui.html) 23:59:02 INFO - PID 3582 | RSS: Main: 173203456 23:59:02 INFO - PID 3582 | 00:02:04 INFO - PID 3582 | Cycle 1(1): loaded http://localhost:38323/tests/dromaeo/cssquery-yui.html (next: http://localhost:38323/tests/dromaeo/cssquery-dojo.html) 00:02:04 INFO - PID 3582 | RSS: Main: 174383104 00:02:04 INFO - PID 3582 | 00:02:04 INFO - PID 3582 | __start_tp_report 00:02:04 INFO - PID 3582 | _x_x_mozilla_page_load 00:02:04 INFO - PID 3582 | _x_x_mozilla_page_load_details 00:02:04 INFO - PID 3582 | |i|pagename|runs| 00:02:04 INFO - PID 3582 | |0;dojo.html;3142.497200447928;3143.0885043337435;3166.1926208816753;3171.3974344874473;3183.076907696768;6150.200473938393;6220.40906113919;6276.121343011976;6286.9056964145575;6312;6097.2073630427985;6221.844453888655;6230.221222347207;6240.937590624092;6247.656378899159;5712.800051998181;5723.170140329649;5734.655920644754;5748.770049198048;5751.597388182829;5742.540596752271;5746.0806270996645;5750.482456578907;5795.4784069433745;5825.446582574648;5755.366909639936;5806.44838740319;5819.592628516006;5826.359100498942;5883.205767221413;5652.717364131818;5692.060809966371;5733.598648094635;5733.799317023926;5802.216700745387;5478.780848766045;5578.135389014709;5615.382307946123;5666.178404131378;5691;6032.185654936615;6138.232720909887;6155.938440615581;6204.255489341263;6229.25248970122;6644.900326495106;6655.101561289212;6667.633280169589;6742.393184613359;6746.392824645756;6654.334566543355;6654.467642588581;6673.499487538405;6678.866422671568;6694.096296999892;6099.84750381244;6181.196444462191;6181.938180618181;6190.226221722285;6196.907046394308;6728.629925354153;6730.259671436138;6820.6930688119155;6823.28355522663;6833.794986150423;6404.455621272151;6458.6770661466735;6497.480201583862;6564.310747371553;6568.6058836469965;6695.899561506581;6709.563878347892;6744.460443164535;6746;6771.01820236063;6637;6648.33516648341;6705.966470167716;6727.798166055026;6742.9662851685425;6555.475561955032;6657.13457250564;6675.198976122896;6765.323467653294;6774.085498457645;5420.07858664028;5431.511163995259;5446.101393270066;5455.236266922555;5491.176323551499;4648.511906249795;4660.13787449323;4705.811767529261;4726.314684370747;4732.716037037789;5754.88490230193;5766.106253530709;5780.942190578125;5830.941690583125;5871.6183448075735;6684.799456016327;6704.296048914891;6708.664566771739;6709.161354830646;6716.932830671729;5734.39788822176;5772.249607550992;5785.71071446426;5870.236869206976;5875.8248350330105;5899.793507227227;5955.52355811534;5972.492338151219;5982.521398288213;5983.341832398432;6426.935730642634;6465.935340646627;6481.1898512684975;6497.18785151856;6504.414602685781;6752.257251702211;6761.391474767294;6768.695408706719;6773.593584384953;6774.187097548129;6476.676166191766;6481.773137940149;6551.672416379257;6554.442872355903;6563.737450501926;6579.374959378852;6601;6683.465322774264;6691.59850408977;6691.698873550605;6681.665916704243;6723.058771772054;6820.420264277592;6825.385715285648;6825.863482730417;6402.967985160044;6409.7115629795835;6415.06981487691;6453.09656648079;6454.741810327534;6365.554411191172;6409.519286053472;6447.742090316335;6468.611883287018;6491.578047426902;6305.306416294296;6340.873182536231;6396.200474940632;6405.423511883952;6412.294647588855;6437.452816510649;6565.540412171103;6574.868502629825;6606.636634985122;6664.033715111184;6240.063990401476;6319.9052014218905;6346.587471814318;6355.618662880242;6441.323661015525 00:02:04 INFO - PID 3582 | |1;ext.html;814.7922279818646;832.3091833777964;866.8526350520413;874.2350443362059;884.6726711116884;42289;42869.57130428699;43122;43243;43271.35092973604;40124.79937600315;40293.39559906597;40520.39219411704;40553.59446405535;40570.18859622806;7078.646067696607;7212.603306818123;7213.963930180342;7216.206217316091;7219.061522002133;7031.789046328593;7105.9644701776415;7109.715611375539;7109.893351599704;7110.3245191706965;7055.6472176391235;7080.150381954173;7086.114235720535;7090.71637134514;7097.964510177468;7008.088948436722;7049.7885063448175;7051.753188638424;7054;7054.964725176393;6461.773837915651;6476.740930362827;6488.28628850826;6508.93491065088;6514.153160089206;35385.64614353849;35598.46602300968;35643.643563564554;35677.28645427103;35701.64298357009;3425.383430982422;3436.329915666446;3438.6561343865665;3449.4653328734084;3450.4996775467416;28412;28496.430071398456;28538.143855684157;28547.857260713772;28610.42779144426;4470.865874023784;4535.387722657432;4548.681592288541;4573.062522182944;4581.931271030937;188388;190188.0490597552;190694;190759;191191;21861.562768744538;21885.234016809336;21947.231846885603;21960.560788784136;21961.450963725714;22281.3315600529;22323.888380557994;22412.319076069034;22432.214872479384;22432.32703018912;13253.271070091045;13478;13482.460701572023;13484.393202305724;13485.797713034312;13248.072634915463;13260.469581216836;13264;13348.199108053548;13354.53259135945;5829.854253643608;5899.587028908021;5938.762449502058;5941.197938278364;5949.286085669747;2405.314485371661;2416.6979127609047;2432.7932125769153;2440.8535487870786;2458.4960083182905;1014.4674046125843;1018.9847152292573;1019.23557332001;1022.928395012342;1023.411538365428;23499;23596;23638.881805590863;23773.167939122046;24080.87959560191;1120.490176969477;1122.6014764758556;1126.5155982927256;1137.397179494869;1143.4911464398429;12334;12563.937180314222;12586.118971671895;12598.748025039447;12602;212826;214334;214393;214576;215537;53963.730181348845;53972.19041714377;56328.71835640795;59361.10958335629;59980.40019599835;1497.445945000335;1517.681286929735;1522.649790548158;1526.8854835887353;1527.9236038198046;27809;28133.296667582654;28189.154325370273;28504.57243141313;29172.27069323284;39000;39137.608623913395;39445.21109577735;39507.209855803296;39603.207935840546;185778;186654;186777;186886;186970;35304;35346.64653353434;35361.46957795584;35428.46857297194;36919;47722.28416573824;47920.520794793;48101.518984811104;48500.5149948496;48522.27216591824;34451.483227752105;35170.47244291286;35281.29437411186;36021.63978360183;36280.63719362773;34708.47937280993;34971.47542786809;35299.82350088233;35337.46993795044;35517.289654207285;38415.23169536538;38488;38595.2280954385;38806.6119338803;39432.21135577215;33899.4915076279;33910.321793564486;34071.4889276666;34133.82933085319;34760.304793904485;24514.877425612758;24798.132065377624;25071.623925640764;25088.62367064459;25249.368765781004 00:02:04 INFO - PID 3582 | |2;jquery.html;579.099500277069;581.2008488328547;582.170407169783;583.6906439587018;602.2772672792648;22618.321450356496;22624.321270361874;23426;23462.413439663975;23543.764562354372;26475.470490590178;27308.04421845236;27372.726272737265;27415.45169096622;27462.5880611791;7014.754483593075;7179.748708795193;7185.604791736452;7186.13766348039;7189.424846012333;6668.899966500507;6969.860602787941;6969.930300697004;6978.371946524811;6990.266022067686;6944.47916406269;6956.860862782742;6959.234484206733;6960.825979350531;6961.373476387124;6959.547629404073;6962.582245065287;6964.338387853146;6966.477514186457;6966.651667416634;6811.284815094443;6827.0783444234885;6848.691808868563;6852.314768523158;6860.691268892861;30757.38485230283;31974.520382194285;32223;32262.193445163823;32356.029319120466;1954.0913475233942;2003.5592169722638;2004.2684420186672;2004.5088953206412;2005.1077270614583;20555.38333849987;21629.242976495905;21639.45901352463;21650.56698866014;21652.133914643397;2531;2536.6321883327;2609.608558716189;2670.7462791034823;2673.9732602673917;135307;143098.28450857784;143331;143581.28209358992;143971;21203.89398053;21771.346859594236;21815.454613634785;22166.889165554392;22340.218092367013;43446;43503.34744978828;43687.378757274666;43888.3416748749;43910;11376.886231137749;11624;11760;11820.586279480176;11898.821517677241;9781.364211326383;9781.510924453749;9801.656942006995;9867.30928834989;9933.304668673269;11746.765064698659;11831.763364732657;11852.822207666892;12003.579874704343;12064.698382540506;4460.487043989918;4488.573585509372;4581.770911454414;4596.747178905125;4685.601723853442;975.9707208783748;986.156835905305;987.8863930647924;991.5389343955095;1008.4907121903539;19598.608027839364;19727.40817775469;19757.209711611664;19901.402957911287;20236.291729789387;1029.5006921642996;1033.121846430528;1048.2714513413257;1053.378506681062;1054.9894501054891;10882.129429645609;11049.668509944715;11079.279846809932;11222.719432014264;11288.22365042403;445797;448008;449851;459548;459846;111914;112991.43504282426;113716.43141784404;114125.42937285261;115077;1075.2580719303655;1106.468894930438;1121.9046381057701;1197.9580714674944;1211.8969887559656;20803.791962080184;21664.675029874248;22327.330180093973;22675.773242268027;22747.772522274565;59127;63177.68411157915;65283.347166527725;65557;65724.67137664281;80293;80423.59788201022;80562;82677.17322826695;83919;20127;20436.591268174256;20535.38393848187;21145.365639030853;21948.670769938784;22180.334589962327;22267.88866055724;22291.99686014166;22411.551768964855;23801.880990594935;18341.17464714118;18455.53861153482;18807.811921880606;18917.148728307533;18920.810791891905;15752.92123539375;16153.838461615233;16567.834321656628;16571.91714041422;17945.282188712306;18457;19705.704414434083;19929.402117936486;20015.599688005866;20041.799582003994;21320.93395330258;21337;21409.892950535148;21472.892635536722;21542;17039.233234504725;17163.742543862103;17175.57061073483;17246.741298880275;17391 00:02:04 INFO - PID 3582 | |3;mootools.html;1345.7644912140377;1391.944322227111;1399.2514005007324;1403.200175899737;1403.7192561487705;13607.251601161932;13852.445902163901;14148.151110933351;14257.643558911032;14271.928640356784;14359;14588.124712517256;14596.489122880701;14609.488667896625;14616.196109213988;2694.2186765837882;2736.151792944194;2737.86310684465;2738.315421144714;2739.9726002740017;2615.796733502591;2632.8420294782277;2666.799990000748;2668.119520558211;2677.5046616376035;2603.3882037721214;2629.2900916752465;2643.7884969202514;2669.21258228822;2682.275785537913;2627.632131501591;2653.3764565327133;2657.747513986178;2657.7740892024203;2664.214056853233;2573.806964477653;2595.156574113421;2600.1679462571983;2603.4142317978494;2629.789616830649;13334.19994800315;13610.455581776816;13613.659658508517;13616;13620.591382258548;7396.260373962615;7620.314171724516;7638.465307428482;7647.082350118021;7662.808429789244;5010.423801262865;5084.847454576368;5125.564327032207;5209.817656382046;5247.553957913544;1878.605492846504;1886.1983656945881;1897.7343171955938;1933.5456167800555;1944.3000519812856;22087.889560552256;22227.22204722843;22244;22314;22339.55320893573;6378.2346118466085;6381.840453988688;6534.575252608565;6597.571157874723;6608.306127856602;15755.842441575667;15781.605459863595;15789.921050394674;15804.182519010232;15823.525294241192;7433.442491813135;7562.395008399315;7563.016807814949;7566;7571.621418929031;5445.50990410857;6041.637501749821;6053.364396738367;6993.0209770632155;7069.646517674199;4946.851594452172;5075.593952483792;5079.796808127633;5106.259592359162;5155.175171972466;1481.9851801482064;1487.9032862863878;1489.1809504772332;1493.3429291111877;1500;871.904090550039;893.9150780675825;894.4007514964989;896.6503063805121;902.9954850225707;8253.504789712637;8431.873521897176;8774.561271936378;8934.955325223333;9020;943.1417410156862;969.3602222533094;976.951152442375;979.5445118020154;981.5484876956538;4890.486498917562;4969.751512424365;4996;5008.323876276729;5017;18364;18922.716159257623;19053.42839714811;19391.51521211981;19451.416457506297;18899.433017009236;19032.048397580344;19055.142518586697;19199.136038878285;19256.326028588934;10374.481275936172;10693.251472396858;10812.135029197645;10919.836202456969;11046.834297485704;7313.232110628307;7476.140243872024;7505.624718763931;7512.5492470451945;7528.397728181842;16501.91749041247;16805.243764030405;16861.241244144287;17015.489535313962;17043.829561704224;17081.48755537336;17120.14399280056;17179.656406872044;17229.82770172282;17242.913785430992;10030.548625311732;10270.948645256725;10276.332038417479;10284;10334.741631459274;12849.357532123544;12854.421551030038;12892.419841106985;13044.934775326063;13047;10477;10582.365058096539;10679.786404272027;10813.459327033459;10937.12502999774;10248.231382646181;10311.432871192157;10373.533191006272;10407.843882341922;10585.100266477435;9443.055694430503;9598.520073996411;9599.560065990157;9600.615975360908;9604.85592716096;6785.728570857111;6834.282400347892;6853.7943861684225;6901.24086350491;6903.447724181953;6922.307769223037;7016.087908572057;7037.225905150532;7050.717971281297;7205.423566114593 00:02:04 INFO - PID 3582 | |4;prototype.html;491.63373286901265;499.5329367041816;500.5770124245013;520.3053923012777;525.4351572060034;6114.523617934732;6179.845503862406;6217.937820621803;6241.282252540959;6273.372662733725;5873.177755114288;6069.78755743549;6087.295557243968;6088.908666370008;6134.2025536680285;4924.901501969958;4948.614387971374;4953.331300274453;4953.851384458454;4956.87607809804;4783.856484305476;4900.534449227318;4949.208126699728;4951.23255895335;4984.975075124619;4919.893024069574;4926.162552366089;4939.876503087434;4941.678790878599;4955.355803745526;4881.243407271843;4891.804327826882;4903.53416425439;4922.138625740481;4932.556069953685;4429.446319210098;4462.9107417851465;4476.082403107355;4478.8880277992985;4486.192485352635;6016.608920420203;6039.3960603939695;6068.787592434288;6083.756649734005;6098.57309988301;5651.463111004489;5656.981743286206;5668.518175955049;5680;5751.511121554631;6522.7390904363765;6532.41208291256;6533.705983230766;6542.953127499625;6584.374484423972;4897.755112244409;4901.304282644532;4925.975370123162;4928.186849169882;4933.28467372229;6780.627065511444;6797.456203503757;6838.452923766087;6844.2129155147295;6934.826629334257;4960.727160006162;5007.874803129878;5022.573081288058;5030.622703297267;5045.470225626256;5093.847184584469;5104.412992505835;5104.489551044866;5124.641275110706;5145.408278048072;5566.610337276433;5653.9151912721345;5664.320281566238;5677.148427735872;5680.6591604503865;6539.378759017885;6558.245801732862;6604.207495100619;6604.801855944329;6665.733650558834;1676.8323167683134;1681.6048228666255;1733.9826601734073;1750.7111326631218;1759.938402155944;1209.989658635032;1214.0651698192341;1217.0993464836135;1223.1315765806198;1234.6851552854143;5664.745086471119;5691.601587888808;5702.747414771142;5757.251557297608;5773.538116950634;6701.620924571805;6709.563878347892;6722.764703235363;6759.797206083826;6800.897986530206;5705.22979397776;5720.599558030898;5721.942780572224;5745.2818397700285;5775.873704627641;3576.1774791798034;3579.3378225028455;3595.40675788492;3605.531280933462;3628.310620982005;6518.380753828379;6526.804195874131;6546.869062618721;6584.6378449184795;6587.473002159816;6861.691223894937;6896.517243792886;6929.549579277432;6957.9304206958295;6959.164900211906;6382.20222472191;6421.582597131265;6454.257760357619;6498.902516462257;6521.011091617008;6691.799246022627;6715.932840671726;6723.327667233238;6791.286914873867;6797.1843378794865;6587.7483278177;6637;6693.397594216543;6714.227863795726;6715.227748808949;6503;6518.024005356634;6548.574342667902;6563.606183628997;6564.146660934048;4994.375703037121;5011.624128190473;5011.724355160502;5030.9245361320345;5056.898862022813;6595.868082638416;6722.9663851680425;6739.59562426256;6777.559458635173;6847.794566163023;6411.166548348685;6514;6523.739050438119;6570.5729127606555;6586.901196481961;6539.378759017885;6559.508036897348;6562.212534495891;6585;6593.80218593443;6353.269374022047;6452.419282264619;6464;6482.513811464065;6526.216853977553;6619.569727967667;6628.210383196413;6644.7009884554345;6656.933430665631;6666.400023997863;6439.00195469703;6450.774222902176;6453.419192272718;6463.57986730861;6486.870262594627 00:02:04 INFO - PID 3582 | |5;yui.html;877.1360210192959;893.3835653399154;903.0653273861546;907.718607231758;908.5684299957521;18324.541886452844;19418.70871936922;19443.12505937231;19465.902670486663;19588.902055489703;20187;21539.138434462642;21553.137874485;21641.567168656617;21648.458788530294;1035.9171266298697;1054.3199636234624;1054.4516851237352;1056.7886422715487;1059.2955684469819;992.483908367652;1019.4036488654109;1063.4842101580766;1064.4039337970723;1069.7165251208437;1110.5502271580024;1114.9832752508719;1115.074488174817;1115.2082021764556;1115.5928086248541;1107.4462768615692;1107.7396811749193;1108.3682301088384;1108.5233349659643;1109.9001089901947;821.0024819843859;824.488816933499;825.1377310710322;825.2366560931115;825.475822852487;19960.900195499074;20062.49843753918;20353.185872565078;20410.489737756525;21021.894890525604;21746.238881639067;21913.780862191332;22179.66730499028;22198.890055497322;22441.55116897653;16383;16415.753763693436;16651.583710407216;16839.32642694291;17018.234179461953;3614.7469677122613;3630.7458477906557;3634.618365071682;3641.763285386468;3643.85424583019;119431.40284298523;121671.39164304211;127470.36264818709;127811;128091;17518.47444576639;17657.293708251782;17734;17838.375656852208;18022;30792.69207307943;31351.529727054112;31495.527567086054;32536.67463325384;32615.67384326174;7501.249875012455;7889.644965976545;8510.829783404297;8827;9256.537173141316;4264.253755592759;4414.536473670282;4415.161119387306;4416.447944006999;4429.2027435062;5154.974225128851;5192.974035129876;5246.790128394821;5267.051930652519;5271.288376069258;1000.8198524265556;1021.274894824668;1036.1917704190744;1038.3510306058713;1042.6246551241547;690.2752110284182;712.4976891291627;716.8279612892868;721.2643104033856;733.0982891044046;11701.707457313636;12164.452599632861;12203.816942745689;12682.429290681941;12975.83647767303;700.2472342232121;703.6868593475854;705.5837056136904;715.677944924786;723.6598798564667;5496.4503549645515;5521.751521181556;5600.719964001783;5610.018246806874;5683.658980461186;111646.44176779065;114247;114342;114879.42560287144;115435;92564;94514;96161;99239;99503;85063;85147;85852.57073714717;87515.1248487507;90221;10425.791484170426;10602;10715.571377144826;10750.51622676997;10809.35143891369;40103;40583.594164057984;40657.999999998814;41281.380779287734;41390.793046034574;50421;51024;52314;52376;52974;15971;16046.277917493508;16175;16480.587985300463;16637.251323690703;17236.74144887853;17336.30654773795;17400.73898891543;17550.12249387551;17752.20115094798;15411.922940385226;15566.221688915735;15693.686126277182;15753.921230393775;15771.369145234521;15862;15899.920500397424;15919.761203582188;16066.67866642684;16086.678266434372;15967.600809979844;16015.759763603322;16067.357305708108;16142.67714645724;16173.4339298124;11913.22564033335;12023.21849079807;12126.514939402325;12285.324307162835;12337.50649973991;12137.271763694207;12207.69480762988;12208.938955305166;12278.298774269646;12312.815307770212 00:02:04 INFO - PID 3582 | __end_tp_report 00:02:04 INFO - PID 3582 | __start_cc_report 00:02:04 INFO - PID 3582 | _x_x_mozilla_cycle_collect,371 00:02:04 INFO - PID 3582 | __end_cc_report 00:02:04 INFO - PID 3582 | __startTimestamp1502866924306__endTimestamp 00:02:04 INFO - PID 3582 | 00:02:04 INFO - PID 3582 | ------- Summary: start ------- 00:02:04 INFO - PID 3582 | Number of tests: 6 00:02:04 INFO - PID 3582 | 00:02:04 INFO - PID 3582 | [#0] dojo.html Cycles:165 Average:6154.73 Median:6396.20 stddev:716.00 (11.2%) stddev-sans-first:678.08 00:02:04 INFO - PID 3582 | Values: 3142.5 3143.1 3166.2 3171.4 3183.1 6150.2 6220.4 6276.1 6286.9 6312.0 6097.2 6221.8 6230.2 6240.9 6247.7 5712.8 5723.2 5734.7 5748.8 5751.6 5742.5 5746.1 5750.5 5795.5 5825.4 5755.4 5806.4 5819.6 5826.4 5883.2 5652.7 5692.1 5733.6 5733.8 5802.2 5478.8 5578.1 5615.4 5666.2 5691.0 6032.2 6138.2 6155.9 6204.3 6229.3 6644.9 6655.1 6667.6 6742.4 6746.4 6654.3 6654.5 6673.5 6678.9 6694.1 6099.8 6181.2 6181.9 6190.2 6196.9 6728.6 6730.3 6820.7 6823.3 6833.8 6404.5 6458.7 6497.5 6564.3 6568.6 6695.9 6709.6 6744.5 6746.0 6771.0 6637.0 6648.3 6706.0 6727.8 6743.0 6555.5 6657.1 6675.2 6765.3 6774.1 5420.1 5431.5 5446.1 5455.2 5491.2 4648.5 4660.1 4705.8 4726.3 4732.7 5754.9 5766.1 5780.9 5830.9 5871.6 6684.8 6704.3 6708.7 6709.2 6716.9 5734.4 5772.2 5785.7 5870.2 5875.8 5899.8 5955.5 5972.5 5982.5 5983.3 6426.9 6465.9 6481.2 6497.2 6504.4 6752.3 6761.4 6768.7 6773.6 6774.2 6476.7 6481.8 6551.7 6554.4 6563.7 6579.4 6601.0 6683.5 6691.6 6691.7 6681.7 6723.1 6820.4 6825.4 6825.9 6403.0 6409.7 6415.1 6453.1 6454.7 6365.6 6409.5 6447.7 6468.6 6491.6 6305.3 6340.9 6396.2 6405.4 6412.3 6437.5 6565.5 6574.9 6606.6 6664.0 6240.1 6319.9 6346.6 6355.6 6441.3 00:02:04 INFO - PID 3582 | 00:02:04 INFO - PID 3582 | [#1] ext.html Cycles:180 Average:35511.58 Median:34734.39 stddev:51364.47 (147.9%) stddev-sans-first:51442.48 00:02:04 INFO - PID 3582 | Values: 814.8 832.3 866.9 874.2 884.7 42289.0 42869.6 43122.0 43243.0 43271.4 40124.8 40293.4 40520.4 40553.6 40570.2 7078.6 7212.6 7214.0 7216.2 7219.1 7031.8 7106.0 7109.7 7109.9 7110.3 7055.6 7080.2 7086.1 7090.7 7098.0 7008.1 7049.8 7051.8 7054.0 7055.0 6461.8 6476.7 6488.3 6508.9 6514.2 35385.6 35598.5 35643.6 35677.3 35701.6 3425.4 3436.3 3438.7 3449.5 3450.5 28412.0 28496.4 28538.1 28547.9 28610.4 4470.9 4535.4 4548.7 4573.1 4581.9 188388.0 190188.0 190694.0 190759.0 191191.0 21861.6 21885.2 21947.2 21960.6 21961.5 22281.3 22323.9 22412.3 22432.2 22432.3 13253.3 13478.0 13482.5 13484.4 13485.8 13248.1 13260.5 13264.0 13348.2 13354.5 5829.9 5899.6 5938.8 5941.2 5949.3 2405.3 2416.7 2432.8 2440.9 2458.5 1014.5 1019.0 1019.2 1022.9 1023.4 23499.0 23596.0 23638.9 23773.2 24080.9 1120.5 1122.6 1126.5 1137.4 1143.5 12334.0 12563.9 12586.1 12598.7 12602.0 212826.0 214334.0 214393.0 214576.0 215537.0 53963.7 53972.2 56328.7 59361.1 59980.4 1497.4 1517.7 1522.6 1526.9 1527.9 27809.0 28133.3 28189.2 28504.6 29172.3 39000.0 39137.6 39445.2 39507.2 39603.2 185778.0 186654.0 186777.0 186886.0 186970.0 35304.0 35346.6 35361.5 35428.5 36919.0 47722.3 47920.5 48101.5 48500.5 48522.3 34451.5 35170.5 35281.3 36021.6 36280.6 34708.5 34971.5 35299.8 35337.5 35517.3 38415.2 38488.0 38595.2 38806.6 39432.2 33899.5 33910.3 34071.5 34133.8 34760.3 24514.9 24798.1 25071.6 25088.6 25249.4 00:02:04 INFO - PID 3582 | 00:02:04 INFO - PID 3582 | [#2] jquery.html Cycles:180 Average:35937.44 Median:22333.77 stddev:76892.83 (344.3%) stddev-sans-first:77062.71 00:02:04 INFO - PID 3582 | Values: 579.1 581.2 582.2 583.7 602.3 22618.3 22624.3 23426.0 23462.4 23543.8 26475.5 27308.0 27372.7 27415.5 27462.6 7014.8 7179.7 7185.6 7186.1 7189.4 6668.9 6969.9 6969.9 6978.4 6990.3 6944.5 6956.9 6959.2 6960.8 6961.4 6959.5 6962.6 6964.3 6966.5 6966.7 6811.3 6827.1 6848.7 6852.3 6860.7 30757.4 31974.5 32223.0 32262.2 32356.0 1954.1 2003.6 2004.3 2004.5 2005.1 20555.4 21629.2 21639.5 21650.6 21652.1 2531.0 2536.6 2609.6 2670.7 2674.0 135307.0 143098.3 143331.0 143581.3 143971.0 21203.9 21771.3 21815.5 22166.9 22340.2 43446.0 43503.3 43687.4 43888.3 43910.0 11376.9 11624.0 11760.0 11820.6 11898.8 9781.4 9781.5 9801.7 9867.3 9933.3 11746.8 11831.8 11852.8 12003.6 12064.7 4460.5 4488.6 4581.8 4596.7 4685.6 976.0 986.2 987.9 991.5 1008.5 19598.6 19727.4 19757.2 19901.4 20236.3 1029.5 1033.1 1048.3 1053.4 1055.0 10882.1 11049.7 11079.3 11222.7 11288.2 445797.0 448008.0 449851.0 459548.0 459846.0 111914.0 112991.4 113716.4 114125.4 115077.0 1075.3 1106.5 1121.9 1198.0 1211.9 20803.8 21664.7 22327.3 22675.8 22747.8 59127.0 63177.7 65283.3 65557.0 65724.7 80293.0 80423.6 80562.0 82677.2 83919.0 20127.0 20436.6 20535.4 21145.4 21948.7 22180.3 22267.9 22292.0 22411.6 23801.9 18341.2 18455.5 18807.8 18917.1 18920.8 15752.9 16153.8 16567.8 16571.9 17945.3 18457.0 19705.7 19929.4 20015.6 20041.8 21320.9 21337.0 21409.9 21472.9 21542.0 17039.2 17163.7 17175.6 17246.7 17391.0 00:02:04 INFO - PID 3582 | 00:02:04 INFO - PID 3582 | [#3] mootools.html Cycles:180 Average:8612.03 Median:2621.71 stddev:5840.24 (222.8%) stddev-sans-first:5831.10 00:02:04 INFO - PID 3582 | Values: 1345.8 1391.9 1399.3 1403.2 1403.7 13607.3 13852.4 14148.2 14257.6 14271.9 14359.0 14588.1 14596.5 14609.5 14616.2 2694.2 2736.2 2737.9 2738.3 2740.0 2615.8 2632.8 2666.8 2668.1 2677.5 2603.4 2629.3 2643.8 2669.2 2682.3 2627.6 2653.4 2657.7 2657.8 2664.2 2573.8 2595.2 2600.2 2603.4 2629.8 13334.2 13610.5 13613.7 13616.0 13620.6 7396.3 7620.3 7638.5 7647.1 7662.8 5010.4 5084.8 5125.6 5209.8 5247.6 1878.6 1886.2 1897.7 1933.5 1944.3 22087.9 22227.2 22244.0 22314.0 22339.6 6378.2 6381.8 6534.6 6597.6 6608.3 15755.8 15781.6 15789.9 15804.2 15823.5 7433.4 7562.4 7563.0 7566.0 7571.6 5445.5 6041.6 6053.4 6993.0 7069.6 4946.9 5075.6 5079.8 5106.3 5155.2 1482.0 1487.9 1489.2 1493.3 1500.0 871.9 893.9 894.4 896.7 903.0 8253.5 8431.9 8774.6 8935.0 9020.0 943.1 969.4 977.0 979.5 981.5 4890.5 4969.8 4996.0 5008.3 5017.0 18364.0 18922.7 19053.4 19391.5 19451.4 18899.4 19032.0 19055.1 19199.1 19256.3 10374.5 10693.3 10812.1 10919.8 11046.8 7313.2 7476.1 7505.6 7512.5 7528.4 16501.9 16805.2 16861.2 17015.5 17043.8 17081.5 17120.1 17179.7 17229.8 17242.9 10030.5 10270.9 10276.3 10284.0 10334.7 12849.4 12854.4 12892.4 13044.9 13047.0 10477.0 10582.4 10679.8 10813.5 10937.1 10248.2 10311.4 10373.5 10407.8 10585.1 9443.1 9598.5 9599.6 9600.6 9604.9 6785.7 6834.3 6853.8 6901.2 6903.4 6922.3 7016.1 7037.2 7050.7 7205.4 00:02:04 INFO - PID 3582 | 00:02:04 INFO - PID 3582 | [#4] prototype.html Cycles:180 Average:5510.10 Median:6085.53 stddev:1552.82 (25.5%) stddev-sans-first:1510.80 00:02:04 INFO - PID 3582 | Values: 491.6 499.5 500.6 520.3 525.4 6114.5 6179.8 6217.9 6241.3 6273.4 5873.2 6069.8 6087.3 6088.9 6134.2 4924.9 4948.6 4953.3 4953.9 4956.9 4783.9 4900.5 4949.2 4951.2 4985.0 4919.9 4926.2 4939.9 4941.7 4955.4 4881.2 4891.8 4903.5 4922.1 4932.6 4429.4 4462.9 4476.1 4478.9 4486.2 6016.6 6039.4 6068.8 6083.8 6098.6 5651.5 5657.0 5668.5 5680.0 5751.5 6522.7 6532.4 6533.7 6543.0 6584.4 4897.8 4901.3 4926.0 4928.2 4933.3 6780.6 6797.5 6838.5 6844.2 6934.8 4960.7 5007.9 5022.6 5030.6 5045.5 5093.8 5104.4 5104.5 5124.6 5145.4 5566.6 5653.9 5664.3 5677.1 5680.7 6539.4 6558.2 6604.2 6604.8 6665.7 1676.8 1681.6 1734.0 1750.7 1759.9 1210.0 1214.1 1217.1 1223.1 1234.7 5664.7 5691.6 5702.7 5757.3 5773.5 6701.6 6709.6 6722.8 6759.8 6800.9 5705.2 5720.6 5721.9 5745.3 5775.9 3576.2 3579.3 3595.4 3605.5 3628.3 6518.4 6526.8 6546.9 6584.6 6587.5 6861.7 6896.5 6929.5 6957.9 6959.2 6382.2 6421.6 6454.3 6498.9 6521.0 6691.8 6715.9 6723.3 6791.3 6797.2 6587.7 6637.0 6693.4 6714.2 6715.2 6503.0 6518.0 6548.6 6563.6 6564.1 4994.4 5011.6 5011.7 5030.9 5056.9 6595.9 6723.0 6739.6 6777.6 6847.8 6411.2 6514.0 6523.7 6570.6 6586.9 6539.4 6559.5 6562.2 6585.0 6593.8 6353.3 6452.4 6464.0 6482.5 6526.2 6619.6 6628.2 6644.7 6656.9 6666.4 6439.0 6450.8 6453.4 6463.6 6486.9 00:02:04 INFO - PID 3582 | 00:02:04 INFO - PID 3582 | [#5] yui.html Cycles:180 Average:23013.01 Median:19430.92 stddev:31773.41 (163.5%) stddev-sans-first:31819.06 00:02:04 INFO - PID 3582 | Values: 877.1 893.4 903.1 907.7 908.6 18324.5 19418.7 19443.1 19465.9 19588.9 20187.0 21539.1 21553.1 21641.6 21648.5 1035.9 1054.3 1054.5 1056.8 1059.3 992.5 1019.4 1063.5 1064.4 1069.7 1110.6 1115.0 1115.1 1115.2 1115.6 1107.4 1107.7 1108.4 1108.5 1109.9 821.0 824.5 825.1 825.2 825.5 19960.9 20062.5 20353.2 20410.5 21021.9 21746.2 21913.8 22179.7 22198.9 22441.6 16383.0 16415.8 16651.6 16839.3 17018.2 3614.7 3630.7 3634.6 3641.8 3643.9 119431.4 121671.4 127470.4 127811.0 128091.0 17518.5 17657.3 17734.0 17838.4 18022.0 30792.7 31351.5 31495.5 32536.7 32615.7 7501.2 7889.6 8510.8 8827.0 9256.5 4264.3 4414.5 4415.2 4416.4 4429.2 5155.0 5193.0 5246.8 5267.1 5271.3 1000.8 1021.3 1036.2 1038.4 1042.6 690.3 712.5 716.8 721.3 733.1 11701.7 12164.5 12203.8 12682.4 12975.8 700.2 703.7 705.6 715.7 723.7 5496.5 5521.8 5600.7 5610.0 5683.7 111646.4 114247.0 114342.0 114879.4 115435.0 92564.0 94514.0 96161.0 99239.0 99503.0 85063.0 85147.0 85852.6 87515.1 90221.0 10425.8 10602.0 10715.6 10750.5 10809.4 40103.0 40583.6 40658.0 41281.4 41390.8 50421.0 51024.0 52314.0 52376.0 52974.0 15971.0 16046.3 16175.0 16480.6 16637.3 17236.7 17336.3 17400.7 17550.1 17752.2 15411.9 15566.2 15693.7 15753.9 15771.4 15862.0 15899.9 15919.8 16066.7 16086.7 15967.6 16015.8 16067.4 16142.7 16173.4 11913.2 12023.2 12126.5 12285.3 12337.5 12137.3 12207.7 12208.9 12278.3 12312.8 00:02:04 INFO - PID 3582 | -------- Summary: end -------- 00:02:04 INFO - PID 3582 | 00:02:04 INFO - TEST-INFO | 3582: exit 0 00:02:05 INFO - TEST-OK | dromaeo_css | took 1111363ms 00:02:05 INFO - TEST-START | kraken 00:02:05 INFO - Initialising browser for kraken test... 00:02:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38323/getInfo.html -profile /tmp/tmpjTDCXn/profile 00:02:05 INFO - TEST-INFO | started process 3938 (/builds/slave/test/build/application/firefox/firefox http://localhost:38323/getInfo.html) 00:02:10 INFO - TEST-INFO | 3938: exit 0 00:02:10 INFO - Browser initialized. 00:02:10 INFO - Running cycle 1/1 for kraken test... 00:02:10 INFO - TEST-INFO | started process 4115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjTDCXn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:02:11 INFO - PID 4115 | 00:02:11 INFO - PID 4115 | (/builds/slave/test/build/application/firefox/firefox:4163): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:02:11 INFO - PID 4115 | 00:02:22 INFO - PID 4115 | RSS: Main: 164954112 00:02:22 INFO - PID 4115 | 00:02:24 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38323/tests/kraken/driver.html?testName=audio-beat-detection) 00:02:25 INFO - PID 4115 | RSS: Main: 171233280 00:02:25 INFO - PID 4115 | 00:02:28 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38323/tests/kraken/driver.html?testName=audio-dft) 00:02:28 INFO - PID 4115 | RSS: Main: 171520000 00:02:28 INFO - PID 4115 | 00:02:31 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38323/tests/kraken/driver.html?testName=audio-fft) 00:02:32 INFO - PID 4115 | RSS: Main: 165580800 00:02:32 INFO - PID 4115 | 00:02:34 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38323/tests/kraken/driver.html?testName=audio-oscillator) 00:02:35 INFO - PID 4115 | RSS: Main: 166666240 00:02:35 INFO - PID 4115 | 00:02:37 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38323/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:02:38 INFO - PID 4115 | RSS: Main: 166989824 00:02:38 INFO - PID 4115 | 00:02:41 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38323/tests/kraken/driver.html?testName=imaging-darkroom) 00:02:41 INFO - PID 4115 | RSS: Main: 169598976 00:02:41 INFO - PID 4115 | 00:02:45 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38323/tests/kraken/driver.html?testName=imaging-desaturate) 00:02:45 INFO - PID 4115 | RSS: Main: 171827200 00:02:45 INFO - PID 4115 | 00:02:48 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38323/tests/kraken/driver.html?testName=json-parse-financial) 00:02:49 INFO - PID 4115 | RSS: Main: 170934272 00:02:49 INFO - PID 4115 | 00:02:50 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38323/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:02:51 INFO - PID 4115 | RSS: Main: 170373120 00:02:51 INFO - PID 4115 | 00:02:53 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38323/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:02:53 INFO - PID 4115 | RSS: Main: 170561536 00:02:53 INFO - PID 4115 | 00:02:55 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38323/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:02:56 INFO - PID 4115 | RSS: Main: 170229760 00:02:56 INFO - PID 4115 | 00:02:59 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38323/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:03:00 INFO - PID 4115 | RSS: Main: 170409984 00:03:00 INFO - PID 4115 | 00:03:03 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38323/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:03:03 INFO - PID 4115 | RSS: Main: 170815488 00:03:03 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | Cycle 1(1): loaded http://localhost:38323/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38323/tests/kraken/driver.html?testName=ai-astar) 00:03:05 INFO - PID 4115 | RSS: Main: 172294144 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | __start_tp_report 00:03:05 INFO - PID 4115 | _x_x_mozilla_page_load 00:03:05 INFO - PID 4115 | _x_x_mozilla_page_load_details 00:03:05 INFO - PID 4115 | |i|pagename|runs| 00:03:05 INFO - PID 4115 | |0;ai-astar;98;108;101;110;108;108;109;99;106;109 00:03:05 INFO - PID 4115 | |1;audio-beat-detection;157;118;147;168;118;152;145;121;176;119 00:03:05 INFO - PID 4115 | |2;audio-dft;163;161;162;162;162;161;160;168;168;163 00:03:05 INFO - PID 4115 | |3;audio-fft;76;76;75;172;76;85;75;75;149;77 00:03:05 INFO - PID 4115 | |4;audio-oscillator;79;79;136;79;78;81;126;79;78;140 00:03:05 INFO - PID 4115 | |5;imaging-gaussian-blur;114;114;113;114;114;114;113;114;113;115 00:03:05 INFO - PID 4115 | |6;imaging-darkroom;150;150;150;151;150;151;150;151;151;149 00:03:05 INFO - PID 4115 | |7;imaging-desaturate;94;94;93;95;94;93;94;94;94;94 00:03:05 INFO - PID 4115 | |8;json-parse-financial;53;53;53;54;54;54;54;59;53;53 00:03:05 INFO - PID 4115 | |9;json-stringify-tinderbox;54;54;55;54;54;54;54;54;54;55 00:03:05 INFO - PID 4115 | |10;stanford-crypto-aes;77;78;79;77;86;86;78;76;78;77 00:03:05 INFO - PID 4115 | |11;stanford-crypto-ccm;133;121;128;134;123;131;124;124;123;158 00:03:05 INFO - PID 4115 | |12;stanford-crypto-pbkdf2;178;185;176;182;176;178;178;180;180;182 00:03:05 INFO - PID 4115 | |13;stanford-crypto-sha256-iterative;69;69;72;68;67;67;68;67;68;67 00:03:05 INFO - PID 4115 | __end_tp_report 00:03:05 INFO - PID 4115 | __start_cc_report 00:03:05 INFO - PID 4115 | _x_x_mozilla_cycle_collect,979 00:03:05 INFO - PID 4115 | __end_cc_report 00:03:05 INFO - PID 4115 | __startTimestamp1502866985709__endTimestamp 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | ------- Summary: start ------- 00:03:05 INFO - PID 4115 | Number of tests: 14 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#0] ai-astar Cycles:10 Average:105.60 Median:109.00 stddev:4.50 (4.1%) stddev-sans-first:3.84 00:03:05 INFO - PID 4115 | Values: 98.0 108.0 101.0 110.0 108.0 108.0 109.0 99.0 106.0 109.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:149.50 stddev:21.89 (14.6%) stddev-sans-first:22.55 00:03:05 INFO - PID 4115 | Values: 157.0 118.0 147.0 168.0 118.0 152.0 145.0 121.0 176.0 119.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.79 (1.7%) stddev-sans-first:2.96 00:03:05 INFO - PID 4115 | Values: 163.0 161.0 162.0 162.0 162.0 161.0 160.0 168.0 168.0 163.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:35.80 (47.1%) stddev-sans-first:37.40 00:03:05 INFO - PID 4115 | Values: 76.0 76.0 75.0 172.0 76.0 85.0 75.0 75.0 149.0 77.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:79.00 stddev:26.80 (33.9%) stddev-sans-first:27.75 00:03:05 INFO - PID 4115 | Values: 79.0 79.0 136.0 79.0 78.0 81.0 126.0 79.0 78.0 140.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 00:03:05 INFO - PID 4115 | Values: 114.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 113.0 115.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 00:03:05 INFO - PID 4115 | Values: 150.0 150.0 150.0 151.0 150.0 151.0 150.0 151.0 151.0 149.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 00:03:05 INFO - PID 4115 | Values: 94.0 94.0 93.0 95.0 94.0 93.0 94.0 94.0 94.0 94.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.83 (3.4%) stddev-sans-first:1.90 00:03:05 INFO - PID 4115 | Values: 53.0 53.0 53.0 54.0 54.0 54.0 54.0 59.0 53.0 53.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 00:03:05 INFO - PID 4115 | Values: 54.0 54.0 55.0 54.0 54.0 54.0 54.0 54.0 54.0 55.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.00 stddev:3.68 (4.7%) stddev-sans-first:3.81 00:03:05 INFO - PID 4115 | Values: 77.0 78.0 79.0 77.0 86.0 86.0 78.0 76.0 78.0 77.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:129.50 stddev:10.88 (8.4%) stddev-sans-first:11.48 00:03:05 INFO - PID 4115 | Values: 133.0 121.0 128.0 134.0 123.0 131.0 124.0 124.0 123.0 158.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:180.00 stddev:2.88 (1.6%) stddev-sans-first:3.00 00:03:05 INFO - PID 4115 | Values: 178.0 185.0 176.0 182.0 176.0 178.0 178.0 180.0 180.0 182.0 00:03:05 INFO - PID 4115 | 00:03:05 INFO - PID 4115 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.55 (2.3%) stddev-sans-first:1.62 00:03:05 INFO - PID 4115 | Values: 69.0 69.0 72.0 68.0 67.0 67.0 68.0 67.0 68.0 67.0 00:03:05 INFO - PID 4115 | -------- Summary: end -------- 00:03:05 INFO - PID 4115 | 00:03:06 INFO - PID 4115 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:03:06 INFO - TEST-INFO | 4115: exit 0 00:03:06 INFO - TEST-OK | kraken | took 61495ms 00:03:06 INFO - SUITE-END | took 1172s 00:03:06 INFO - Completed test suite (00:19:33) 00:03:06 INFO - javascript benchmark 00:03:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8444.087373068875, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3142.497200447928, 3143.0885043337435, 3166.1926208816753, 3171.3974344874473, 3183.076907696768, 6150.200473938393, 6220.40906113919, 6276.121343011976, 6286.9056964145575, 6312.0, 6097.2073630427985, 6221.844453888655, 6230.221222347207, 6240.937590624092, 6247.656378899159, 5712.800051998181, 5723.170140329649, 5734.655920644754, 5748.770049198048, 5751.597388182829, 5742.540596752271, 5746.0806270996645, 5750.482456578907, 5795.4784069433745, 5825.446582574648, 5755.366909639936, 5806.44838740319, 5819.592628516006, 5826.359100498942, 5883.205767221413, 5652.717364131818, 5692.060809966371, 5733.598648094635, 5733.799317023926, 5802.216700745387, 5478.780848766045, 5578.135389014709, 5615.382307946123, 5666.178404131378, 5691.0, 6032.185654936615, 6138.232720909887, 6155.938440615581, 6204.255489341263, 6229.25248970122, 6644.900326495106, 6655.101561289212, 6667.633280169589, 6742.393184613359, 6746.392824645756, 6654.334566543355, 6654.467642588581, 6673.499487538405, 6678.866422671568, 6694.096296999892, 6099.84750381244, 6181.196444462191, 6181.938180618181, 6190.226221722285, 6196.907046394308, 6728.629925354153, 6730.259671436138, 6820.6930688119155, 6823.28355522663, 6833.794986150423, 6404.455621272151, 6458.6770661466735, 6497.480201583862, 6564.310747371553, 6568.6058836469965, 6695.899561506581, 6709.563878347892, 6744.460443164535, 6746.0, 6771.01820236063, 6637.0, 6648.33516648341, 6705.966470167716, 6727.798166055026, 6742.9662851685425, 6555.475561955032, 6657.13457250564, 6675.198976122896, 6765.323467653294, 6774.085498457645, 5420.07858664028, 5431.511163995259, 5446.101393270066, 5455.236266922555, 5491.176323551499, 4648.511906249795, 4660.13787449323, 4705.811767529261, 4726.314684370747, 4732.716037037789, 5754.88490230193, 5766.106253530709, 5780.942190578125, 5830.941690583125, 5871.6183448075735, 6684.799456016327, 6704.296048914891, 6708.664566771739, 6709.161354830646, 6716.932830671729, 5734.39788822176, 5772.249607550992, 5785.71071446426, 5870.236869206976, 5875.8248350330105, 5899.793507227227, 5955.52355811534, 5972.492338151219, 5982.521398288213, 5983.341832398432, 6426.935730642634, 6465.935340646627, 6481.1898512684975, 6497.18785151856, 6504.414602685781, 6752.257251702211, 6761.391474767294, 6768.695408706719, 6773.593584384953, 6774.187097548129, 6476.676166191766, 6481.773137940149, 6551.672416379257, 6554.442872355903, 6563.737450501926, 6579.374959378852, 6601.0, 6683.465322774264, 6691.59850408977, 6691.698873550605, 6681.665916704243, 6723.058771772054, 6820.420264277592, 6825.385715285648, 6825.863482730417, 6402.967985160044, 6409.7115629795835, 6415.06981487691, 6453.09656648079, 6454.741810327534, 6365.554411191172, 6409.519286053472, 6447.742090316335, 6468.611883287018, 6491.578047426902, 6305.306416294296, 6340.873182536231, 6396.200474940632, 6405.423511883952, 6412.294647588855, 6437.452816510649, 6565.540412171103, 6574.868502629825, 6606.636634985122, 6664.033715111184, 6240.063990401476, 6319.9052014218905, 6346.587471814318, 6355.618662880242, 6441.323661015525], "value": 6101.517943921942, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.7922279818646, 832.3091833777964, 866.8526350520413, 874.2350443362059, 884.6726711116884, 42289.0, 42869.57130428699, 43122.0, 43243.0, 43271.35092973604, 40124.79937600315, 40293.39559906597, 40520.39219411704, 40553.59446405535, 40570.18859622806, 7078.646067696607, 7212.603306818123, 7213.963930180342, 7216.206217316091, 7219.061522002133, 7031.789046328593, 7105.9644701776415, 7109.715611375539, 7109.893351599704, 7110.3245191706965, 7055.6472176391235, 7080.150381954173, 7086.114235720535, 7090.71637134514, 7097.964510177468, 7008.088948436722, 7049.7885063448175, 7051.753188638424, 7054.0, 7054.964725176393, 6461.773837915651, 6476.740930362827, 6488.28628850826, 6508.93491065088, 6514.153160089206, 35385.64614353849, 35598.46602300968, 35643.643563564554, 35677.28645427103, 35701.64298357009, 3425.383430982422, 3436.329915666446, 3438.6561343865665, 3449.4653328734084, 3450.4996775467416, 28412.0, 28496.430071398456, 28538.143855684157, 28547.857260713772, 28610.42779144426, 4470.865874023784, 4535.387722657432, 4548.681592288541, 4573.062522182944, 4581.931271030937, 188388.0, 190188.0490597552, 190694.0, 190759.0, 191191.0, 21861.562768744538, 21885.234016809336, 21947.231846885603, 21960.560788784136, 21961.450963725714, 22281.3315600529, 22323.888380557994, 22412.319076069034, 22432.214872479384, 22432.32703018912, 13253.271070091045, 13478.0, 13482.460701572023, 13484.393202305724, 13485.797713034312, 13248.072634915463, 13260.469581216836, 13264.0, 13348.199108053548, 13354.53259135945, 5829.854253643608, 5899.587028908021, 5938.762449502058, 5941.197938278364, 5949.286085669747, 2405.314485371661, 2416.6979127609047, 2432.7932125769153, 2440.8535487870786, 2458.4960083182905, 1014.4674046125843, 1018.9847152292573, 1019.23557332001, 1022.928395012342, 1023.411538365428, 23499.0, 23596.0, 23638.881805590863, 23773.167939122046, 24080.87959560191, 1120.490176969477, 1122.6014764758556, 1126.5155982927256, 1137.397179494869, 1143.4911464398429, 12334.0, 12563.937180314222, 12586.118971671895, 12598.748025039447, 12602.0, 212826.0, 214334.0, 214393.0, 214576.0, 215537.0, 53963.730181348845, 53972.19041714377, 56328.71835640795, 59361.10958335629, 59980.40019599835, 1497.445945000335, 1517.681286929735, 1522.649790548158, 1526.8854835887353, 1527.9236038198046, 27809.0, 28133.296667582654, 28189.154325370273, 28504.57243141313, 29172.27069323284, 39000.0, 39137.608623913395, 39445.21109577735, 39507.209855803296, 39603.207935840546, 185778.0, 186654.0, 186777.0, 186886.0, 186970.0, 35304.0, 35346.64653353434, 35361.46957795584, 35428.46857297194, 36919.0, 47722.28416573824, 47920.520794793, 48101.518984811104, 48500.5149948496, 48522.27216591824, 34451.483227752105, 35170.47244291286, 35281.29437411186, 36021.63978360183, 36280.63719362773, 34708.47937280993, 34971.47542786809, 35299.82350088233, 35337.46993795044, 35517.289654207285, 38415.23169536538, 38488.0, 38595.2280954385, 38806.6119338803, 39432.21135577215, 33899.4915076279, 33910.321793564486, 34071.4889276666, 34133.82933085319, 34760.304793904485, 24514.877425612758, 24798.132065377624, 25071.623925640764, 25088.62367064459, 25249.368765781004], "value": 15587.088733099225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.099500277069, 581.2008488328547, 582.170407169783, 583.6906439587018, 602.2772672792648, 22618.321450356496, 22624.321270361874, 23426.0, 23462.413439663975, 23543.764562354372, 26475.470490590178, 27308.04421845236, 27372.726272737265, 27415.45169096622, 27462.5880611791, 7014.754483593075, 7179.748708795193, 7185.604791736452, 7186.13766348039, 7189.424846012333, 6668.899966500507, 6969.860602787941, 6969.930300697004, 6978.371946524811, 6990.266022067686, 6944.47916406269, 6956.860862782742, 6959.234484206733, 6960.825979350531, 6961.373476387124, 6959.547629404073, 6962.582245065287, 6964.338387853146, 6966.477514186457, 6966.651667416634, 6811.284815094443, 6827.0783444234885, 6848.691808868563, 6852.314768523158, 6860.691268892861, 30757.38485230283, 31974.520382194285, 32223.0, 32262.193445163823, 32356.029319120466, 1954.0913475233942, 2003.5592169722638, 2004.2684420186672, 2004.5088953206412, 2005.1077270614583, 20555.38333849987, 21629.242976495905, 21639.45901352463, 21650.56698866014, 21652.133914643397, 2531.0, 2536.6321883327, 2609.608558716189, 2670.7462791034823, 2673.9732602673917, 135307.0, 143098.28450857784, 143331.0, 143581.28209358992, 143971.0, 21203.89398053, 21771.346859594236, 21815.454613634785, 22166.889165554392, 22340.218092367013, 43446.0, 43503.34744978828, 43687.378757274666, 43888.3416748749, 43910.0, 11376.886231137749, 11624.0, 11760.0, 11820.586279480176, 11898.821517677241, 9781.364211326383, 9781.510924453749, 9801.656942006995, 9867.30928834989, 9933.304668673269, 11746.765064698659, 11831.763364732657, 11852.822207666892, 12003.579874704343, 12064.698382540506, 4460.487043989918, 4488.573585509372, 4581.770911454414, 4596.747178905125, 4685.601723853442, 975.9707208783748, 986.156835905305, 987.8863930647924, 991.5389343955095, 1008.4907121903539, 19598.608027839364, 19727.40817775469, 19757.209711611664, 19901.402957911287, 20236.291729789387, 1029.5006921642996, 1033.121846430528, 1048.2714513413257, 1053.378506681062, 1054.9894501054891, 10882.129429645609, 11049.668509944715, 11079.279846809932, 11222.719432014264, 11288.22365042403, 445797.0, 448008.0, 449851.0, 459548.0, 459846.0, 111914.0, 112991.43504282426, 113716.43141784404, 114125.42937285261, 115077.0, 1075.2580719303655, 1106.468894930438, 1121.9046381057701, 1197.9580714674944, 1211.8969887559656, 20803.791962080184, 21664.675029874248, 22327.330180093973, 22675.773242268027, 22747.772522274565, 59127.0, 63177.68411157915, 65283.347166527725, 65557.0, 65724.67137664281, 80293.0, 80423.59788201022, 80562.0, 82677.17322826695, 83919.0, 20127.0, 20436.591268174256, 20535.38393848187, 21145.365639030853, 21948.670769938784, 22180.334589962327, 22267.88866055724, 22291.99686014166, 22411.551768964855, 23801.880990594935, 18341.17464714118, 18455.53861153482, 18807.811921880606, 18917.148728307533, 18920.810791891905, 15752.92123539375, 16153.838461615233, 16567.834321656628, 16571.91714041422, 17945.282188712306, 18457.0, 19705.704414434083, 19929.402117936486, 20015.599688005866, 20041.799582003994, 21320.93395330258, 21337.0, 21409.892950535148, 21472.892635536722, 21542.0, 17039.233234504725, 17163.742543862103, 17175.57061073483, 17246.741298880275, 17391.0], "value": 13310.026160308873, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.7644912140377, 1391.944322227111, 1399.2514005007324, 1403.200175899737, 1403.7192561487705, 13607.251601161932, 13852.445902163901, 14148.151110933351, 14257.643558911032, 14271.928640356784, 14359.0, 14588.124712517256, 14596.489122880701, 14609.488667896625, 14616.196109213988, 2694.2186765837882, 2736.151792944194, 2737.86310684465, 2738.315421144714, 2739.9726002740017, 2615.796733502591, 2632.8420294782277, 2666.799990000748, 2668.119520558211, 2677.5046616376035, 2603.3882037721214, 2629.2900916752465, 2643.7884969202514, 2669.21258228822, 2682.275785537913, 2627.632131501591, 2653.3764565327133, 2657.747513986178, 2657.7740892024203, 2664.214056853233, 2573.806964477653, 2595.156574113421, 2600.1679462571983, 2603.4142317978494, 2629.789616830649, 13334.19994800315, 13610.455581776816, 13613.659658508517, 13616.0, 13620.591382258548, 7396.260373962615, 7620.314171724516, 7638.465307428482, 7647.082350118021, 7662.808429789244, 5010.423801262865, 5084.847454576368, 5125.564327032207, 5209.817656382046, 5247.553957913544, 1878.605492846504, 1886.1983656945881, 1897.7343171955938, 1933.5456167800555, 1944.3000519812856, 22087.889560552256, 22227.22204722843, 22244.0, 22314.0, 22339.55320893573, 6378.2346118466085, 6381.840453988688, 6534.575252608565, 6597.571157874723, 6608.306127856602, 15755.842441575667, 15781.605459863595, 15789.921050394674, 15804.182519010232, 15823.525294241192, 7433.442491813135, 7562.395008399315, 7563.016807814949, 7566.0, 7571.621418929031, 5445.50990410857, 6041.637501749821, 6053.364396738367, 6993.0209770632155, 7069.646517674199, 4946.851594452172, 5075.593952483792, 5079.796808127633, 5106.259592359162, 5155.175171972466, 1481.9851801482064, 1487.9032862863878, 1489.1809504772332, 1493.3429291111877, 1500.0, 871.904090550039, 893.9150780675825, 894.4007514964989, 896.6503063805121, 902.9954850225707, 8253.504789712637, 8431.873521897176, 8774.561271936378, 8934.955325223333, 9020.0, 943.1417410156862, 969.3602222533094, 976.951152442375, 979.5445118020154, 981.5484876956538, 4890.486498917562, 4969.751512424365, 4996.0, 5008.323876276729, 5017.0, 18364.0, 18922.716159257623, 19053.42839714811, 19391.51521211981, 19451.416457506297, 18899.433017009236, 19032.048397580344, 19055.142518586697, 19199.136038878285, 19256.326028588934, 10374.481275936172, 10693.251472396858, 10812.135029197645, 10919.836202456969, 11046.834297485704, 7313.232110628307, 7476.140243872024, 7505.624718763931, 7512.5492470451945, 7528.397728181842, 16501.91749041247, 16805.243764030405, 16861.241244144287, 17015.489535313962, 17043.829561704224, 17081.48755537336, 17120.14399280056, 17179.656406872044, 17229.82770172282, 17242.913785430992, 10030.548625311732, 10270.948645256725, 10276.332038417479, 10284.0, 10334.741631459274, 12849.357532123544, 12854.421551030038, 12892.419841106985, 13044.934775326063, 13047.0, 10477.0, 10582.365058096539, 10679.786404272027, 10813.459327033459, 10937.12502999774, 10248.231382646181, 10311.432871192157, 10373.533191006272, 10407.843882341922, 10585.100266477435, 9443.055694430503, 9598.520073996411, 9599.560065990157, 9600.615975360908, 9604.85592716096, 6785.728570857111, 6834.282400347892, 6853.7943861684225, 6901.24086350491, 6903.447724181953, 6922.307769223037, 7016.087908572057, 7037.225905150532, 7050.717971281297, 7205.423566114593], "value": 6320.16672883917, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.63373286901265, 499.5329367041816, 500.5770124245013, 520.3053923012777, 525.4351572060034, 6114.523617934732, 6179.845503862406, 6217.937820621803, 6241.282252540959, 6273.372662733725, 5873.177755114288, 6069.78755743549, 6087.295557243968, 6088.908666370008, 6134.2025536680285, 4924.901501969958, 4948.614387971374, 4953.331300274453, 4953.851384458454, 4956.87607809804, 4783.856484305476, 4900.534449227318, 4949.208126699728, 4951.23255895335, 4984.975075124619, 4919.893024069574, 4926.162552366089, 4939.876503087434, 4941.678790878599, 4955.355803745526, 4881.243407271843, 4891.804327826882, 4903.53416425439, 4922.138625740481, 4932.556069953685, 4429.446319210098, 4462.9107417851465, 4476.082403107355, 4478.8880277992985, 4486.192485352635, 6016.608920420203, 6039.3960603939695, 6068.787592434288, 6083.756649734005, 6098.57309988301, 5651.463111004489, 5656.981743286206, 5668.518175955049, 5680.0, 5751.511121554631, 6522.7390904363765, 6532.41208291256, 6533.705983230766, 6542.953127499625, 6584.374484423972, 4897.755112244409, 4901.304282644532, 4925.975370123162, 4928.186849169882, 4933.28467372229, 6780.627065511444, 6797.456203503757, 6838.452923766087, 6844.2129155147295, 6934.826629334257, 4960.727160006162, 5007.874803129878, 5022.573081288058, 5030.622703297267, 5045.470225626256, 5093.847184584469, 5104.412992505835, 5104.489551044866, 5124.641275110706, 5145.408278048072, 5566.610337276433, 5653.9151912721345, 5664.320281566238, 5677.148427735872, 5680.6591604503865, 6539.378759017885, 6558.245801732862, 6604.207495100619, 6604.801855944329, 6665.733650558834, 1676.8323167683134, 1681.6048228666255, 1733.9826601734073, 1750.7111326631218, 1759.938402155944, 1209.989658635032, 1214.0651698192341, 1217.0993464836135, 1223.1315765806198, 1234.6851552854143, 5664.745086471119, 5691.601587888808, 5702.747414771142, 5757.251557297608, 5773.538116950634, 6701.620924571805, 6709.563878347892, 6722.764703235363, 6759.797206083826, 6800.897986530206, 5705.22979397776, 5720.599558030898, 5721.942780572224, 5745.2818397700285, 5775.873704627641, 3576.1774791798034, 3579.3378225028455, 3595.40675788492, 3605.531280933462, 3628.310620982005, 6518.380753828379, 6526.804195874131, 6546.869062618721, 6584.6378449184795, 6587.473002159816, 6861.691223894937, 6896.517243792886, 6929.549579277432, 6957.9304206958295, 6959.164900211906, 6382.20222472191, 6421.582597131265, 6454.257760357619, 6498.902516462257, 6521.011091617008, 6691.799246022627, 6715.932840671726, 6723.327667233238, 6791.286914873867, 6797.1843378794865, 6587.7483278177, 6637.0, 6693.397594216543, 6714.227863795726, 6715.227748808949, 6503.0, 6518.024005356634, 6548.574342667902, 6563.606183628997, 6564.146660934048, 4994.375703037121, 5011.624128190473, 5011.724355160502, 5030.9245361320345, 5056.898862022813, 6595.868082638416, 6722.9663851680425, 6739.59562426256, 6777.559458635173, 6847.794566163023, 6411.166548348685, 6514.0, 6523.739050438119, 6570.5729127606555, 6586.901196481961, 6539.378759017885, 6559.508036897348, 6562.212534495891, 6585.0, 6593.80218593443, 6353.269374022047, 6452.419282264619, 6464.0, 6482.513811464065, 6526.216853977553, 6619.569727967667, 6628.210383196413, 6644.7009884554345, 6656.933430665631, 6666.400023997863, 6439.00195469703, 6450.774222902176, 6453.419192272718, 6463.57986730861, 6486.870262594627], "value": 5050.880350938334, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.1360210192959, 893.3835653399154, 903.0653273861546, 907.718607231758, 908.5684299957521, 18324.541886452844, 19418.70871936922, 19443.12505937231, 19465.902670486663, 19588.902055489703, 20187.0, 21539.138434462642, 21553.137874485, 21641.567168656617, 21648.458788530294, 1035.9171266298697, 1054.3199636234624, 1054.4516851237352, 1056.7886422715487, 1059.2955684469819, 992.483908367652, 1019.4036488654109, 1063.4842101580766, 1064.4039337970723, 1069.7165251208437, 1110.5502271580024, 1114.9832752508719, 1115.074488174817, 1115.2082021764556, 1115.5928086248541, 1107.4462768615692, 1107.7396811749193, 1108.3682301088384, 1108.5233349659643, 1109.9001089901947, 821.0024819843859, 824.488816933499, 825.1377310710322, 825.2366560931115, 825.475822852487, 19960.900195499074, 20062.49843753918, 20353.185872565078, 20410.489737756525, 21021.894890525604, 21746.238881639067, 21913.780862191332, 22179.66730499028, 22198.890055497322, 22441.55116897653, 16383.0, 16415.753763693436, 16651.583710407216, 16839.32642694291, 17018.234179461953, 3614.7469677122613, 3630.7458477906557, 3634.618365071682, 3641.763285386468, 3643.85424583019, 119431.40284298523, 121671.39164304211, 127470.36264818709, 127811.0, 128091.0, 17518.47444576639, 17657.293708251782, 17734.0, 17838.375656852208, 18022.0, 30792.69207307943, 31351.529727054112, 31495.527567086054, 32536.67463325384, 32615.67384326174, 7501.249875012455, 7889.644965976545, 8510.829783404297, 8827.0, 9256.537173141316, 4264.253755592759, 4414.536473670282, 4415.161119387306, 4416.447944006999, 4429.2027435062, 5154.974225128851, 5192.974035129876, 5246.790128394821, 5267.051930652519, 5271.288376069258, 1000.8198524265556, 1021.274894824668, 1036.1917704190744, 1038.3510306058713, 1042.6246551241547, 690.2752110284182, 712.4976891291627, 716.8279612892868, 721.2643104033856, 733.0982891044046, 11701.707457313636, 12164.452599632861, 12203.816942745689, 12682.429290681941, 12975.83647767303, 700.2472342232121, 703.6868593475854, 705.5837056136904, 715.677944924786, 723.6598798564667, 5496.4503549645515, 5521.751521181556, 5600.719964001783, 5610.018246806874, 5683.658980461186, 111646.44176779065, 114247.0, 114342.0, 114879.42560287144, 115435.0, 92564.0, 94514.0, 96161.0, 99239.0, 99503.0, 85063.0, 85147.0, 85852.57073714717, 87515.1248487507, 90221.0, 10425.791484170426, 10602.0, 10715.571377144826, 10750.51622676997, 10809.35143891369, 40103.0, 40583.594164057984, 40657.999999998814, 41281.380779287734, 41390.793046034574, 50421.0, 51024.0, 52314.0, 52376.0, 52974.0, 15971.0, 16046.277917493508, 16175.0, 16480.587985300463, 16637.251323690703, 17236.74144887853, 17336.30654773795, 17400.73898891543, 17550.12249387551, 17752.20115094798, 15411.922940385226, 15566.221688915735, 15693.686126277182, 15753.921230393775, 15771.369145234521, 15862.0, 15899.920500397424, 15919.761203582188, 16066.67866642684, 16086.678266434372, 15967.600809979844, 16015.759763603322, 16067.357305708108, 16142.67714645724, 16173.4339298124, 11913.22564033335, 12023.21849079807, 12126.514939402325, 12285.324307162835, 12337.50649973991, 12137.271763694207, 12207.69480762988, 12208.938955305166, 12278.298774269646, 12312.815307770212], "value": 8970.41836951113, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 101.0, 110.0, 108.0, 108.0, 109.0, 99.0, 106.0, 109.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 118.0, 147.0, 168.0, 118.0, 152.0, 145.0, 121.0, 176.0, 119.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 162.0, 161.0, 160.0, 168.0, 168.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 172.0, 76.0, 85.0, 75.0, 75.0, 149.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 136.0, 79.0, 78.0, 81.0, 126.0, 79.0, 78.0, 140.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 150.0, 151.0, 150.0, 151.0, 151.0, 149.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 59.0, 53.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 79.0, 77.0, 86.0, 86.0, 78.0, 76.0, 78.0, 77.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 121.0, 128.0, 134.0, 123.0, 131.0, 124.0, 124.0, 123.0, 158.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 185.0, 176.0, 182.0, 176.0, 178.0, 178.0, 180.0, 180.0, 182.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 72.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0], "value": 68.2, "unit": "score"}]}]} 00:03:06 INFO - Return code: 0 00:03:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:03:07 INFO - # TBPL SUCCESS # 00:03:07 INFO - Running post-action listener: _package_coverage_data 00:03:07 INFO - Running post-action listener: _resource_record_post_action 00:03:07 INFO - [mozharness: 2017-08-16 07:03:07.011551Z] Finished run-tests step (success) 00:03:07 INFO - Running post-run listener: _resource_record_post_run 00:03:07 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 435036160; Read time: 96; Write time: 282068 00:03:07 INFO - TinderboxPrint: CPU usage
13.1% 00:03:07 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 96 00:03:07 INFO - TinderboxPrint: I/O write bytes / time
435,036,160 / 282,068 00:03:07 INFO - TinderboxPrint: CPU idle
8,252.9 (86.9%) 00:03:07 INFO - TinderboxPrint: CPU user
1,195.8 (12.6%) 00:03:07 INFO - TinderboxPrint: Swap in / out
0 / 0 00:03:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107094016; Read time: 0; Write time: 86848 00:03:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:03:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327942144; Read time: 80; Write time: 195220 00:03:07 INFO - Running post-run listener: _upload_blobber_files 00:03:07 INFO - Blob upload gear active. 00:03:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:03:07 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 00:03:07 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:03:07 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:03:08 INFO - (blobuploader) - INFO - Open directory for files ... 00:03:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:03:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:03:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:08 INFO - (blobuploader) - INFO - Done attempting. 00:03:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:03:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:03:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:15 INFO - (blobuploader) - INFO - Done attempting. 00:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:16 INFO - (blobuploader) - INFO - Done attempting. 00:03:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:03:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:16 INFO - (blobuploader) - INFO - Done attempting. 00:03:16 INFO - (blobuploader) - INFO - Iteration through files over. 00:03:16 INFO - Return code: 0 00:03:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:03:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:03:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44af31f6d3b757b7a0a40fd5e6eaf0ab622ea03b2dbc6f381734aac3f45f9011d8b7f5f2c86406924271e5701f1bae302aa1a722137cf0910b4dedeb600068a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81729bbcbe3edd984dd651087e9338841e8d602d0df66cd825dfb4c9dca175a49917889ce188d12e49a04aee5fa4d482ba233fbe7581660a2d40b92ebe2243e5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/924a4ba73b2047292aec3b9624bc81eb6a16214d4686a820412267787e714dd75d87342f10def2638b9c4b4987e62a59d94d2e69c1cbf97aa918e798fae9d8cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60976e50b3520c09ae6203c5c316c93f84c363854d742aad64b3a5a5359ca02a98dd424485b6abd22efc63669489353853d86868308b4d1a98f6796eaa0de8ea"} 00:03:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:03:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:03:16 INFO - Contents: 00:03:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44af31f6d3b757b7a0a40fd5e6eaf0ab622ea03b2dbc6f381734aac3f45f9011d8b7f5f2c86406924271e5701f1bae302aa1a722137cf0910b4dedeb600068a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81729bbcbe3edd984dd651087e9338841e8d602d0df66cd825dfb4c9dca175a49917889ce188d12e49a04aee5fa4d482ba233fbe7581660a2d40b92ebe2243e5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/924a4ba73b2047292aec3b9624bc81eb6a16214d4686a820412267787e714dd75d87342f10def2638b9c4b4987e62a59d94d2e69c1cbf97aa918e798fae9d8cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60976e50b3520c09ae6203c5c316c93f84c363854d742aad64b3a5a5359ca02a98dd424485b6abd22efc63669489353853d86868308b4d1a98f6796eaa0de8ea"} 00:03:16 INFO - Running post-run listener: copy_logs_to_upload_dir 00:03:16 INFO - Copying logs to upload dir... 00:03:16 INFO - mkdir: /builds/slave/test/build/upload/logs 00:03:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.215512 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-16 00:03:16.339823) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:16.343626) ========= 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=bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352 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-Non-PGO/sha512/44af31f6d3b757b7a0a40fd5e6eaf0ab622ea03b2dbc6f381734aac3f45f9011d8b7f5f2c86406924271e5701f1bae302aa1a722137cf0910b4dedeb600068a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81729bbcbe3edd984dd651087e9338841e8d602d0df66cd825dfb4c9dca175a49917889ce188d12e49a04aee5fa4d482ba233fbe7581660a2d40b92ebe2243e5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/924a4ba73b2047292aec3b9624bc81eb6a16214d4686a820412267787e714dd75d87342f10def2638b9c4b4987e62a59d94d2e69c1cbf97aa918e798fae9d8cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60976e50b3520c09ae6203c5c316c93f84c363854d742aad64b3a5a5359ca02a98dd424485b6abd22efc63669489353853d86868308b4d1a98f6796eaa0de8ea"} build_url:https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44af31f6d3b757b7a0a40fd5e6eaf0ab622ea03b2dbc6f381734aac3f45f9011d8b7f5f2c86406924271e5701f1bae302aa1a722137cf0910b4dedeb600068a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81729bbcbe3edd984dd651087e9338841e8d602d0df66cd825dfb4c9dca175a49917889ce188d12e49a04aee5fa4d482ba233fbe7581660a2d40b92ebe2243e5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/924a4ba73b2047292aec3b9624bc81eb6a16214d4686a820412267787e714dd75d87342f10def2638b9c4b4987e62a59d94d2e69c1cbf97aa918e798fae9d8cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60976e50b3520c09ae6203c5c316c93f84c363854d742aad64b3a5a5359ca02a98dd424485b6abd22efc63669489353853d86868308b4d1a98f6796eaa0de8ea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:16.371029) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:16.371414) ========= 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=bb9b54edd4a927dc735d112f000001d9-1502859454.558217-1309480352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:16.459708) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 00:03:16.460127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 00:03:16.460481) ========= ========= Total master_lag: 0.18 =========