builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1505687070.47 results: success (0) revision: ae39864562c6048fdc2950c5dfedb48e247c3300 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:30.472278) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:30.472750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:30.473099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:30.586673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:30.587054) ========= 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=337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 15:24:30-- 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% 45.6M=0s 2017-09-17 15:24:30 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132603 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:30.772313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:30.772689) ========= 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=337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018494 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:30.838768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:30.839468) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ae39864562c6048fdc2950c5dfedb48e247c3300 --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 ae39864562c6048fdc2950c5dfedb48e247c3300 --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=337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 15:24:30,842 truncating revision to first 12 chars 2017-09-17 15:24:30,842 Setting DEBUG logging. 2017-09-17 15:24:30,842 attempt 1/10 2017-09-17 15:24:30,842 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ae39864562c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 15:24:31,387 unpacking tar archive at: mozilla-central-ae39864562c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.814814 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:31.680759) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:31.681072) ========= script_repo_revision: ae39864562c6048fdc2950c5dfedb48e247c3300 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:31.681470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:31.681742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:24:31.694223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-17 15:24:31.694525) ========= /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=337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:24:31 INFO - MultiFileLogger online at 20170917 15:24:31 in /builds/slave/test 15:24:31 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 15:24:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:31 INFO - {'append_to_log': False, 15:24:31 INFO - 'base_work_dir': '/builds/slave/test', 15:24:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:24:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:31 INFO - 'branch': 'Firefox-Non-PGO', 15:24:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:31 INFO - 'code_coverage': False, 15:24:31 INFO - 'config_files': ('talos/linux_config.py',), 15:24:31 INFO - 'default_actions': ('clobber', 15:24:31 INFO - 'read-buildbot-config', 15:24:31 INFO - 'download-and-extract', 15:24:31 INFO - 'populate-webroot', 15:24:31 INFO - 'create-virtualenv', 15:24:31 INFO - 'install', 15:24:31 INFO - 'setup-mitmproxy', 15:24:31 INFO - 'run-tests'), 15:24:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:31 INFO - 'disable_ccov_upload': False, 15:24:31 INFO - 'disable_stylo': False, 15:24:31 INFO - 'download_minidump_stackwalk': True, 15:24:31 INFO - 'download_symbols': 'ondemand', 15:24:31 INFO - 'enable_stylo': False, 15:24:31 INFO - 'enable_webrender': False, 15:24:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:24:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:31 INFO - 'gecko_profile': False, 15:24:31 INFO - 'gecko_profile_interval': 0, 15:24:31 INFO - 'installer_path': 'installer.exe', 15:24:31 INFO - 'log_level': 'info', 15:24:31 INFO - 'log_name': 'talos', 15:24:31 INFO - 'log_to_console': True, 15:24:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:24:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:24:31 INFO - 'opt_config_files': (), 15:24:31 INFO - 'pip_index': False, 15:24:31 INFO - 'suite': 'dromaeojs-e10s', 15:24:31 INFO - 'system_bits': '32', 15:24:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:31 INFO - 'title': 'talos-linux64-ix-060', 15:24:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:31 INFO - 'use_talos_json': True, 15:24:31 INFO - 'verify': 'False', 15:24:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:31 INFO - 'work_dir': 'build'} 15:24:31 INFO - [mozharness: 2017-09-17 22:24:31.828723Z] Running clobber step. 15:24:31 INFO - Running pre-action listener: _resource_record_pre_action 15:24:31 INFO - Running main action method: clobber 15:24:31 INFO - rmtree: /builds/slave/test/build 15:24:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:32 INFO - Running post-action listener: _resource_record_post_action 15:24:32 INFO - [mozharness: 2017-09-17 22:24:32.819453Z] Finished clobber step (success) 15:24:32 INFO - [mozharness: 2017-09-17 22:24:32.819553Z] Running read-buildbot-config step. 15:24:32 INFO - Running pre-action listener: _resource_record_pre_action 15:24:32 INFO - Running main action method: read_buildbot_config 15:24:32 INFO - Using buildbot properties: 15:24:32 INFO - { 15:24:32 INFO - "project": "", 15:24:32 INFO - "product": "firefox", 15:24:32 INFO - "who": "archaeopteryx@coole-files.de", 15:24:32 INFO - "installer_path": "public/build/target.tar.bz2", 15:24:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:24:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:24:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:24:32 INFO - "stage_platform": "linux64", 15:24:32 INFO - "basedir": "/builds/slave/test", 15:24:32 INFO - "buildnumber": 1155, 15:24:32 INFO - "platform": "ubuntu64_hw", 15:24:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:24:32 INFO - "slavebuilddir": "test", 15:24:32 INFO - "taskId": "TqpQ7lB0TrSAfPZ054gH1A", 15:24:32 INFO - "branch": "mozilla-central", 15:24:32 INFO - "script_repo_revision": "production", 15:24:32 INFO - "revision": "ae39864562c6048fdc2950c5dfedb48e247c3300", 15:24:32 INFO - "slavename": "talos-linux64-ix-060", 15:24:32 INFO - "repo_path": "mozilla-central" 15:24:32 INFO - } 15:24:32 INFO - Finding installer, test and symbols from parent task. 15:24:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TqpQ7lB0TrSAfPZ054gH1A'}, attempt #1 15:24:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TqpQ7lB0TrSAfPZ054gH1A'}, attempt #1 15:24:33 INFO - Task dependencies: b2Y79Ct6TZem2FvxMKycGw 15:24:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw'}, attempt #1 15:24:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json 15:24:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip 15:24:34 INFO - Running post-action listener: _resource_record_post_action 15:24:34 INFO - [mozharness: 2017-09-17 22:24:34.165610Z] Finished read-buildbot-config step (success) 15:24:34 INFO - [mozharness: 2017-09-17 22:24:34.165826Z] Running download-and-extract step. 15:24:34 INFO - Running pre-action listener: _resource_record_pre_action 15:24:34 INFO - Running main action method: download_and_extract 15:24:34 INFO - mkdir: /builds/slave/test/build/tests 15:24:34 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')]} 15:24:34 INFO - trying https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json 15:24:34 INFO - Downloading https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:24:34 INFO - Downloaded 989 bytes. 15:24:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:24:34 INFO - Using the following test package requirements: 15:24:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:24:34 INFO - u'common': [u'target.common.tests.zip'], 15:24:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:24:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:24:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:24:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:24:34 INFO - u'mozbase': [u'target.common.tests.zip'], 15:24:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:24:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:24:34 INFO - u'web-platform': [u'target.common.tests.zip', 15:24:34 INFO - u'target.web-platform.tests.tar.gz'], 15:24:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:24:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:24:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.common.tests.zip 15:24:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:24:34 INFO - Fetch https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.common.tests.zip into memory 15:24:35 INFO - Content-Length response header: 54731154 15:24:35 INFO - Bytes received: 54731154 15:24:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.talos.tests.zip 15:24:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:24:46 INFO - Fetch https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.talos.tests.zip into memory 15:24:47 INFO - Content-Length response header: 14508748 15:24:47 INFO - Bytes received: 14508748 15:24:47 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')]} 15:24:47 INFO - trying https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:47 INFO - Downloading https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:24:48 INFO - Downloaded 61436042 bytes. 15:24:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:48 INFO - mkdir: /builds/slave/test/properties 15:24:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:48 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:48 INFO - Contents: 15:24:48 INFO - build_url:https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 15:24:48 INFO - Running post-action listener: _resource_record_post_action 15:24:48 INFO - Running post-action listener: find_tests_for_verification 15:24:48 INFO - Running post-action listener: set_extra_try_arguments 15:24:48 INFO - [mozharness: 2017-09-17 22:24:48.708964Z] Finished download-and-extract step (success) 15:24:48 INFO - [mozharness: 2017-09-17 22:24:48.709138Z] Running populate-webroot step. 15:24:48 INFO - Running pre-action listener: _resource_record_pre_action 15:24:48 INFO - Running main action method: populate_webroot 15:24:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['tresize', 15:24:48 INFO - 'tcanvasmark']}, 15:24:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['dromaeo_css', 15:24:48 INFO - 'kraken']}, 15:24:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:48 INFO - 'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:24:48 INFO - 'tests': ['damp', 'tps']}, 15:24:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:48 INFO - 'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['damp', 'tps']}, 15:24:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['dromaeo_dom']}, 15:24:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:24:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['basic_compositor_video', 15:24:48 INFO - 'glvideo']}, 15:24:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:24:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:24:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:48 INFO - 'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['ts_paint_webext', 15:24:48 INFO - 'tp5o_webext']}, 15:24:48 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:48 INFO - 'ts_paint', 15:24:48 INFO - 'tpaint', 15:24:48 INFO - 'sessionrestore', 15:24:48 INFO - 'sessionrestore_many_windows', 15:24:48 INFO - 'sessionrestore_no_auto_restore', 15:24:48 INFO - 'tabpaint']}, 15:24:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['a11yr', 15:24:48 INFO - 'ts_paint', 15:24:48 INFO - 'tpaint', 15:24:48 INFO - 'sessionrestore', 15:24:48 INFO - 'sessionrestore_many_windows', 15:24:48 INFO - 'sessionrestore_no_auto_restore', 15:24:48 INFO - 'tabpaint']}, 15:24:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:24:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:24:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['perf_reftest_singletons']}, 15:24:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['bloom_basic']}, 15:24:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:48 INFO - 'tsvgr_opacity', 15:24:48 INFO - 'tart', 15:24:48 INFO - 'tscrollx', 15:24:48 INFO - 'tsvg_static']}, 15:24:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['tsvgx', 15:24:48 INFO - 'tsvgr_opacity', 15:24:48 INFO - 'tart', 15:24:48 INFO - 'tscrollx', 15:24:48 INFO - 'tsvg_static']}, 15:24:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:24:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:48 INFO - 'talos_options': ['--disable-stylo'], 15:24:48 INFO - 'tests': ['tp5o']}, 15:24:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:48 INFO - 'talos_options': ['--mitmproxy', 15:24:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:48 INFO - '--firstNonBlankPaint'], 15:24:48 INFO - 'tests': ['tp6_google', 15:24:48 INFO - 'tp6_youtube', 15:24:48 INFO - 'tp6_amazon', 15:24:48 INFO - 'tp6_facebook']}, 15:24:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:48 INFO - 'talos_options': ['--disable-stylo', 15:24:48 INFO - '--mitmproxy', 15:24:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:48 INFO - '--firstNonBlankPaint'], 15:24:48 INFO - 'tests': ['tp6_google', 15:24:48 INFO - 'tp6_youtube', 15:24:48 INFO - 'tp6_amazon', 15:24:48 INFO - 'tp6_facebook']}, 15:24:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:48 INFO - 'talos_options': ['--stylo-threads=1', 15:24:48 INFO - '--mitmproxy', 15:24:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:48 INFO - '--firstNonBlankPaint'], 15:24:48 INFO - 'tests': ['tp6_google', 15:24:48 INFO - 'tp6_youtube', 15:24:48 INFO - 'tp6_amazon', 15:24:48 INFO - 'tp6_facebook']}, 15:24:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:24:48 INFO - 'talos_options': ['--xperf_path', 15:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:48 INFO - 'tests': ['tp5n']}, 15:24:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:24:48 INFO - 'talos_options': ['--disable-stylo', 15:24:48 INFO - '--xperf_path', 15:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:48 INFO - 'tests': ['tp5n']}}} 15:24:48 INFO - Running post-action listener: _resource_record_post_action 15:24:48 INFO - [mozharness: 2017-09-17 22:24:48.725226Z] Finished populate-webroot step (success) 15:24:48 INFO - [mozharness: 2017-09-17 22:24:48.725315Z] Running create-virtualenv step. 15:24:48 INFO - Running pre-action listener: _resource_record_pre_action 15:24:48 INFO - Running main action method: create_virtualenv 15:24:48 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:24:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:24:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:24:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:49 INFO - Installing pip...............done. 15:24:49 INFO - Return code: 0 15:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:24:49 INFO - Reading from file tmpfile_stdout 15:24:49 INFO - Output received: 15:24:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:24:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24:49 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')]} 15:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:49 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')]} 15:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:49 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 0x23951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2701a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, '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': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', '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 15:24:49 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 15:24:49 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 15:24:49 INFO - Using env: {'DISPLAY': ':0', 15:24:49 INFO - 'HOME': '/home/cltbld', 15:24:49 INFO - 'LANG': 'en_US.UTF-8', 15:24:49 INFO - 'LANGUAGE': 'en_US:en', 15:24:49 INFO - 'LOGNAME': 'cltbld', 15:24:49 INFO - 'MAIL': '/var/mail/cltbld', 15:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:49 INFO - 'MOZ_NO_REMOTE': '1', 15:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:49 INFO - 'NO_EM_RESTART': '1', 15:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:49 INFO - 'PWD': '/builds/slave/test', 15:24:49 INFO - 'SHELL': '/bin/bash', 15:24:49 INFO - 'SHLVL': '1', 15:24:49 INFO - 'TERM': 'linux', 15:24:49 INFO - 'TMOUT': '86400', 15:24:49 INFO - 'USER': 'cltbld', 15:24:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:49 INFO - '_': '/tools/buildbot/bin/python'} 15:24:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:24:51 INFO - Downloading/unpacking pip>=1.5 15:24:51 INFO - Running setup.py egg_info for package pip 15:24:51 INFO - warning: no files found matching 'pip/cacert.pem' 15:24:51 INFO - warning: no files found matching '*.html' under directory 'docs' 15:24:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:24:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:24:51 INFO - Installing collected packages: pip 15:24:51 INFO - Found existing installation: pip 1.1 15:24:51 INFO - Uninstalling pip: 15:24:51 INFO - Successfully uninstalled pip 15:24:51 INFO - Running setup.py install for pip 15:24:51 INFO - warning: no files found matching 'pip/cacert.pem' 15:24:51 INFO - warning: no files found matching '*.html' under directory 'docs' 15:24:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:24:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:24:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:24:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:24:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:24:51 INFO - Successfully installed pip 15:24:51 INFO - Cleaning up... 15:24:51 INFO - Return code: 0 15:24:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:51 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 0x23951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2701a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, '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': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', '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 15:24:51 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 15:24:51 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 15:24:51 INFO - Using env: {'DISPLAY': ':0', 15:24:51 INFO - 'HOME': '/home/cltbld', 15:24:51 INFO - 'LANG': 'en_US.UTF-8', 15:24:51 INFO - 'LANGUAGE': 'en_US:en', 15:24:51 INFO - 'LOGNAME': 'cltbld', 15:24:51 INFO - 'MAIL': '/var/mail/cltbld', 15:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:51 INFO - 'MOZ_NO_REMOTE': '1', 15:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:51 INFO - 'NO_EM_RESTART': '1', 15:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:51 INFO - 'PWD': '/builds/slave/test', 15:24:51 INFO - 'SHELL': '/bin/bash', 15:24:51 INFO - 'SHLVL': '1', 15:24:51 INFO - 'TERM': 'linux', 15:24:51 INFO - 'TMOUT': '86400', 15:24:51 INFO - 'USER': 'cltbld', 15:24:51 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:51 INFO - '_': '/tools/buildbot/bin/python'} 15:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:51 INFO - Downloading/unpacking psutil>=3.1.1 15:24:51 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 15:24:51 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 15:24:51 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 15:24:51 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 15:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:52 INFO - Installing collected packages: psutil 15:24:52 INFO - Running setup.py install for psutil 15:24:52 INFO - building 'psutil._psutil_linux' extension 15:24:52 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 15:24:52 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 15:24:52 INFO - building 'psutil._psutil_posix' extension 15:24:52 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 15:24:52 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 15:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:52 INFO - Successfully installed psutil 15:24:52 INFO - Cleaning up... 15:24:53 INFO - Return code: 0 15:24:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:53 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 0x23951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2701a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, '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': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', '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 15:24:53 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 15:24:53 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 15:24:53 INFO - Using env: {'DISPLAY': ':0', 15:24:53 INFO - 'HOME': '/home/cltbld', 15:24:53 INFO - 'LANG': 'en_US.UTF-8', 15:24:53 INFO - 'LANGUAGE': 'en_US:en', 15:24:53 INFO - 'LOGNAME': 'cltbld', 15:24:53 INFO - 'MAIL': '/var/mail/cltbld', 15:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:53 INFO - 'MOZ_NO_REMOTE': '1', 15:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:53 INFO - 'NO_EM_RESTART': '1', 15:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:53 INFO - 'PWD': '/builds/slave/test', 15:24:53 INFO - 'SHELL': '/bin/bash', 15:24:53 INFO - 'SHLVL': '1', 15:24:53 INFO - 'TERM': 'linux', 15:24:53 INFO - 'TMOUT': '86400', 15:24:53 INFO - 'USER': 'cltbld', 15:24:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:53 INFO - '_': '/tools/buildbot/bin/python'} 15:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:24:53 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 15:24:53 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 15:24:53 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 15:24:53 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 15:24:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:24:54 INFO - Installing collected packages: mozsystemmonitor 15:24:54 INFO - Running setup.py install for mozsystemmonitor 15:24:54 INFO - Successfully installed mozsystemmonitor 15:24:54 INFO - Cleaning up... 15:24:55 INFO - Return code: 0 15:24:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:24:55 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')]} 15:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:55 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')]} 15:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:55 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 0x23951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2701a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, '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': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', '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 15:24:55 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 15:24:55 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 15:24:55 INFO - Using env: {'DISPLAY': ':0', 15:24:55 INFO - 'HOME': '/home/cltbld', 15:24:55 INFO - 'LANG': 'en_US.UTF-8', 15:24:55 INFO - 'LANGUAGE': 'en_US:en', 15:24:55 INFO - 'LOGNAME': 'cltbld', 15:24:55 INFO - 'MAIL': '/var/mail/cltbld', 15:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:55 INFO - 'MOZ_NO_REMOTE': '1', 15:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:55 INFO - 'NO_EM_RESTART': '1', 15:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:55 INFO - 'PWD': '/builds/slave/test', 15:24:55 INFO - 'SHELL': '/bin/bash', 15:24:55 INFO - 'SHLVL': '1', 15:24:55 INFO - 'TERM': 'linux', 15:24:55 INFO - 'TMOUT': '86400', 15:24:55 INFO - 'USER': 'cltbld', 15:24:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:55 INFO - '_': '/tools/buildbot/bin/python'} 15:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:55 INFO - Downloading/unpacking jsonschema==2.5.1 15:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:24:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:24:58 INFO - warning: no files found matching '*.txt' 15:24:58 INFO - no previously-included directories found matching 'build' 15:24:58 INFO - no previously-included directories found matching 'dist' 15:24:58 INFO - no previously-included directories found matching '.git*' 15:24:58 INFO - Installing collected packages: jsonschema, functools32 15:24:58 INFO - Running setup.py install for functools32 15:24:58 INFO - warning: no files found matching '*.txt' 15:24:58 INFO - no previously-included directories found matching 'build' 15:24:58 INFO - no previously-included directories found matching 'dist' 15:24:58 INFO - no previously-included directories found matching '.git*' 15:24:58 INFO - Successfully installed jsonschema functools32 15:24:58 INFO - Cleaning up... 15:24:58 INFO - Return code: 0 15:24:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24: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', '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 0x23951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2701a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, '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': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', '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 15:24: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:24: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 functools32==3.2.3-2 15:24:58 INFO - Using env: {'DISPLAY': ':0', 15:24:58 INFO - 'HOME': '/home/cltbld', 15:24:58 INFO - 'LANG': 'en_US.UTF-8', 15:24:58 INFO - 'LANGUAGE': 'en_US:en', 15:24:58 INFO - 'LOGNAME': 'cltbld', 15:24:58 INFO - 'MAIL': '/var/mail/cltbld', 15:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:58 INFO - 'MOZ_NO_REMOTE': '1', 15:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:58 INFO - 'NO_EM_RESTART': '1', 15:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:58 INFO - 'PWD': '/builds/slave/test', 15:24:58 INFO - 'SHELL': '/bin/bash', 15:24:58 INFO - 'SHLVL': '1', 15:24:58 INFO - 'TERM': 'linux', 15:24:58 INFO - 'TMOUT': '86400', 15:24:58 INFO - 'USER': 'cltbld', 15:24:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:58 INFO - '_': '/tools/buildbot/bin/python'} 15:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:24:58 INFO - Cleaning up... 15:24:58 INFO - Return code: 0 15:24:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24: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', '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 0x23951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2701a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, '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': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', '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 15:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:24: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 blobuploader==1.2.4 15:24:58 INFO - Using env: {'DISPLAY': ':0', 15:24:58 INFO - 'HOME': '/home/cltbld', 15:24:58 INFO - 'LANG': 'en_US.UTF-8', 15:24:58 INFO - 'LANGUAGE': 'en_US:en', 15:24:58 INFO - 'LOGNAME': 'cltbld', 15:24:58 INFO - 'MAIL': '/var/mail/cltbld', 15:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:58 INFO - 'MOZ_NO_REMOTE': '1', 15:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:58 INFO - 'NO_EM_RESTART': '1', 15:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:58 INFO - 'PWD': '/builds/slave/test', 15:24:58 INFO - 'SHELL': '/bin/bash', 15:24:58 INFO - 'SHLVL': '1', 15:24:58 INFO - 'TERM': 'linux', 15:24:58 INFO - 'TMOUT': '86400', 15:24:58 INFO - 'USER': 'cltbld', 15:24:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:58 INFO - '_': '/tools/buildbot/bin/python'} 15:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:58 INFO - Downloading/unpacking blobuploader==1.2.4 15:24: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 15:24: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 15:24: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 15:24: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 15:24:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:24:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:24:59 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 15:24:59 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 15:24:59 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 15:24:59 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 15:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:25:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:25: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 15:25: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 15:25: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 15:25: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 15:25:00 INFO - Downloading docopt-0.6.1.tar.gz 15:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:25:00 INFO - Installing collected packages: blobuploader, requests, docopt 15:25:00 INFO - Running setup.py install for blobuploader 15:25:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:25:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:25:00 INFO - Running setup.py install for requests 15:25:00 INFO - Running setup.py install for docopt 15:25:00 INFO - Successfully installed blobuploader requests docopt 15:25:00 INFO - Cleaning up... 15:25:00 INFO - Return code: 0 15:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25: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')]} 15:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:00 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 0x23951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2701a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, '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': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', '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 15:25:00 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 15:25:00 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 15:25:00 INFO - Using env: {'DISPLAY': ':0', 15:25:00 INFO - 'HOME': '/home/cltbld', 15:25:00 INFO - 'LANG': 'en_US.UTF-8', 15:25:00 INFO - 'LANGUAGE': 'en_US:en', 15:25:00 INFO - 'LOGNAME': 'cltbld', 15:25:00 INFO - 'MAIL': '/var/mail/cltbld', 15:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:00 INFO - 'MOZ_NO_REMOTE': '1', 15:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:00 INFO - 'NO_EM_RESTART': '1', 15:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:00 INFO - 'PWD': '/builds/slave/test', 15:25:00 INFO - 'SHELL': '/bin/bash', 15:25:00 INFO - 'SHLVL': '1', 15:25:00 INFO - 'TERM': 'linux', 15:25:00 INFO - 'TMOUT': '86400', 15:25:00 INFO - 'USER': 'cltbld', 15:25:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:00 INFO - '_': '/tools/buildbot/bin/python'} 15:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:01 INFO - Running setup.py (path:/tmp/pip-f3GX_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:01 INFO - Running setup.py (path:/tmp/pip-EUo5ZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:01 INFO - Running setup.py (path:/tmp/pip-xQK_h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:01 INFO - Running setup.py (path:/tmp/pip-pleibQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:01 INFO - Running setup.py (path:/tmp/pip-DTtTJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:01 INFO - Running setup.py (path:/tmp/pip-mziBgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:01 INFO - Running setup.py (path:/tmp/pip-OXU9sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:01 INFO - Running setup.py (path:/tmp/pip-7Tm9QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:01 INFO - Running setup.py (path:/tmp/pip-2K3Ov3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:01 INFO - Running setup.py (path:/tmp/pip-90gEZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:01 INFO - Running setup.py (path:/tmp/pip-E3_uSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:01 INFO - Running setup.py (path:/tmp/pip-f68oh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:02 INFO - Running setup.py (path:/tmp/pip-KpA40D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:02 INFO - Running setup.py (path:/tmp/pip-3gvVq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:02 INFO - Running setup.py (path:/tmp/pip-YDkHdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:02 INFO - Running setup.py (path:/tmp/pip-x2cMMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:02 INFO - Running setup.py (path:/tmp/pip-CoO7Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:25:02 INFO - Running setup.py install for manifestparser 15:25:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozcrash 15:25:02 INFO - Running setup.py install for mozdebug 15:25:02 INFO - Running setup.py install for mozdevice 15:25:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozfile 15:25:02 INFO - Running setup.py install for mozhttpd 15:25:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozinfo 15:25:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Running setup.py install for mozInstall 15:25:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Running setup.py install for mozleak 15:25:03 INFO - Running setup.py install for mozlog 15:25:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Running setup.py install for moznetwork 15:25:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Running setup.py install for mozprocess 15:25:03 INFO - Running setup.py install for mozprofile 15:25:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Running setup.py install for mozrunner 15:25:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Running setup.py install for mozscreenshot 15:25:03 INFO - Running setup.py install for moztest 15:25:04 INFO - Running setup.py install for mozversion 15:25:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:25:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:25:04 INFO - Cleaning up... 15:25:04 INFO - Return code: 0 15:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:04 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')]} 15:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:04 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')]} 15:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:04 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 0x23951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2701a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, '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': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', '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 15:25:04 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 15:25:04 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 15:25:04 INFO - Using env: {'DISPLAY': ':0', 15:25:04 INFO - 'HOME': '/home/cltbld', 15:25:04 INFO - 'LANG': 'en_US.UTF-8', 15:25:04 INFO - 'LANGUAGE': 'en_US:en', 15:25:04 INFO - 'LOGNAME': 'cltbld', 15:25:04 INFO - 'MAIL': '/var/mail/cltbld', 15:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:04 INFO - 'MOZ_NO_REMOTE': '1', 15:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:04 INFO - 'NO_EM_RESTART': '1', 15:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:04 INFO - 'PWD': '/builds/slave/test', 15:25:04 INFO - 'SHELL': '/bin/bash', 15:25:04 INFO - 'SHLVL': '1', 15:25:04 INFO - 'TERM': 'linux', 15:25:04 INFO - 'TMOUT': '86400', 15:25:04 INFO - 'USER': 'cltbld', 15:25:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:04 INFO - '_': '/tools/buildbot/bin/python'} 15:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:04 INFO - Running setup.py (path:/tmp/pip-SdUQrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:04 INFO - Running setup.py (path:/tmp/pip-NWucMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:04 INFO - Running setup.py (path:/tmp/pip-9K6o4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:04 INFO - Running setup.py (path:/tmp/pip-AONjjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:04 INFO - Running setup.py (path:/tmp/pip-Y2Kykk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:04 INFO - Running setup.py (path:/tmp/pip-2TRYLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:04 INFO - Running setup.py (path:/tmp/pip-GFCgwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:04 INFO - Running setup.py (path:/tmp/pip-l2VUSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:04 INFO - Running setup.py (path:/tmp/pip-heHOmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:04 INFO - Running setup.py (path:/tmp/pip-BlKp9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:05 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)) 15:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:05 INFO - Running setup.py (path:/tmp/pip-hVQYX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:05 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)) 15:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:05 INFO - Running setup.py (path:/tmp/pip-h8Tlmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:05 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)) 15:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:05 INFO - Running setup.py (path:/tmp/pip-IyjtKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:05 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)) 15:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:05 INFO - Running setup.py (path:/tmp/pip-JfAPXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:05 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)) 15:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:05 INFO - Running setup.py (path:/tmp/pip-2kD6_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:05 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)) 15:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:05 INFO - Running setup.py (path:/tmp/pip-6boQ5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:05 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)) 15:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:05 INFO - Running setup.py (path:/tmp/pip-YfvSmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:05 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)) 15:25:05 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)) 15:25:05 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)) 15:25:05 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)) 15:25:05 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)) 15:25:05 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)) 15:25:05 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)) 15:25:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25: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 15:25: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 15:25: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 15:25: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 15:25:06 INFO - Downloading blessings-1.6.tar.gz 15:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:25:06 INFO - Installing collected packages: blessings 15:25:06 INFO - Running setup.py install for blessings 15:25:06 INFO - Successfully installed blessings 15:25:06 INFO - Cleaning up... 15:25:06 INFO - Return code: 0 15:25:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:07 INFO - Reading from file tmpfile_stdout 15:25:07 INFO - Current package versions: 15:25:07 INFO - argparse == 1.2.1 15:25:07 INFO - blessings == 1.6 15:25:07 INFO - blobuploader == 1.2.4 15:25:07 INFO - docopt == 0.6.1 15:25:07 INFO - functools32 == 3.2.3-2 15:25:07 INFO - jsonschema == 2.5.1 15:25:07 INFO - manifestparser == 1.1 15:25:07 INFO - mozInstall == 1.13 15:25:07 INFO - mozcrash == 1.0 15:25:07 INFO - mozdebug == 0.1 15:25:07 INFO - mozdevice == 0.51 15:25:07 INFO - mozfile == 1.2 15:25:07 INFO - mozhttpd == 0.7 15:25:07 INFO - mozinfo == 0.10 15:25:07 INFO - mozleak == 0.1 15:25:07 INFO - mozlog == 3.5 15:25:07 INFO - moznetwork == 0.27 15:25:07 INFO - mozprocess == 0.25 15:25:07 INFO - mozprofile == 0.28 15:25:07 INFO - mozrunner == 6.13 15:25:07 INFO - mozscreenshot == 0.1 15:25:07 INFO - mozsystemmonitor == 0.3 15:25:07 INFO - moztest == 0.8 15:25:07 INFO - mozversion == 1.4 15:25:07 INFO - psutil == 3.1.1 15:25:07 INFO - requests == 1.2.3 15:25:07 INFO - wsgiref == 0.1.2 15:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:07 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')]} 15:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:07 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')]} 15:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:07 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 0x23951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2701a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, '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': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', '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 15:25:07 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 15:25:07 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 15:25:07 INFO - Using env: {'DISPLAY': ':0', 15:25:07 INFO - 'HOME': '/home/cltbld', 15:25:07 INFO - 'LANG': 'en_US.UTF-8', 15:25:07 INFO - 'LANGUAGE': 'en_US:en', 15:25:07 INFO - 'LOGNAME': 'cltbld', 15:25:07 INFO - 'MAIL': '/var/mail/cltbld', 15:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:07 INFO - 'MOZ_NO_REMOTE': '1', 15:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:07 INFO - 'NO_EM_RESTART': '1', 15:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:07 INFO - 'PWD': '/builds/slave/test', 15:25:07 INFO - 'SHELL': '/bin/bash', 15:25:07 INFO - 'SHLVL': '1', 15:25:07 INFO - 'TERM': 'linux', 15:25:07 INFO - 'TMOUT': '86400', 15:25:07 INFO - 'USER': 'cltbld', 15:25:07 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:07 INFO - '_': '/tools/buildbot/bin/python'} 15:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:07 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)) 15:25:07 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)) 15:25:07 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)) 15:25:07 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)) 15:25:07 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)) 15:25:07 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)) 15:25:07 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)) 15:25:07 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)) 15:25:07 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)) 15:25:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:25:07 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 15:25:07 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 15:25:07 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 15:25:07 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 15:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:25:08 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)) 15:25:08 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)) 15:25:08 INFO - Installing collected packages: simplejson 15:25:08 INFO - Running setup.py install for simplejson 15:25:08 INFO - building 'simplejson._speedups' extension 15:25:08 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 15:25:09 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 15:25:09 INFO - Successfully installed simplejson 15:25:09 INFO - Cleaning up... 15:25:09 INFO - Return code: 0 15:25:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25: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')]} 15:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:09 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 0x23951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2701a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, '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': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', '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 15:25:09 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 15:25:09 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 15:25:09 INFO - Using env: {'DISPLAY': ':0', 15:25:09 INFO - 'HOME': '/home/cltbld', 15:25:09 INFO - 'LANG': 'en_US.UTF-8', 15:25:09 INFO - 'LANGUAGE': 'en_US:en', 15:25:09 INFO - 'LOGNAME': 'cltbld', 15:25:09 INFO - 'MAIL': '/var/mail/cltbld', 15:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:09 INFO - 'MOZ_NO_REMOTE': '1', 15:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:09 INFO - 'NO_EM_RESTART': '1', 15:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:09 INFO - 'PWD': '/builds/slave/test', 15:25:09 INFO - 'SHELL': '/bin/bash', 15:25:09 INFO - 'SHLVL': '1', 15:25:09 INFO - 'TERM': 'linux', 15:25:09 INFO - 'TMOUT': '86400', 15:25:09 INFO - 'USER': 'cltbld', 15:25:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:09 INFO - '_': '/tools/buildbot/bin/python'} 15:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:25:09 INFO - Cleaning up... 15:25:09 INFO - Return code: 0 15:25:09 INFO - Running post-action listener: _resource_record_post_action 15:25:09 INFO - Running post-action listener: _start_resource_monitoring 15:25:09 INFO - Starting resource monitoring. 15:25:09 INFO - [mozharness: 2017-09-17 22:25:09.807208Z] Finished create-virtualenv step (success) 15:25:09 INFO - [mozharness: 2017-09-17 22:25:09.807797Z] Running install step. 15:25:09 INFO - Running pre-action listener: _resource_record_pre_action 15:25:09 INFO - Running main action method: install 15:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:10 INFO - Reading from file tmpfile_stdout 15:25:10 INFO - Detecting whether we're running mozinstall >=1.0... 15:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:25:10 INFO - Reading from file tmpfile_stdout 15:25:10 INFO - Output received: 15:25:10 INFO - Usage: mozinstall [options] installer 15:25:10 INFO - Options: 15:25:10 INFO - -h, --help show this help message and exit 15:25:10 INFO - -d DEST, --destination=DEST 15:25:10 INFO - Directory to install application into. [default: 15:25:10 INFO - "/builds/slave/test"] 15:25:10 INFO - --app=APP Application being installed. [default: firefox] 15:25:10 INFO - mkdir: /builds/slave/test/build/application 15:25:10 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'] 15:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:25:27 INFO - Reading from file tmpfile_stdout 15:25:27 INFO - Output received: 15:25:27 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:27 INFO - Running post-action listener: _resource_record_post_action 15:25:27 INFO - [mozharness: 2017-09-17 22:25:27.938819Z] Finished install step (success) 15:25:27 INFO - [mozharness: 2017-09-17 22:25:27.939070Z] Running setup-mitmproxy step. 15:25:27 INFO - Running pre-action listener: _resource_record_pre_action 15:25:27 INFO - Running main action method: setup_mitmproxy 15:25:27 INFO - Skipping: mitmproxy is not required 15:25:27 INFO - Running post-action listener: _resource_record_post_action 15:25:27 INFO - [mozharness: 2017-09-17 22:25:27.940278Z] Finished setup-mitmproxy step (success) 15:25:27 INFO - [mozharness: 2017-09-17 22:25:27.940496Z] Running run-tests step. 15:25:27 INFO - Running pre-action listener: _resource_record_pre_action 15:25:27 INFO - Running pre-action listener: _set_gcov_prefix 15:25:27 INFO - Running main action method: run_tests 15:25:27 WARNING - Try message not found. 15:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:27 INFO - Python 2.7.3 15:25:27 INFO - Return code: 0 15:25:27 INFO - grabbing minidump binary from tooltool 15:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2705090>, '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 0x2705d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:25:27 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:25:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:25:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:28 INFO - Return code: 0 15:25:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:28 INFO - ENV: RUST_BACKTRACE is now full 15:25:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:28 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/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 15:25:28 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/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 15:25:28 INFO - Using env: {'DISPLAY': ':0', 15:25:28 INFO - 'HOME': '/home/cltbld', 15:25:28 INFO - 'LANG': 'en_US.UTF-8', 15:25:28 INFO - 'LANGUAGE': 'en_US:en', 15:25:28 INFO - 'LOGNAME': 'cltbld', 15:25:28 INFO - 'MAIL': '/var/mail/cltbld', 15:25:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:28 INFO - 'MOZ_NO_REMOTE': '1', 15:25:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:28 INFO - 'NO_EM_RESTART': '1', 15:25:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:28 INFO - 'PWD': '/builds/slave/test', 15:25:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:28 INFO - 'RUST_BACKTRACE': 'full', 15:25:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:25:28 INFO - 'SHELL': '/bin/bash', 15:25:28 INFO - 'SHLVL': '1', 15:25:28 INFO - 'TERM': 'linux', 15:25:28 INFO - 'TMOUT': '86400', 15:25:28 INFO - 'USER': 'cltbld', 15:25:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:28 INFO - '_': '/tools/buildbot/bin/python'} 15:25:28 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/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 15:25:28 INFO - mozversion application_buildid: 20170917213235 15:25:28 INFO - mozversion application_changeset: ae39864562c6048fdc2950c5dfedb48e247c3300 15:25:28 INFO - mozversion application_display_name: Nightly 15:25:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:28 INFO - mozversion application_name: Firefox 15:25:28 INFO - mozversion application_remotingname: firefox 15:25:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:25:28 INFO - mozversion application_vendor: Mozilla 15:25:28 INFO - mozversion application_version: 57.0a1 15:25:28 INFO - mozversion platform_buildid: 20170917213235 15:25:28 INFO - mozversion platform_changeset: ae39864562c6048fdc2950c5dfedb48e247c3300 15:25:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:25:28 INFO - mozversion platform_version: 57.0a1 15:25:28 INFO - using testdate: 1505687128 15:25:28 INFO - actual date: 1505687128 15:25:28 INFO - starting webserver on 'localhost:44361' 15:25:28 INFO - SUITE-START | Running 2 tests 15:25:28 INFO - TEST-START | dromaeo_css 15:25:28 INFO - Initialising browser for dromaeo_css test... 15:25:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44361/getInfo.html -profile /tmp/tmpt_QYxz/profile 15:25:28 INFO - TEST-INFO | started process 8373 (/builds/slave/test/build/application/firefox/firefox http://localhost:44361/getInfo.html) 15:25:33 INFO - TEST-INFO | 8373: exit 0 15:25:34 INFO - Browser initialized. 15:25:34 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:34 INFO - Using env: {'DISPLAY': ':0', 15:25:34 INFO - 'HOME': '/home/cltbld', 15:25:34 INFO - 'JSGC_DISABLE_POISONING': '1', 15:25:34 INFO - 'LANG': 'en_US.UTF-8', 15:25:34 INFO - 'LANGUAGE': 'en_US:en', 15:25:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:25:34 INFO - 'LOGNAME': 'cltbld', 15:25:34 INFO - 'MAIL': '/var/mail/cltbld', 15:25:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:34 INFO - 'MOZ_CRASHREPORTER': '1', 15:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:25:34 INFO - 'MOZ_NO_REMOTE': '1', 15:25:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:34 INFO - 'NO_EM_RESTART': '1', 15:25:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:34 INFO - 'PWD': '/builds/slave/test', 15:25:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:34 INFO - 'RUST_BACKTRACE': 'full', 15:25:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:25:34 INFO - 'SHELL': '/bin/bash', 15:25:34 INFO - 'SHLVL': '1', 15:25:34 INFO - 'TERM': 'linux', 15:25:34 INFO - 'TMOUT': '86400', 15:25:34 INFO - 'USER': 'cltbld', 15:25:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:34 INFO - '_': '/tools/buildbot/bin/python'} 15:25:34 INFO - TEST-INFO | started process 8605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_QYxz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:34 INFO - PID 8605 | 15:25:34 INFO - PID 8605 | (/builds/slave/test/build/application/firefox/firefox:8654): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:25:34 INFO - PID 8605 | 15:25:45 INFO - PID 8605 | RSS: Main: 157102080 15:25:45 INFO - PID 8605 | 15:28:42 INFO - PID 8605 | Cycle 1(1): loaded http://localhost:44361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44361/tests/dromaeo/cssquery-ext.html) 15:28:44 INFO - PID 8605 | RSS: Main: 156745728 15:28:44 INFO - PID 8605 | 15:31:46 INFO - PID 8605 | Cycle 1(1): loaded http://localhost:44361/tests/dromaeo/cssquery-ext.html (next: http://localhost:44361/tests/dromaeo/cssquery-jquery.html) 15:31:46 INFO - PID 8605 | RSS: Main: 154595328 15:31:46 INFO - PID 8605 | 15:34:48 INFO - PID 8605 | Cycle 1(1): loaded http://localhost:44361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44361/tests/dromaeo/cssquery-mootools.html) 15:34:49 INFO - PID 8605 | RSS: Main: 156811264 15:34:49 INFO - PID 8605 | 15:37:50 INFO - PID 8605 | Cycle 1(1): loaded http://localhost:44361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44361/tests/dromaeo/cssquery-prototype.html) 15:37:51 INFO - PID 8605 | RSS: Main: 156721152 15:37:51 INFO - PID 8605 | 15:40:54 INFO - PID 8605 | Cycle 1(1): loaded http://localhost:44361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44361/tests/dromaeo/cssquery-yui.html) 15:40:55 INFO - PID 8605 | RSS: Main: 157913088 15:40:55 INFO - PID 8605 | 15:43:56 INFO - PID 8605 | Cycle 1(1): loaded http://localhost:44361/tests/dromaeo/cssquery-yui.html (next: http://localhost:44361/tests/dromaeo/cssquery-dojo.html) 15:43:56 INFO - PID 8605 | RSS: Main: 160104448 15:43:56 INFO - PID 8605 | 15:43:56 INFO - PID 8605 | __start_tp_report 15:43:56 INFO - PID 8605 | _x_x_mozilla_page_load 15:43:56 INFO - PID 8605 | _x_x_mozilla_page_load_details 15:43:56 INFO - PID 8605 | |i|pagename|runs| 15:43:56 INFO - PID 8605 | |0;dojo.html;3067.585875906753;3107.999999999999;3114.7041031102053;3124.4376012317803;3152.637446693631;6240.4071613196675;6328.778492752755;6368.713407896645;6396;6456.7094480748365;6275.278342990558;6360.236771587404;6383.936160638392;6454.19322584677;6462.773802916899;1311.4627696968878;5852.619579727304;5910.113482977545;5949.5537834662355;5950.226470558821;5753.510951569122;5774.191613174159;5904.970475147618;5910.704464776765;5937.109433584954;5819.7672093116435;5838.737256823453;5880.647161170344;5906.822795316148;5915.940840591582;5829.8251052468495;5850.76596936122;5901.468867801876;5908.793192238251;5918.7928422505;5811.099279611667;5818.41815818419;5881.2354393928945;5892.351841297454;5901.468867801918;6120.510359171256;6247.75008999644;6340.175777148941;6424;6429.4856411487435;6792.049113124167;6818.522703410763;6889.931100688979;6895.138107736533;6897.48268879836;6953.408960238386;6968.581885086911;6985.545939513915;6988.056612357368;6999.930000700029;6344.6827658616885;6363.61818290904;6399.360063993563;6435.549511534195;6441.3880681335195;6865.5537390069485;6991.335823096798;6993.230744618088;6997.090378250897;7001.439884809305;6677.098591690156;6692.5984440932725;6696.732130714814;6700.195976482853;6709.5303328767495;6857.5199736018;6907;6951.409130223988;6951.930480695129;6957.130358705162;6822.11312529368;6832.521723479408;6851.862962740817;6926.099607051051;6929.75745848903;6646.53474256807;6793.898091528631;6797.830054248683;6853.588784672936;6950.54821436605;5316.787328506894;5330.600204984642;5353.785848566092;5402.432744561765;5417.241586177938;4695.577398034194;4772.3557319762085;4774.3077253798;4777.140114779304;4780.856574302777;5854.151148083504;5870.383609721003;5940.435658612511;5949.881002379928;5949.970250148722;6684.064231007663;6798.558093723892;6856.5200435969;6866.519343645997;6969.1985421676145;5814.30228372598;5893.705314734246;5902.970485147633;5909.527237820964;5910.674912879833;5855.2973643163095;5907.881842363128;5915.319738230072;5930.881382372415;5938.881222375615;6571.638559879252;6592.703328350236;6608.504362172856;6665.233498147775;6674.666266686646;6597.076409302797;6715.462762978852;6810.727570897307;6932.029515867783;6966.825829354307;6462.579932304385;6609.504287178384;6616.801495955129;6625.966870165618;6627.304133065959;6772.25505194438;6787.762428314985;6846.178458585002;6849.349311815369;6849.623270720158;6893.138357705287;6899.275576064641;6909.550879192836;6985.860282794417;6991.44068474531;6460.192475940507;6613.404793568602;6615;6620.337966203341;6669.599824010381;6566.737330506918;6569.24453687832;6575;6577.4409175218725;6601.3728695773825;6381.074744162163;6499.935000650122;6609.834754130993;6623.172103487064;6646.368594983469;6671.066050752996;6724.596524208563;6776.796696099125;6777.491688123509;6784.185897692111;6353.14232578596;6457.257415397289;6469.450096741642;6543.640099794557;6551.475881929529 15:43:56 INFO - PID 8605 | |1;ext.html;867.405827008499;892.321835405092;896.3994123936966;896.623418164371;905.2893478619285;39907.2018559629;41681.58318416819;41730.58269417305;41738;41812;39058.21883562327;39505;39510.80244598773;39519.40720889189;39585.40621890674;7203.3877120444695;7294.088238970129;7314;7317.890231646529;7325.157606875225;7180.820479488002;7213.422926165894;7214.711411543558;7254.927450725478;7286.125664920217;7736.535807851519;7986.2013798620255;8031.598420079002;8038.196180381944;8040.075391329984;7872.803179920491;7972.800679983046;7973;7981.561014144219;7981.800454988643;7709.807254818675;7788.221177882223;7856.410769192334;7865.449418540705;7933.682652693886;37810.62189378098;38133.427998580046;38224.42663360052;38261.808690956364;38284.617153828665;3444.156181735466;3450.016745227598;3472.1840367513614;3472.58329000519;3479.634638362986;31073;31497.21256968571;31510;31575.736970521153;31594.210144746336;5095.898082038376;5235.712035838027;5243.68537887728;5265.262863199156;5265.710385928773;174284;174702;174885;174897;175326;41418;42086.36870446946;47527;49950.50049499459;50595;52086.47913520892;52253;52273;52316;52316.73841630767;16463.506094817174;16556.586085347964;16580.336786528645;16603.83396166047;16614.169291535374;13438.059335846592;13477.663058423423;13527.66180845467;13603.387847546885;13608.455661773418;14209.573712788633;14270.429182832571;14279.357428915724;14324.928375358057;14426.495072672617;5709.400512946164;5730.656160630376;5849.239598852122;5861.706914654335;5931.466168044811;998.9051040151174;1016.1261315268863;1017.8574999500075;1034.4000479721744;1044.6657069737612;22778.31665050051;23087.653685194735;23130.7686923132;23262.3021309361;23383.41541461477;1111.3887361950895;1125.7579620381493;1135.3528488761492;1136.4147464056018;1137.70988397958;12171.878281217074;12190;12272.447739851728;12343.876561234452;12354.691132721575;223310;224535;224868;225624;226479;52972;53025;53156.46843531515;53490;53556;1425.0808228692642;1476.3946781819188;1484;1484.1836989655646;1499.6700725840299;22549;22635.20776772805;22774;22933.65599516042;22953.540929181658;34599.82700086483;34732.47901281432;34863.47704784481;34867.65132348746;34909.47635785516;185526;187183;187864;187920;188113;33522;35913.46129808003;37355.252894941405;37388.626113738515;37476.812615936746;43828.78085609679;45408;45535;45905;46069.53930460652;33265.33469330648;33265.501017484276;33502;33786.49320260247;33844.323113538085;33570.66429335773;33638.495422568194;33888;34033.65966340305;34457.48313775245;37390.81304593568;37435.25129497449;37441.625583743815;37630.62369376271;37688.43467348047;32645.34709305848;32739.672603273662;32756.672433275362;32767.18082047968;33612.66387336095;23975.400614984766;24111.879440602686;24420.877895610407;24644.753552464244;24681.876590616932 15:43:56 INFO - PID 8605 | |2;jquery.html;560.2744445942504;561.9634723742956;567.2002476508125;569.7179895951505;574.6008469377067;21640.35078947632;22481;22543.436414089676;22550;22575.096996120155;23511.177108801196;24447.144349947754;24861.75138248617;24943;25745.22764317069;6585.93414065858;6676.666166691671;6677.298883617199;6686.264510903797;6696.665166741668;6552.803415897531;6605.70274337656;6610.900836487456;6689.866202675944;6714.328567143295;6621.635810030471;6731.899021514681;6991.580505169681;7052.858942821141;7184.173820010714;6984.650767461632;7155.391791697712;7162.713491460361;7184.066071410735;7184.892226616605;6725.865482690368;7025.156981162242;7036.894446583306;7046.084009078838;7047.872340425559;30940.38119237625;31438.685613144033;31450.37099258025;31489.685103149135;31512.36975260505;2034.7965203479534;2055.2190167736167;2066.4627196928755;2076.6573515370096;2081.115525901501;20277.898610506854;20329.695054574193;20666.793332066638;21415.892920535454;21577.892110539502;2569.6402503649506;2573.3052075939577;2641.141628970573;2650.7084220735896;2655.3361659585103;115727;120380.39809800983;129471.35264323713;137276;138021.3098934509;20007.699884501744;21312.254071107436;21847.781522184894;21940.670889936664;21994.45013874666;41844.372334415006;41975;41979;42158.36762448504;42251.7887410561;11462.828057578976;11545;11676.532938682527;11711.648650540497;11766.5881694142;9744.220462362993;9751.414915105117;9839.704808855746;9933.65232216869;9933.652322168833;11170.664880053611;11258.155638327158;11435.485403156878;11636.476358563885;11688.532458701728;3798.3732684107367;4025.5571887092397;4115.691323150776;4267.97866010668;4402.669799765031;935.9391639543408;944.5088553951906;960.2653969713175;965.3001573858896;974.6539978307599;19081.236750529824;19283;19284.13221405012;19340.419787406117;19646.70529942052;1024.8206563851297;1027.2860362048305;1035.4563853976722;1036.6786296248188;1036.9014943580498;10564.102051325723;10766.461676916122;10781.838272425919;10883.940486386367;10921.126309895348;480699;485512;493713;493790;498573;112352.75294494064;113235;114802.42598786953;115806;115825;1119.5409881948524;1132.603588743933;1167.0663469224587;1168.1005625668188;1171.4318555500574;16996.49592857869;17080.74378884293;17526.036068016383;17571.385001524886;17646.294148233927;55138;55648;56714.716426419254;57447;58715.70642146762;70641.29358706347;71139.28860711327;71603.64198179184;71840.64079679568;72773;19739.506512337306;19954.20183192656;20066.799332006492;20286.89856550708;20415;19473.221071156993;19477.805221947598;19972.50068748293;23056.769432305464;23472.295831125095;18234.908825456318;18243.908780456542;18244.635107297516;18503.81496185075;18555.628887422445;14588.197649129399;15368;16126.113063781604;16726.58183545421;16835.074070926217;18716;18907.62184756325;19057.428277151706;19081.90459047696;19177.616447671247;20126.69809952881;20148.38812894994;20285.681430706958;20290.98545072711;20370.18519259213;18282.634347312713;18354.72467913009;18408.815911841248;18438.907805460887;18685.15916783775 15:43:56 INFO - PID 8605 | |3;mootools.html;1331.9334033298335;1403.3334166271022;1409.077054529283;1412.5126831243217;1415.4055296775352;15697.215139243035;16111;16157.83842161581;16207.108609026498;16251.268692908818;15891.682166356666;15986;16045;16074.919625401886;16077.678446431064;2795.2872017635473;2820.9153725388273;2859.8570071496447;2864.6275984122035;2867.268846444154;2713.986430067857;2739.6164536964843;2753.5731961545994;2759.84820834854;2761.765249953746;2740.4245108527134;2763.0467488716463;2775.3200465885884;2778.7082356352594;2786.986065069672;2352.3178278299274;2455.17751553229;2457.103157347573;2734.6855111662016;2808.817426867247;2579.0457530713757;2639.2214296782495;2659.228823641142;2663.893444262227;2665.5335316319565;14784.852151478455;15040.623984400368;15150;15197.240137993056;15219.391224351013;7905.841883162305;8243.958780206121;8262.876056859152;8264.21489958453;8376.329893608498;5333.599980001477;5456.863578410532;5572.4148964358565;5643.322801263834;5757.856053598652;1937.2417510030637;1960.4804726747423;1965.2335589120255;1982.2566537548419;1996.341207401554;27168.728312716816;27200.727992720018;27218;27220.31949201266;27245.45509089827;7284.49008569395;7377.704891804375;7404.444666650023;7573.46985710995;7593.506422082547;20063.097160627807;20154;20201.393958181277;20205.292814751414;20235.494112647302;8244.258016778398;8276.08963014068;8299.170082991652;8299.709510167115;8304.377171712145;7245.130584329914;7246.746363877239;7521.623918804038;7553.962230188814;7612.581308028111;5538.501534861882;5811.651300921958;5819.214406055213;5862.472377486047;5866.061430171152;1830.2861883865037;1847.390361180807;1852.54612619909;1871.1299245850744;1874.9812501875078;850.4217132350061;855.3371137368465;871.4379225399582;876.7676565710092;892.8660700894918;8767;9414.15272625467;9424.434533927986;9458.290628202913;9466.1953733932;728.9125304963333;734.8346622010112;739.6449704142042;744.6500144931873;747.1333253426;4513.323001549794;4570.200214962369;4575.7483338416705;4581.541845815458;4641.814327426932;21149.154033838782;21994.01026953759;22175.66736498954;22349.888250558644;22486.550268994855;20519.281825136048;21830.89084554599;21893.67159492609;22300.888495557418;22342.553148937255;11316.773664526663;11372.48823802931;11390.715232119263;11425.885741142481;11465.14011449128;7907.644156012878;7914.683412663429;8068.798280043045;8106.959465202636;8196.754097377088;18309;18774.812251877305;18906.716399254296;19063.90468047651;19130.808691912902;19502.219911203392;19710.113044912727;19831.702524462435;20350.694739579216;20473.89763051175;12206.633800985985;12243.877561224273;12353.938230308791;12408.255504669749;12448.439820207932;14255.786163207353;14260.144391336553;14404.135751854923;14420.783688244894;14432.134071955295;11808.82286765682;12058.879411205775;12101.81847272274;12125.75748485043;12270.4478298475;10796.892031079902;11347.092232621535;11407.885921141014;11631.069514438655;11733.530658773894;9718.611255549698;9778.119969202806;9799.657012004545;9812.509374531388;9839.360441571274;7308.1595616502655;7402.074740657418;7457.216992215739;7500.324970752658;7521.887171692539;7200.855982880418;7240.167380751071;7336.303051210127;7362.116546014512;7409.851802964018 15:43:56 INFO - PID 8605 | |4;prototype.html;478.8108697064662;500.8647665130415;507.72582805285145;511.65974626873134;530.3979982719613;6134.325224225332;6273.463001564617;6312.652804095773;6314.463270621997;6319.368063193679;6152;6162.352952939944;6169.352218017111;6186.845328866781;6208.6585237811905;5112.488751124885;5119.155339368999;5126.897462050757;5127.154019586782;5167.819126330579;5019.799208031674;5099.053917699825;5119.56483698886;5126.282320475137;5148.099082660538;5140.126178549655;5168.61235407346;5188.688678679272;5200.401953775307;5209.791608335662;5166.405863325728;5183.667349692634;5183.688978661255;5194.402643695986;5232.8749318896425;4701.600363969067;4807.206810876201;4820.084184005028;4825.9034819303415;4831.106245344622;6122.326544080148;6150.169727086831;6155.045967874987;6188.133661287423;6196.132541444202;5961.105834124873;5966.70166491678;5982.820515384546;5983.910241346383;6008.879822403527;6529.183852018497;6551.246606640249;6562.639054851981;6587.901181482282;6643.873960332696;5048.217526283432;5232.686038837682;5282.577393808486;5288.444713305086;5294.814681486168;6695.263521012685;6698.162729658793;6790.796276111724;6860.965695171542;6877.346652068046;5417.6478528895495;5418.4039755626845;5423.450978040315;5431.619786614978;5452.127659574449;5470.425605311465;5472.863178420572;5528.640638358494;5544.556435485151;5559.138333558305;5864.560157988168;5886.293644762656;5919.247549889322;5932.169496270526;5961.433663801932;6602.207735071822;6621.536492445579;6623;6646.567973081735;6648.767293144813;1887.9622407552047;1905.818392596599;1922.2887531613112;1935.9032048397805;1944.9691663418412;1352.8985326100583;1418.198717724503;1430.6065831896312;1433.2475450388629;1455.9662639526055;5573.972130139324;5585.553155747531;5609.214709940612;5610.242617246701;5615.157726341082;6505.41451269388;6528.792173447928;6561.2782593914635;6568.737250510022;6577;5567.164925261243;5595.964746521907;5635.350835560679;5652.943470565242;5668.461496157858;3464.965350346464;3471.923703651876;3475.42655461851;3479.4258947273415;3491.17957280039;6375.649339286291;6389.776357827547;6397.776077837253;6416.454601358843;6460.870782584322;6745.628990405575;6771.627560484122;6783.932160678429;6857;6878.55289406187;6356.2054743157105;6375.681215939185;6407.455366293917;6411.67941602918;6463.027007576474;6526.738930442729;6580.539362244788;6603.273639899703;6657.434118099822;6661.766838160641;6436.133521278964;6461.19235095613;6535.901961470487;6558.8360290993105;6581.736730530916;6266.905996409966;6285.308616052322;6297.15873317267;6309.968450157719;6346.555741098079;5430.375506816608;5440.211169380497;5449.863753406196;5452.236686863922;5456.427075157051;6407.327230640715;6485.8702825944165;6599.505037122139;6705.698243579148;6743.595384276763;6393.744250229939;6399.680015999088;6409.6860143671365;6425.325340839145;6461.741530338733;6318.810435686937;6341.302456729848;6345.841353966188;6353.094071778541;6405.743770249324;6129.896618608694;6327.335629758809;6328.177336946352;6374.776882809079;6432.6140431572385;6304.495640348669;6331.430171284606;6426.807195783947;6470.22357317125;6477;6174.475169610633;6225.875482490234;6251.593646413151;6253.249610046823;6284.151639528788 15:43:56 INFO - PID 8605 | |5;yui.html;918.7886786039215;926.3191554207658;937.96248150074;938.5072836760704;943.9150476457118;18929.33747318844;19782.604347913035;19868.006599670032;19935.800641993577;19942.70085948712;18279.634407311845;18348.174332155053;18380.264789408408;18485.815141848576;18514.351997680085;974.6052848596312;989.8168838764816;990.7770751580873;995.6067353395405;996.6013594562161;983.9901600984006;986.9851952220722;991.6380521109779;993.4933184076137;993.5131785425126;995.3629677006721;1023.5036007536339;1027.5119318323812;1029.1663752360612;1031.144150355207;1011.6206422591529;1014.7970405918845;1016.3038318751642;1016.8017236638858;1018.4398580780542;752.0824593995317;754.2193829386558;754.8565772503207;755.6637296403103;757.5681861339039;19750;20127.698084528598;20159.697604535944;20373;20414.69377959332;21363.67954480684;21365.893170534204;22378.44053898649;22525.887370563207;22570.097196112136;17691.380801672007;18075.819241807545;18086.366977155736;18176.000319982395;18226;3536.2397084626928;3563.1804684922354;3603.855845766166;3609.350316942949;3612.0789198754414;103701.48149259205;140503.29748351296;140654;141017.29491352476;143065;17540.649187016443;18138.81861181398;18171.454856354332;18213.08934553267;18222.180001899946;31840;32829.50755738618;32880.1779955503;32933.50599741006;32972;8718.738437846874;8809.295256379473;8929.24101451371;8936.41913275635;8977.685780997634;4422.624076953431;4510.8421205257655;4532.27483602622;4539.886502837456;4561.817527298871;5456.236126942231;5486.862828429242;5556.722163891789;5558.833235002876;5586.022446071921;1108.8115020446544;1119.054399032816;1122.421952694363;1124.527698366688;1126.0147371050332;677.4309579952863;688.4595592459895;696.6342670098138;699.6781480518916;701.5404909784099;11405.372704501333;11856.585019524275;11910.642680719593;11917.582884599171;11930.343831089373;677.654396257912;688.2291833146908;688.8897776355759;690.3303795318533;694.2710154337925;5406.432324605938;5496.258005169331;5500.80747173847;5529.060059789765;5582.385937546866;127488;127629.36185319014;128804;129374;131498;106274;106606;106716.46641766741;108280;110396;98445;99798.5010074945;100832.99999999853;100956.49521752344;103593;11800;12206.267623942593;12463.252204867737;12548.435320410787;12561.80662837029;43457.34813977856;44029.33955990727;44165.33751993787;45308.32037519374;46093.53906460892;57293;58080;58687.70656146692;60529.39470605414;61142;16689.833101668828;16912.915435422743;16918.915405422893;16949.067801270554;16956;20050.59898802045;20112.698309525076;20147.59704805925;20171.39485815428;20336.08487618031;15560.610984725472;15576.454824081104;15628.92185539065;15756.212189390255;15841.287142078403;16062.759058614363;16547.751783723495;16995.320187192374;17081;17260;16369.099699516164;16589.668206635557;16604.58488537796;16650.583735406228;16692.248848802075;12564.87435125637;12740.490380384681;12890.742185156432;12974;13016.934915325362;12312.322822244863;12328.289519559363;12348.753024939631;12561.05792065617;12588.622341329774 15:43:56 INFO - PID 8605 | __end_tp_report 15:43:56 INFO - PID 8605 | __start_cc_report 15:43:56 INFO - PID 8605 | _x_x_mozilla_cycle_collect,282 15:43:56 INFO - PID 8605 | __end_cc_report 15:43:56 INFO - PID 8605 | __startTimestamp1505688236952__endTimestamp 15:43:56 INFO - PID 8605 | 15:43:56 INFO - PID 8605 | ------- Summary: start ------- 15:43:56 INFO - PID 8605 | Number of tests: 6 15:43:56 INFO - PID 8605 | 15:43:56 INFO - PID 8605 | [#0] dojo.html Cycles:165 Average:6258.51 Median:6543.64 stddev:855.72 (13.1%) stddev-sans-first:820.92 15:43:56 INFO - PID 8605 | Values: 3067.6 3108.0 3114.7 3124.4 3152.6 6240.4 6328.8 6368.7 6396.0 6456.7 6275.3 6360.2 6383.9 6454.2 6462.8 1311.5 5852.6 5910.1 5949.6 5950.2 5753.5 5774.2 5905.0 5910.7 5937.1 5819.8 5838.7 5880.6 5906.8 5915.9 5829.8 5850.8 5901.5 5908.8 5918.8 5811.1 5818.4 5881.2 5892.4 5901.5 6120.5 6247.8 6340.2 6424.0 6429.5 6792.0 6818.5 6889.9 6895.1 6897.5 6953.4 6968.6 6985.5 6988.1 6999.9 6344.7 6363.6 6399.4 6435.5 6441.4 6865.6 6991.3 6993.2 6997.1 7001.4 6677.1 6692.6 6696.7 6700.2 6709.5 6857.5 6907.0 6951.4 6951.9 6957.1 6822.1 6832.5 6851.9 6926.1 6929.8 6646.5 6793.9 6797.8 6853.6 6950.5 5316.8 5330.6 5353.8 5402.4 5417.2 4695.6 4772.4 4774.3 4777.1 4780.9 5854.2 5870.4 5940.4 5949.9 5950.0 6684.1 6798.6 6856.5 6866.5 6969.2 5814.3 5893.7 5903.0 5909.5 5910.7 5855.3 5907.9 5915.3 5930.9 5938.9 6571.6 6592.7 6608.5 6665.2 6674.7 6597.1 6715.5 6810.7 6932.0 6966.8 6462.6 6609.5 6616.8 6626.0 6627.3 6772.3 6787.8 6846.2 6849.3 6849.6 6893.1 6899.3 6909.6 6985.9 6991.4 6460.2 6613.4 6615.0 6620.3 6669.6 6566.7 6569.2 6575.0 6577.4 6601.4 6381.1 6499.9 6609.8 6623.2 6646.4 6671.1 6724.6 6776.8 6777.5 6784.2 6353.1 6457.3 6469.5 6543.6 6551.5 15:43:56 INFO - PID 8605 | 15:43:56 INFO - PID 8605 | [#1] ext.html Cycles:180 Average:36885.51 Median:19106.06 stddev:50942.34 (266.6%) stddev-sans-first:51013.46 15:43:56 INFO - PID 8605 | Values: 867.4 892.3 896.4 896.6 905.3 39907.2 41681.6 41730.6 41738.0 41812.0 39058.2 39505.0 39510.8 39519.4 39585.4 7203.4 7294.1 7314.0 7317.9 7325.2 7180.8 7213.4 7214.7 7254.9 7286.1 7736.5 7986.2 8031.6 8038.2 8040.1 7872.8 7972.8 7973.0 7981.6 7981.8 7709.8 7788.2 7856.4 7865.4 7933.7 37810.6 38133.4 38224.4 38261.8 38284.6 3444.2 3450.0 3472.2 3472.6 3479.6 31073.0 31497.2 31510.0 31575.7 31594.2 5095.9 5235.7 5243.7 5265.3 5265.7 174284.0 174702.0 174885.0 174897.0 175326.0 41418.0 42086.4 47527.0 49950.5 50595.0 52086.5 52253.0 52273.0 52316.0 52316.7 16463.5 16556.6 16580.3 16603.8 16614.2 13438.1 13477.7 13527.7 13603.4 13608.5 14209.6 14270.4 14279.4 14324.9 14426.5 5709.4 5730.7 5849.2 5861.7 5931.5 998.9 1016.1 1017.9 1034.4 1044.7 22778.3 23087.7 23130.8 23262.3 23383.4 1111.4 1125.8 1135.4 1136.4 1137.7 12171.9 12190.0 12272.4 12343.9 12354.7 223310.0 224535.0 224868.0 225624.0 226479.0 52972.0 53025.0 53156.5 53490.0 53556.0 1425.1 1476.4 1484.0 1484.2 1499.7 22549.0 22635.2 22774.0 22933.7 22953.5 34599.8 34732.5 34863.5 34867.7 34909.5 185526.0 187183.0 187864.0 187920.0 188113.0 33522.0 35913.5 37355.3 37388.6 37476.8 43828.8 45408.0 45535.0 45905.0 46069.5 33265.3 33265.5 33502.0 33786.5 33844.3 33570.7 33638.5 33888.0 34033.7 34457.5 37390.8 37435.3 37441.6 37630.6 37688.4 32645.3 32739.7 32756.7 32767.2 33612.7 23975.4 24111.9 24420.9 24644.8 24681.9 15:43:56 INFO - PID 8605 | 15:43:56 INFO - PID 8605 | [#2] jquery.html Cycles:180 Average:35679.66 Median:21744.07 stddev:82122.46 (377.7%) stddev-sans-first:82310.50 15:43:56 INFO - PID 8605 | Values: 560.3 562.0 567.2 569.7 574.6 21640.4 22481.0 22543.4 22550.0 22575.1 23511.2 24447.1 24861.8 24943.0 25745.2 6585.9 6676.7 6677.3 6686.3 6696.7 6552.8 6605.7 6610.9 6689.9 6714.3 6621.6 6731.9 6991.6 7052.9 7184.2 6984.7 7155.4 7162.7 7184.1 7184.9 6725.9 7025.2 7036.9 7046.1 7047.9 30940.4 31438.7 31450.4 31489.7 31512.4 2034.8 2055.2 2066.5 2076.7 2081.1 20277.9 20329.7 20666.8 21415.9 21577.9 2569.6 2573.3 2641.1 2650.7 2655.3 115727.0 120380.4 129471.4 137276.0 138021.3 20007.7 21312.3 21847.8 21940.7 21994.5 41844.4 41975.0 41979.0 42158.4 42251.8 11462.8 11545.0 11676.5 11711.6 11766.6 9744.2 9751.4 9839.7 9933.7 9933.7 11170.7 11258.2 11435.5 11636.5 11688.5 3798.4 4025.6 4115.7 4268.0 4402.7 935.9 944.5 960.3 965.3 974.7 19081.2 19283.0 19284.1 19340.4 19646.7 1024.8 1027.3 1035.5 1036.7 1036.9 10564.1 10766.5 10781.8 10883.9 10921.1 480699.0 485512.0 493713.0 493790.0 498573.0 112352.8 113235.0 114802.4 115806.0 115825.0 1119.5 1132.6 1167.1 1168.1 1171.4 16996.5 17080.7 17526.0 17571.4 17646.3 55138.0 55648.0 56714.7 57447.0 58715.7 70641.3 71139.3 71603.6 71840.6 72773.0 19739.5 19954.2 20066.8 20286.9 20415.0 19473.2 19477.8 19972.5 23056.8 23472.3 18234.9 18243.9 18244.6 18503.8 18555.6 14588.2 15368.0 16126.1 16726.6 16835.1 18716.0 18907.6 19057.4 19081.9 19177.6 20126.7 20148.4 20285.7 20291.0 20370.2 18282.6 18354.7 18408.8 18438.9 18685.2 15:43:56 INFO - PID 8605 | 15:43:56 INFO - PID 8605 | [#3] mootools.html Cycles:180 Average:9674.24 Median:27209.36 stddev:6959.29 (25.6%) stddev-sans-first:6950.59 15:43:56 INFO - PID 8605 | Values: 1331.9 1403.3 1409.1 1412.5 1415.4 15697.2 16111.0 16157.8 16207.1 16251.3 15891.7 15986.0 16045.0 16074.9 16077.7 2795.3 2820.9 2859.9 2864.6 2867.3 2714.0 2739.6 2753.6 2759.8 2761.8 2740.4 2763.0 2775.3 2778.7 2787.0 2352.3 2455.2 2457.1 2734.7 2808.8 2579.0 2639.2 2659.2 2663.9 2665.5 14784.9 15040.6 15150.0 15197.2 15219.4 7905.8 8244.0 8262.9 8264.2 8376.3 5333.6 5456.9 5572.4 5643.3 5757.9 1937.2 1960.5 1965.2 1982.3 1996.3 27168.7 27200.7 27218.0 27220.3 27245.5 7284.5 7377.7 7404.4 7573.5 7593.5 20063.1 20154.0 20201.4 20205.3 20235.5 8244.3 8276.1 8299.2 8299.7 8304.4 7245.1 7246.7 7521.6 7554.0 7612.6 5538.5 5811.7 5819.2 5862.5 5866.1 1830.3 1847.4 1852.5 1871.1 1875.0 850.4 855.3 871.4 876.8 892.9 8767.0 9414.2 9424.4 9458.3 9466.2 728.9 734.8 739.6 744.7 747.1 4513.3 4570.2 4575.7 4581.5 4641.8 21149.2 21994.0 22175.7 22349.9 22486.6 20519.3 21830.9 21893.7 22300.9 22342.6 11316.8 11372.5 11390.7 11425.9 11465.1 7907.6 7914.7 8068.8 8107.0 8196.8 18309.0 18774.8 18906.7 19063.9 19130.8 19502.2 19710.1 19831.7 20350.7 20473.9 12206.6 12243.9 12353.9 12408.3 12448.4 14255.8 14260.1 14404.1 14420.8 14432.1 11808.8 12058.9 12101.8 12125.8 12270.4 10796.9 11347.1 11407.9 11631.1 11733.5 9718.6 9778.1 9799.7 9812.5 9839.4 7308.2 7402.1 7457.2 7500.3 7521.9 7200.9 7240.2 7336.3 7362.1 7409.9 15:43:56 INFO - PID 8605 | 15:43:56 INFO - PID 8605 | [#4] prototype.html Cycles:180 Average:5554.52 Median:6158.70 stddev:1473.02 (23.9%) stddev-sans-first:1427.04 15:43:56 INFO - PID 8605 | Values: 478.8 500.9 507.7 511.7 530.4 6134.3 6273.5 6312.7 6314.5 6319.4 6152.0 6162.4 6169.4 6186.8 6208.7 5112.5 5119.2 5126.9 5127.2 5167.8 5019.8 5099.1 5119.6 5126.3 5148.1 5140.1 5168.6 5188.7 5200.4 5209.8 5166.4 5183.7 5183.7 5194.4 5232.9 4701.6 4807.2 4820.1 4825.9 4831.1 6122.3 6150.2 6155.0 6188.1 6196.1 5961.1 5966.7 5982.8 5983.9 6008.9 6529.2 6551.2 6562.6 6587.9 6643.9 5048.2 5232.7 5282.6 5288.4 5294.8 6695.3 6698.2 6790.8 6861.0 6877.3 5417.6 5418.4 5423.5 5431.6 5452.1 5470.4 5472.9 5528.6 5544.6 5559.1 5864.6 5886.3 5919.2 5932.2 5961.4 6602.2 6621.5 6623.0 6646.6 6648.8 1888.0 1905.8 1922.3 1935.9 1945.0 1352.9 1418.2 1430.6 1433.2 1456.0 5574.0 5585.6 5609.2 5610.2 5615.2 6505.4 6528.8 6561.3 6568.7 6577.0 5567.2 5596.0 5635.4 5652.9 5668.5 3465.0 3471.9 3475.4 3479.4 3491.2 6375.6 6389.8 6397.8 6416.5 6460.9 6745.6 6771.6 6783.9 6857.0 6878.6 6356.2 6375.7 6407.5 6411.7 6463.0 6526.7 6580.5 6603.3 6657.4 6661.8 6436.1 6461.2 6535.9 6558.8 6581.7 6266.9 6285.3 6297.2 6310.0 6346.6 5430.4 5440.2 5449.9 5452.2 5456.4 6407.3 6485.9 6599.5 6705.7 6743.6 6393.7 6399.7 6409.7 6425.3 6461.7 6318.8 6341.3 6345.8 6353.1 6405.7 6129.9 6327.3 6328.2 6374.8 6432.6 6304.5 6331.4 6426.8 6470.2 6477.0 6174.5 6225.9 6251.6 6253.2 6284.2 15:43:56 INFO - PID 8605 | 15:43:56 INFO - PID 8605 | [#5] yui.html Cycles:180 Average:24879.71 Median:19901.90 stddev:35584.58 (178.8%) stddev-sans-first:35638.93 15:43:56 INFO - PID 8605 | Values: 918.8 926.3 938.0 938.5 943.9 18929.3 19782.6 19868.0 19935.8 19942.7 18279.6 18348.2 18380.3 18485.8 18514.4 974.6 989.8 990.8 995.6 996.6 984.0 987.0 991.6 993.5 993.5 995.4 1023.5 1027.5 1029.2 1031.1 1011.6 1014.8 1016.3 1016.8 1018.4 752.1 754.2 754.9 755.7 757.6 19750.0 20127.7 20159.7 20373.0 20414.7 21363.7 21365.9 22378.4 22525.9 22570.1 17691.4 18075.8 18086.4 18176.0 18226.0 3536.2 3563.2 3603.9 3609.4 3612.1 103701.5 140503.3 140654.0 141017.3 143065.0 17540.6 18138.8 18171.5 18213.1 18222.2 31840.0 32829.5 32880.2 32933.5 32972.0 8718.7 8809.3 8929.2 8936.4 8977.7 4422.6 4510.8 4532.3 4539.9 4561.8 5456.2 5486.9 5556.7 5558.8 5586.0 1108.8 1119.1 1122.4 1124.5 1126.0 677.4 688.5 696.6 699.7 701.5 11405.4 11856.6 11910.6 11917.6 11930.3 677.7 688.2 688.9 690.3 694.3 5406.4 5496.3 5500.8 5529.1 5582.4 127488.0 127629.4 128804.0 129374.0 131498.0 106274.0 106606.0 106716.5 108280.0 110396.0 98445.0 99798.5 100833.0 100956.5 103593.0 11800.0 12206.3 12463.3 12548.4 12561.8 43457.3 44029.3 44165.3 45308.3 46093.5 57293.0 58080.0 58687.7 60529.4 61142.0 16689.8 16912.9 16918.9 16949.1 16956.0 20050.6 20112.7 20147.6 20171.4 20336.1 15560.6 15576.5 15628.9 15756.2 15841.3 16062.8 16547.8 16995.3 17081.0 17260.0 16369.1 16589.7 16604.6 16650.6 16692.2 12564.9 12740.5 12890.7 12974.0 13016.9 12312.3 12328.3 12348.8 12561.1 12588.6 15:43:56 INFO - PID 8605 | -------- Summary: end -------- 15:43:56 INFO - PID 8605 | 15:43:57 INFO - TEST-INFO | 8605: exit 0 15:43:57 INFO - TEST-OK | dromaeo_css | took 1109368ms 15:43:57 INFO - TEST-START | kraken 15:43:57 INFO - Initialising browser for kraken test... 15:43:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44361/getInfo.html -profile /tmp/tmpRhSvjV/profile 15:43:57 INFO - TEST-INFO | started process 8974 (/builds/slave/test/build/application/firefox/firefox http://localhost:44361/getInfo.html) 15:44:02 INFO - TEST-INFO | 8974: exit 0 15:44:02 INFO - Browser initialized. 15:44:02 INFO - Running cycle 1/1 for kraken test... 15:44:02 INFO - Using env: {'DISPLAY': ':0', 15:44:02 INFO - 'HOME': '/home/cltbld', 15:44:02 INFO - 'JSGC_DISABLE_POISONING': '1', 15:44:02 INFO - 'LANG': 'en_US.UTF-8', 15:44:02 INFO - 'LANGUAGE': 'en_US:en', 15:44:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:44:02 INFO - 'LOGNAME': 'cltbld', 15:44:02 INFO - 'MAIL': '/var/mail/cltbld', 15:44:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:44:02 INFO - 'MOZ_CRASHREPORTER': '1', 15:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:44:02 INFO - 'MOZ_NO_REMOTE': '1', 15:44:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:02 INFO - 'NO_EM_RESTART': '1', 15:44:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:02 INFO - 'PWD': '/builds/slave/test', 15:44:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:02 INFO - 'RUST_BACKTRACE': 'full', 15:44:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:44:02 INFO - 'SHELL': '/bin/bash', 15:44:02 INFO - 'SHLVL': '1', 15:44:02 INFO - 'TERM': 'linux', 15:44:02 INFO - 'TMOUT': '86400', 15:44:02 INFO - 'USER': 'cltbld', 15:44:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854', 15:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:02 INFO - '_': '/tools/buildbot/bin/python'} 15:44:02 INFO - TEST-INFO | started process 9208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRhSvjV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:03 INFO - PID 9208 | 15:44:03 INFO - PID 9208 | (/builds/slave/test/build/application/firefox/firefox:9256): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:44:03 INFO - PID 9208 | 15:44:14 INFO - PID 9208 | RSS: Main: 156131328 15:44:14 INFO - PID 9208 | 15:44:16 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44361/tests/kraken/driver.html?testName=audio-beat-detection) 15:44:17 INFO - PID 9208 | RSS: Main: 162893824 15:44:17 INFO - PID 9208 | 15:44:20 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44361/tests/kraken/driver.html?testName=audio-dft) 15:44:20 INFO - PID 9208 | RSS: Main: 162922496 15:44:20 INFO - PID 9208 | 15:44:23 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44361/tests/kraken/driver.html?testName=audio-fft) 15:44:24 INFO - PID 9208 | RSS: Main: 158728192 15:44:24 INFO - PID 9208 | 15:44:26 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44361/tests/kraken/driver.html?testName=audio-oscillator) 15:44:27 INFO - PID 9208 | RSS: Main: 159522816 15:44:27 INFO - PID 9208 | 15:44:29 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:44:29 INFO - PID 9208 | RSS: Main: 159363072 15:44:29 INFO - PID 9208 | 15:44:33 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44361/tests/kraken/driver.html?testName=imaging-darkroom) 15:44:33 INFO - PID 9208 | RSS: Main: 161845248 15:44:33 INFO - PID 9208 | 15:44:37 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44361/tests/kraken/driver.html?testName=imaging-desaturate) 15:44:38 INFO - PID 9208 | RSS: Main: 162181120 15:44:38 INFO - PID 9208 | 15:44:41 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44361/tests/kraken/driver.html?testName=json-parse-financial) 15:44:41 INFO - PID 9208 | RSS: Main: 162062336 15:44:41 INFO - PID 9208 | 15:44:43 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:43 INFO - PID 9208 | RSS: Main: 161824768 15:44:43 INFO - PID 9208 | 15:44:45 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44361/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:46 INFO - PID 9208 | RSS: Main: 161898496 15:44:46 INFO - PID 9208 | 15:44:48 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:44:48 INFO - PID 9208 | RSS: Main: 158269440 15:44:48 INFO - PID 9208 | 15:44:51 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:44:52 INFO - PID 9208 | RSS: Main: 159100928 15:44:52 INFO - PID 9208 | 15:44:54 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:44:55 INFO - PID 9208 | RSS: Main: 159010816 15:44:55 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | Cycle 1(1): loaded http://localhost:44361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44361/tests/kraken/driver.html?testName=ai-astar) 15:44:57 INFO - PID 9208 | RSS: Main: 160870400 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | __start_tp_report 15:44:57 INFO - PID 9208 | _x_x_mozilla_page_load 15:44:57 INFO - PID 9208 | _x_x_mozilla_page_load_details 15:44:57 INFO - PID 9208 | |i|pagename|runs| 15:44:57 INFO - PID 9208 | |0;ai-astar;109;110;107;108;107;108;108;108;107;108 15:44:57 INFO - PID 9208 | |1;audio-beat-detection;120;116;116;120;122;154;117;117;119;117 15:44:57 INFO - PID 9208 | |2;audio-dft;163;162;162;161;162;162;162;163;163;164 15:44:57 INFO - PID 9208 | |3;audio-fft;76;75;75;75;75;75;74;74;74;75 15:44:57 INFO - PID 9208 | |4;audio-oscillator;79;78;79;79;80;79;80;78;78;80 15:44:57 INFO - PID 9208 | |5;imaging-gaussian-blur;113;116;115;109;114;114;117;115;118;117 15:44:57 INFO - PID 9208 | |6;imaging-darkroom;149;148;149;149;150;148;150;150;152;148 15:44:57 INFO - PID 9208 | |7;imaging-desaturate;94;93;94;93;94;95;95;94;94;93 15:44:57 INFO - PID 9208 | |8;json-parse-financial;53;52;52;54;54;54;53;52;53;53 15:44:57 INFO - PID 9208 | |9;json-stringify-tinderbox;37;38;37;38;38;38;38;38;38;38 15:44:57 INFO - PID 9208 | |10;stanford-crypto-aes;72;74;74;74;76;75;75;72;75;80 15:44:57 INFO - PID 9208 | |11;stanford-crypto-ccm;112;111;115;116;114;108;114;117;109;117 15:44:57 INFO - PID 9208 | |12;stanford-crypto-pbkdf2;170;172;165;167;164;164;169;166;166;177 15:44:57 INFO - PID 9208 | |13;stanford-crypto-sha256-iterative;67;63;64;64;67;66;65;70;64;67 15:44:57 INFO - PID 9208 | __end_tp_report 15:44:57 INFO - PID 9208 | __start_cc_report 15:44:57 INFO - PID 9208 | _x_x_mozilla_cycle_collect,737 15:44:57 INFO - PID 9208 | __end_cc_report 15:44:57 INFO - PID 9208 | __startTimestamp1505688297564__endTimestamp 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | ------- Summary: start ------- 15:44:57 INFO - PID 9208 | Number of tests: 14 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.00 stddev:0.94 (0.9%) stddev-sans-first:0.93 15:44:57 INFO - PID 9208 | Values: 109.0 110.0 107.0 108.0 107.0 108.0 108.0 108.0 107.0 108.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:119.50 stddev:11.49 (9.6%) stddev-sans-first:12.17 15:44:57 INFO - PID 9208 | Values: 120.0 116.0 116.0 120.0 122.0 154.0 117.0 117.0 119.0 117.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 15:44:57 INFO - PID 9208 | Values: 163.0 162.0 162.0 161.0 162.0 162.0 162.0 163.0 163.0 164.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#3] audio-fft Cycles:10 Average:74.80 Median:75.00 stddev:0.63 (0.8%) stddev-sans-first:0.50 15:44:57 INFO - PID 9208 | Values: 76.0 75.0 75.0 75.0 75.0 75.0 74.0 74.0 74.0 75.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 15:44:57 INFO - PID 9208 | Values: 79.0 78.0 79.0 79.0 80.0 79.0 80.0 78.0 78.0 80.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.50 stddev:2.57 (2.2%) stddev-sans-first:2.65 15:44:57 INFO - PID 9208 | Values: 113.0 116.0 115.0 109.0 114.0 114.0 117.0 115.0 118.0 117.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 15:44:57 INFO - PID 9208 | Values: 149.0 148.0 149.0 149.0 150.0 148.0 150.0 150.0 152.0 148.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 15:44:57 INFO - PID 9208 | Values: 94.0 93.0 94.0 93.0 94.0 95.0 95.0 94.0 94.0 93.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 15:44:57 INFO - PID 9208 | Values: 53.0 52.0 52.0 54.0 54.0 54.0 53.0 52.0 53.0 53.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.33 15:44:57 INFO - PID 9208 | Values: 37.0 38.0 37.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:75.00 stddev:2.26 (3.0%) stddev-sans-first:2.18 15:44:57 INFO - PID 9208 | Values: 72.0 74.0 74.0 74.0 76.0 75.0 75.0 72.0 75.0 80.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#11] stanford-crypto-ccm Cycles:10 Average:113.30 Median:114.50 stddev:3.20 (2.8%) stddev-sans-first:3.36 15:44:57 INFO - PID 9208 | Values: 112.0 111.0 115.0 116.0 114.0 108.0 114.0 117.0 109.0 117.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.00 stddev:4.11 (2.4%) stddev-sans-first:4.29 15:44:57 INFO - PID 9208 | Values: 170.0 172.0 165.0 167.0 164.0 164.0 169.0 166.0 166.0 177.0 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.50 stddev:2.11 (3.2%) stddev-sans-first:2.19 15:44:57 INFO - PID 9208 | Values: 67.0 63.0 64.0 64.0 67.0 66.0 65.0 70.0 64.0 67.0 15:44:57 INFO - PID 9208 | -------- Summary: end -------- 15:44:57 INFO - PID 9208 | 15:44:57 INFO - PID 9208 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:44:58 INFO - TEST-INFO | 9208: exit 0 15:44:58 INFO - TEST-OK | kraken | took 60574ms 15:44:58 INFO - SUITE-END | took 1169s 15:44:58 INFO - Completed test suite (00:19:30) 15:44:58 INFO - javascript benchmark 15:44:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8729.87134732495, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.585875906753, 3107.999999999999, 3114.7041031102053, 3124.4376012317803, 3152.637446693631, 6240.4071613196675, 6328.778492752755, 6368.713407896645, 6396.0, 6456.7094480748365, 6275.278342990558, 6360.236771587404, 6383.936160638392, 6454.19322584677, 6462.773802916899, 1311.4627696968878, 5852.619579727304, 5910.113482977545, 5949.5537834662355, 5950.226470558821, 5753.510951569122, 5774.191613174159, 5904.970475147618, 5910.704464776765, 5937.109433584954, 5819.7672093116435, 5838.737256823453, 5880.647161170344, 5906.822795316148, 5915.940840591582, 5829.8251052468495, 5850.76596936122, 5901.468867801876, 5908.793192238251, 5918.7928422505, 5811.099279611667, 5818.41815818419, 5881.2354393928945, 5892.351841297454, 5901.468867801918, 6120.510359171256, 6247.75008999644, 6340.175777148941, 6424.0, 6429.4856411487435, 6792.049113124167, 6818.522703410763, 6889.931100688979, 6895.138107736533, 6897.48268879836, 6953.408960238386, 6968.581885086911, 6985.545939513915, 6988.056612357368, 6999.930000700029, 6344.6827658616885, 6363.61818290904, 6399.360063993563, 6435.549511534195, 6441.3880681335195, 6865.5537390069485, 6991.335823096798, 6993.230744618088, 6997.090378250897, 7001.439884809305, 6677.098591690156, 6692.5984440932725, 6696.732130714814, 6700.195976482853, 6709.5303328767495, 6857.5199736018, 6907.0, 6951.409130223988, 6951.930480695129, 6957.130358705162, 6822.11312529368, 6832.521723479408, 6851.862962740817, 6926.099607051051, 6929.75745848903, 6646.53474256807, 6793.898091528631, 6797.830054248683, 6853.588784672936, 6950.54821436605, 5316.787328506894, 5330.600204984642, 5353.785848566092, 5402.432744561765, 5417.241586177938, 4695.577398034194, 4772.3557319762085, 4774.3077253798, 4777.140114779304, 4780.856574302777, 5854.151148083504, 5870.383609721003, 5940.435658612511, 5949.881002379928, 5949.970250148722, 6684.064231007663, 6798.558093723892, 6856.5200435969, 6866.519343645997, 6969.1985421676145, 5814.30228372598, 5893.705314734246, 5902.970485147633, 5909.527237820964, 5910.674912879833, 5855.2973643163095, 5907.881842363128, 5915.319738230072, 5930.881382372415, 5938.881222375615, 6571.638559879252, 6592.703328350236, 6608.504362172856, 6665.233498147775, 6674.666266686646, 6597.076409302797, 6715.462762978852, 6810.727570897307, 6932.029515867783, 6966.825829354307, 6462.579932304385, 6609.504287178384, 6616.801495955129, 6625.966870165618, 6627.304133065959, 6772.25505194438, 6787.762428314985, 6846.178458585002, 6849.349311815369, 6849.623270720158, 6893.138357705287, 6899.275576064641, 6909.550879192836, 6985.860282794417, 6991.44068474531, 6460.192475940507, 6613.404793568602, 6615.0, 6620.337966203341, 6669.599824010381, 6566.737330506918, 6569.24453687832, 6575.0, 6577.4409175218725, 6601.3728695773825, 6381.074744162163, 6499.935000650122, 6609.834754130993, 6623.172103487064, 6646.368594983469, 6671.066050752996, 6724.596524208563, 6776.796696099125, 6777.491688123509, 6784.185897692111, 6353.14232578596, 6457.257415397289, 6469.450096741642, 6543.640099794557, 6551.475881929529], "value": 6194.75117069675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.405827008499, 892.321835405092, 896.3994123936966, 896.623418164371, 905.2893478619285, 39907.2018559629, 41681.58318416819, 41730.58269417305, 41738.0, 41812.0, 39058.21883562327, 39505.0, 39510.80244598773, 39519.40720889189, 39585.40621890674, 7203.3877120444695, 7294.088238970129, 7314.0, 7317.890231646529, 7325.157606875225, 7180.820479488002, 7213.422926165894, 7214.711411543558, 7254.927450725478, 7286.125664920217, 7736.535807851519, 7986.2013798620255, 8031.598420079002, 8038.196180381944, 8040.075391329984, 7872.803179920491, 7972.800679983046, 7973.0, 7981.561014144219, 7981.800454988643, 7709.807254818675, 7788.221177882223, 7856.410769192334, 7865.449418540705, 7933.682652693886, 37810.62189378098, 38133.427998580046, 38224.42663360052, 38261.808690956364, 38284.617153828665, 3444.156181735466, 3450.016745227598, 3472.1840367513614, 3472.58329000519, 3479.634638362986, 31073.0, 31497.21256968571, 31510.0, 31575.736970521153, 31594.210144746336, 5095.898082038376, 5235.712035838027, 5243.68537887728, 5265.262863199156, 5265.710385928773, 174284.0, 174702.0, 174885.0, 174897.0, 175326.0, 41418.0, 42086.36870446946, 47527.0, 49950.50049499459, 50595.0, 52086.47913520892, 52253.0, 52273.0, 52316.0, 52316.73841630767, 16463.506094817174, 16556.586085347964, 16580.336786528645, 16603.83396166047, 16614.169291535374, 13438.059335846592, 13477.663058423423, 13527.66180845467, 13603.387847546885, 13608.455661773418, 14209.573712788633, 14270.429182832571, 14279.357428915724, 14324.928375358057, 14426.495072672617, 5709.400512946164, 5730.656160630376, 5849.239598852122, 5861.706914654335, 5931.466168044811, 998.9051040151174, 1016.1261315268863, 1017.8574999500075, 1034.4000479721744, 1044.6657069737612, 22778.31665050051, 23087.653685194735, 23130.7686923132, 23262.3021309361, 23383.41541461477, 1111.3887361950895, 1125.7579620381493, 1135.3528488761492, 1136.4147464056018, 1137.70988397958, 12171.878281217074, 12190.0, 12272.447739851728, 12343.876561234452, 12354.691132721575, 223310.0, 224535.0, 224868.0, 225624.0, 226479.0, 52972.0, 53025.0, 53156.46843531515, 53490.0, 53556.0, 1425.0808228692642, 1476.3946781819188, 1484.0, 1484.1836989655646, 1499.6700725840299, 22549.0, 22635.20776772805, 22774.0, 22933.65599516042, 22953.540929181658, 34599.82700086483, 34732.47901281432, 34863.47704784481, 34867.65132348746, 34909.47635785516, 185526.0, 187183.0, 187864.0, 187920.0, 188113.0, 33522.0, 35913.46129808003, 37355.252894941405, 37388.626113738515, 37476.812615936746, 43828.78085609679, 45408.0, 45535.0, 45905.0, 46069.53930460652, 33265.33469330648, 33265.501017484276, 33502.0, 33786.49320260247, 33844.323113538085, 33570.66429335773, 33638.495422568194, 33888.0, 34033.65966340305, 34457.48313775245, 37390.81304593568, 37435.25129497449, 37441.625583743815, 37630.62369376271, 37688.43467348047, 32645.34709305848, 32739.672603273662, 32756.672433275362, 32767.18082047968, 33612.66387336095, 23975.400614984766, 24111.879440602686, 24420.877895610407, 24644.753552464244, 24681.876590616932], "value": 17223.063234947298, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.2744445942504, 561.9634723742956, 567.2002476508125, 569.7179895951505, 574.6008469377067, 21640.35078947632, 22481.0, 22543.436414089676, 22550.0, 22575.096996120155, 23511.177108801196, 24447.144349947754, 24861.75138248617, 24943.0, 25745.22764317069, 6585.93414065858, 6676.666166691671, 6677.298883617199, 6686.264510903797, 6696.665166741668, 6552.803415897531, 6605.70274337656, 6610.900836487456, 6689.866202675944, 6714.328567143295, 6621.635810030471, 6731.899021514681, 6991.580505169681, 7052.858942821141, 7184.173820010714, 6984.650767461632, 7155.391791697712, 7162.713491460361, 7184.066071410735, 7184.892226616605, 6725.865482690368, 7025.156981162242, 7036.894446583306, 7046.084009078838, 7047.872340425559, 30940.38119237625, 31438.685613144033, 31450.37099258025, 31489.685103149135, 31512.36975260505, 2034.7965203479534, 2055.2190167736167, 2066.4627196928755, 2076.6573515370096, 2081.115525901501, 20277.898610506854, 20329.695054574193, 20666.793332066638, 21415.892920535454, 21577.892110539502, 2569.6402503649506, 2573.3052075939577, 2641.141628970573, 2650.7084220735896, 2655.3361659585103, 115727.0, 120380.39809800983, 129471.35264323713, 137276.0, 138021.3098934509, 20007.699884501744, 21312.254071107436, 21847.781522184894, 21940.670889936664, 21994.45013874666, 41844.372334415006, 41975.0, 41979.0, 42158.36762448504, 42251.7887410561, 11462.828057578976, 11545.0, 11676.532938682527, 11711.648650540497, 11766.5881694142, 9744.220462362993, 9751.414915105117, 9839.704808855746, 9933.65232216869, 9933.652322168833, 11170.664880053611, 11258.155638327158, 11435.485403156878, 11636.476358563885, 11688.532458701728, 3798.3732684107367, 4025.5571887092397, 4115.691323150776, 4267.97866010668, 4402.669799765031, 935.9391639543408, 944.5088553951906, 960.2653969713175, 965.3001573858896, 974.6539978307599, 19081.236750529824, 19283.0, 19284.13221405012, 19340.419787406117, 19646.70529942052, 1024.8206563851297, 1027.2860362048305, 1035.4563853976722, 1036.6786296248188, 1036.9014943580498, 10564.102051325723, 10766.461676916122, 10781.838272425919, 10883.940486386367, 10921.126309895348, 480699.0, 485512.0, 493713.0, 493790.0, 498573.0, 112352.75294494064, 113235.0, 114802.42598786953, 115806.0, 115825.0, 1119.5409881948524, 1132.603588743933, 1167.0663469224587, 1168.1005625668188, 1171.4318555500574, 16996.49592857869, 17080.74378884293, 17526.036068016383, 17571.385001524886, 17646.294148233927, 55138.0, 55648.0, 56714.716426419254, 57447.0, 58715.70642146762, 70641.29358706347, 71139.28860711327, 71603.64198179184, 71840.64079679568, 72773.0, 19739.506512337306, 19954.20183192656, 20066.799332006492, 20286.89856550708, 20415.0, 19473.221071156993, 19477.805221947598, 19972.50068748293, 23056.769432305464, 23472.295831125095, 18234.908825456318, 18243.908780456542, 18244.635107297516, 18503.81496185075, 18555.628887422445, 14588.197649129399, 15368.0, 16126.113063781604, 16726.58183545421, 16835.074070926217, 18716.0, 18907.62184756325, 19057.428277151706, 19081.90459047696, 19177.616447671247, 20126.69809952881, 20148.38812894994, 20285.681430706958, 20290.98545072711, 20370.18519259213, 18282.634347312713, 18354.72467913009, 18408.815911841248, 18438.907805460887, 18685.15916783775], "value": 12864.528421477076, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.9334033298335, 1403.3334166271022, 1409.077054529283, 1412.5126831243217, 1415.4055296775352, 15697.215139243035, 16111.0, 16157.83842161581, 16207.108609026498, 16251.268692908818, 15891.682166356666, 15986.0, 16045.0, 16074.919625401886, 16077.678446431064, 2795.2872017635473, 2820.9153725388273, 2859.8570071496447, 2864.6275984122035, 2867.268846444154, 2713.986430067857, 2739.6164536964843, 2753.5731961545994, 2759.84820834854, 2761.765249953746, 2740.4245108527134, 2763.0467488716463, 2775.3200465885884, 2778.7082356352594, 2786.986065069672, 2352.3178278299274, 2455.17751553229, 2457.103157347573, 2734.6855111662016, 2808.817426867247, 2579.0457530713757, 2639.2214296782495, 2659.228823641142, 2663.893444262227, 2665.5335316319565, 14784.852151478455, 15040.623984400368, 15150.0, 15197.240137993056, 15219.391224351013, 7905.841883162305, 8243.958780206121, 8262.876056859152, 8264.21489958453, 8376.329893608498, 5333.599980001477, 5456.863578410532, 5572.4148964358565, 5643.322801263834, 5757.856053598652, 1937.2417510030637, 1960.4804726747423, 1965.2335589120255, 1982.2566537548419, 1996.341207401554, 27168.728312716816, 27200.727992720018, 27218.0, 27220.31949201266, 27245.45509089827, 7284.49008569395, 7377.704891804375, 7404.444666650023, 7573.46985710995, 7593.506422082547, 20063.097160627807, 20154.0, 20201.393958181277, 20205.292814751414, 20235.494112647302, 8244.258016778398, 8276.08963014068, 8299.170082991652, 8299.709510167115, 8304.377171712145, 7245.130584329914, 7246.746363877239, 7521.623918804038, 7553.962230188814, 7612.581308028111, 5538.501534861882, 5811.651300921958, 5819.214406055213, 5862.472377486047, 5866.061430171152, 1830.2861883865037, 1847.390361180807, 1852.54612619909, 1871.1299245850744, 1874.9812501875078, 850.4217132350061, 855.3371137368465, 871.4379225399582, 876.7676565710092, 892.8660700894918, 8767.0, 9414.15272625467, 9424.434533927986, 9458.290628202913, 9466.1953733932, 728.9125304963333, 734.8346622010112, 739.6449704142042, 744.6500144931873, 747.1333253426, 4513.323001549794, 4570.200214962369, 4575.7483338416705, 4581.541845815458, 4641.814327426932, 21149.154033838782, 21994.01026953759, 22175.66736498954, 22349.888250558644, 22486.550268994855, 20519.281825136048, 21830.89084554599, 21893.67159492609, 22300.888495557418, 22342.553148937255, 11316.773664526663, 11372.48823802931, 11390.715232119263, 11425.885741142481, 11465.14011449128, 7907.644156012878, 7914.683412663429, 8068.798280043045, 8106.959465202636, 8196.754097377088, 18309.0, 18774.812251877305, 18906.716399254296, 19063.90468047651, 19130.808691912902, 19502.219911203392, 19710.113044912727, 19831.702524462435, 20350.694739579216, 20473.89763051175, 12206.633800985985, 12243.877561224273, 12353.938230308791, 12408.255504669749, 12448.439820207932, 14255.786163207353, 14260.144391336553, 14404.135751854923, 14420.783688244894, 14432.134071955295, 11808.82286765682, 12058.879411205775, 12101.81847272274, 12125.75748485043, 12270.4478298475, 10796.892031079902, 11347.092232621535, 11407.885921141014, 11631.069514438655, 11733.530658773894, 9718.611255549698, 9778.119969202806, 9799.657012004545, 9812.509374531388, 9839.360441571274, 7308.1595616502655, 7402.074740657418, 7457.216992215739, 7500.324970752658, 7521.887171692539, 7200.855982880418, 7240.167380751071, 7336.303051210127, 7362.116546014512, 7409.851802964018], "value": 6835.720804605618, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.8108697064662, 500.8647665130415, 507.72582805285145, 511.65974626873134, 530.3979982719613, 6134.325224225332, 6273.463001564617, 6312.652804095773, 6314.463270621997, 6319.368063193679, 6152.0, 6162.352952939944, 6169.352218017111, 6186.845328866781, 6208.6585237811905, 5112.488751124885, 5119.155339368999, 5126.897462050757, 5127.154019586782, 5167.819126330579, 5019.799208031674, 5099.053917699825, 5119.56483698886, 5126.282320475137, 5148.099082660538, 5140.126178549655, 5168.61235407346, 5188.688678679272, 5200.401953775307, 5209.791608335662, 5166.405863325728, 5183.667349692634, 5183.688978661255, 5194.402643695986, 5232.8749318896425, 4701.600363969067, 4807.206810876201, 4820.084184005028, 4825.9034819303415, 4831.106245344622, 6122.326544080148, 6150.169727086831, 6155.045967874987, 6188.133661287423, 6196.132541444202, 5961.105834124873, 5966.70166491678, 5982.820515384546, 5983.910241346383, 6008.879822403527, 6529.183852018497, 6551.246606640249, 6562.639054851981, 6587.901181482282, 6643.873960332696, 5048.217526283432, 5232.686038837682, 5282.577393808486, 5288.444713305086, 5294.814681486168, 6695.263521012685, 6698.162729658793, 6790.796276111724, 6860.965695171542, 6877.346652068046, 5417.6478528895495, 5418.4039755626845, 5423.450978040315, 5431.619786614978, 5452.127659574449, 5470.425605311465, 5472.863178420572, 5528.640638358494, 5544.556435485151, 5559.138333558305, 5864.560157988168, 5886.293644762656, 5919.247549889322, 5932.169496270526, 5961.433663801932, 6602.207735071822, 6621.536492445579, 6623.0, 6646.567973081735, 6648.767293144813, 1887.9622407552047, 1905.818392596599, 1922.2887531613112, 1935.9032048397805, 1944.9691663418412, 1352.8985326100583, 1418.198717724503, 1430.6065831896312, 1433.2475450388629, 1455.9662639526055, 5573.972130139324, 5585.553155747531, 5609.214709940612, 5610.242617246701, 5615.157726341082, 6505.41451269388, 6528.792173447928, 6561.2782593914635, 6568.737250510022, 6577.0, 5567.164925261243, 5595.964746521907, 5635.350835560679, 5652.943470565242, 5668.461496157858, 3464.965350346464, 3471.923703651876, 3475.42655461851, 3479.4258947273415, 3491.17957280039, 6375.649339286291, 6389.776357827547, 6397.776077837253, 6416.454601358843, 6460.870782584322, 6745.628990405575, 6771.627560484122, 6783.932160678429, 6857.0, 6878.55289406187, 6356.2054743157105, 6375.681215939185, 6407.455366293917, 6411.67941602918, 6463.027007576474, 6526.738930442729, 6580.539362244788, 6603.273639899703, 6657.434118099822, 6661.766838160641, 6436.133521278964, 6461.19235095613, 6535.901961470487, 6558.8360290993105, 6581.736730530916, 6266.905996409966, 6285.308616052322, 6297.15873317267, 6309.968450157719, 6346.555741098079, 5430.375506816608, 5440.211169380497, 5449.863753406196, 5452.236686863922, 5456.427075157051, 6407.327230640715, 6485.8702825944165, 6599.505037122139, 6705.698243579148, 6743.595384276763, 6393.744250229939, 6399.680015999088, 6409.6860143671365, 6425.325340839145, 6461.741530338733, 6318.810435686937, 6341.302456729848, 6345.841353966188, 6353.094071778541, 6405.743770249324, 6129.896618608694, 6327.335629758809, 6328.177336946352, 6374.776882809079, 6432.6140431572385, 6304.495640348669, 6331.430171284606, 6426.807195783947, 6470.22357317125, 6477.0, 6174.475169610633, 6225.875482490234, 6251.593646413151, 6253.249610046823, 6284.151639528788], "value": 5129.36207586704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [918.7886786039215, 926.3191554207658, 937.96248150074, 938.5072836760704, 943.9150476457118, 18929.33747318844, 19782.604347913035, 19868.006599670032, 19935.800641993577, 19942.70085948712, 18279.634407311845, 18348.174332155053, 18380.264789408408, 18485.815141848576, 18514.351997680085, 974.6052848596312, 989.8168838764816, 990.7770751580873, 995.6067353395405, 996.6013594562161, 983.9901600984006, 986.9851952220722, 991.6380521109779, 993.4933184076137, 993.5131785425126, 995.3629677006721, 1023.5036007536339, 1027.5119318323812, 1029.1663752360612, 1031.144150355207, 1011.6206422591529, 1014.7970405918845, 1016.3038318751642, 1016.8017236638858, 1018.4398580780542, 752.0824593995317, 754.2193829386558, 754.8565772503207, 755.6637296403103, 757.5681861339039, 19750.0, 20127.698084528598, 20159.697604535944, 20373.0, 20414.69377959332, 21363.67954480684, 21365.893170534204, 22378.44053898649, 22525.887370563207, 22570.097196112136, 17691.380801672007, 18075.819241807545, 18086.366977155736, 18176.000319982395, 18226.0, 3536.2397084626928, 3563.1804684922354, 3603.855845766166, 3609.350316942949, 3612.0789198754414, 103701.48149259205, 140503.29748351296, 140654.0, 141017.29491352476, 143065.0, 17540.649187016443, 18138.81861181398, 18171.454856354332, 18213.08934553267, 18222.180001899946, 31840.0, 32829.50755738618, 32880.1779955503, 32933.50599741006, 32972.0, 8718.738437846874, 8809.295256379473, 8929.24101451371, 8936.41913275635, 8977.685780997634, 4422.624076953431, 4510.8421205257655, 4532.27483602622, 4539.886502837456, 4561.817527298871, 5456.236126942231, 5486.862828429242, 5556.722163891789, 5558.833235002876, 5586.022446071921, 1108.8115020446544, 1119.054399032816, 1122.421952694363, 1124.527698366688, 1126.0147371050332, 677.4309579952863, 688.4595592459895, 696.6342670098138, 699.6781480518916, 701.5404909784099, 11405.372704501333, 11856.585019524275, 11910.642680719593, 11917.582884599171, 11930.343831089373, 677.654396257912, 688.2291833146908, 688.8897776355759, 690.3303795318533, 694.2710154337925, 5406.432324605938, 5496.258005169331, 5500.80747173847, 5529.060059789765, 5582.385937546866, 127488.0, 127629.36185319014, 128804.0, 129374.0, 131498.0, 106274.0, 106606.0, 106716.46641766741, 108280.0, 110396.0, 98445.0, 99798.5010074945, 100832.99999999853, 100956.49521752344, 103593.0, 11800.0, 12206.267623942593, 12463.252204867737, 12548.435320410787, 12561.80662837029, 43457.34813977856, 44029.33955990727, 44165.33751993787, 45308.32037519374, 46093.53906460892, 57293.0, 58080.0, 58687.70656146692, 60529.39470605414, 61142.0, 16689.833101668828, 16912.915435422743, 16918.915405422893, 16949.067801270554, 16956.0, 20050.59898802045, 20112.698309525076, 20147.59704805925, 20171.39485815428, 20336.08487618031, 15560.610984725472, 15576.454824081104, 15628.92185539065, 15756.212189390255, 15841.287142078403, 16062.759058614363, 16547.751783723495, 16995.320187192374, 17081.0, 17260.0, 16369.099699516164, 16589.668206635557, 16604.58488537796, 16650.583735406228, 16692.248848802075, 12564.87435125637, 12740.490380384681, 12890.742185156432, 12974.0, 13016.934915325362, 12312.322822244863, 12328.289519559363, 12348.753024939631, 12561.05792065617, 12588.622341329774], "value": 9196.980064431385, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1416.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 107.0, 108.0, 107.0, 108.0, 108.0, 108.0, 107.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 116.0, 116.0, 120.0, 122.0, 154.0, 117.0, 117.0, 119.0, 117.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0, 163.0, 164.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 75.0, 75.0, 75.0, 74.0, 74.0, 74.0, 75.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 79.0, 80.0, 79.0, 80.0, 78.0, 78.0, 80.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 109.0, 114.0, 114.0, 117.0, 115.0, 118.0, 117.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 149.0, 150.0, 148.0, 150.0, 150.0, 152.0, 148.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 95.0, 95.0, 94.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 54.0, 54.0, 54.0, 53.0, 52.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 74.0, 74.0, 76.0, 75.0, 75.0, 72.0, 75.0, 80.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 115.0, 116.0, 114.0, 108.0, 114.0, 117.0, 109.0, 117.0], "value": 113.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 165.0, 167.0, 164.0, 164.0, 169.0, 166.0, 166.0, 177.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 64.0, 67.0, 66.0, 65.0, 70.0, 64.0, 67.0], "value": 65.7, "unit": "score"}]}]} 15:44:58 INFO - Return code: 0 15:44:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:44:58 INFO - # TBPL SUCCESS # 15:44:58 INFO - Running post-action listener: _package_coverage_data 15:44:58 INFO - Running post-action listener: _resource_record_post_action 15:44:58 INFO - [mozharness: 2017-09-17 22:44:58.834224Z] Finished run-tests step (success) 15:44:58 INFO - Running post-run listener: _resource_record_post_run 15:44:58 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 434176; Write bytes: 344391680; Read time: 228; Write time: 184448 15:44:58 INFO - TinderboxPrint: CPU usage
13.1% 15:44:58 INFO - TinderboxPrint: I/O read bytes / time
434,176 / 228 15:44:58 INFO - TinderboxPrint: I/O write bytes / time
344,391,680 / 184,448 15:44:58 INFO - TinderboxPrint: CPU idle
8,228.8 (86.9%) 15:44:58 INFO - TinderboxPrint: CPU user
1,191.4 (12.6%) 15:44:58 INFO - TinderboxPrint: Swap in / out
0 / 0 15:44:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10285056; Read time: 0; Write time: 680 15:44:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:44:58 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 430080; Write bytes: 334106624; Read time: 208; Write time: 183768 15:44:59 INFO - Running post-run listener: _upload_blobber_files 15:44:59 INFO - Blob upload gear active. 15:44:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:44:59 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 15:44:59 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'] 15:44:59 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 15:44:59 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:45:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:00 INFO - (blobuploader) - INFO - Done attempting. 15:45:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:45:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:01 INFO - (blobuploader) - INFO - Done attempting. 15:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:09 INFO - (blobuploader) - INFO - Done attempting. 15:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:10 INFO - (blobuploader) - INFO - Done attempting. 15:45:10 INFO - (blobuploader) - INFO - Iteration through files over. 15:45:10 INFO - Return code: 0 15:45:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:45:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:45:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99c488616be0c842fdca12aaf69e28e1b6e6ea0b0db8daa0607b367d703cf1c09e468c75c71b0193a90417654371e19241983de46e810814258d578b8c988b9c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9abcd6d8e3fe32da63faf464afc769ec309c0d5a7379bb98b248b72fc7eb8db43314efecd4a38347e89d7fc77774c0d766304e87a205e1e8fe3ddd5b5fcaf145", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/344f255a41c6b3a39ee9ea6e850c80b74e891884c77b06757f754994971728417973b6d9cb94fe6f2144bda435b6bf30b9a6fc93ad58477edd095ea2d75fa228", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8effd7e3476c8db0e03497d1f5ac387f60658af40f179c1dfdda18a8e2ead61e5ed7d61603a221c1722b28b3178ea051fef0e75b967d6654b3fae670bb585ee2"} 15:45:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:45:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:45:10 INFO - Contents: 15:45:10 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99c488616be0c842fdca12aaf69e28e1b6e6ea0b0db8daa0607b367d703cf1c09e468c75c71b0193a90417654371e19241983de46e810814258d578b8c988b9c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9abcd6d8e3fe32da63faf464afc769ec309c0d5a7379bb98b248b72fc7eb8db43314efecd4a38347e89d7fc77774c0d766304e87a205e1e8fe3ddd5b5fcaf145", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/344f255a41c6b3a39ee9ea6e850c80b74e891884c77b06757f754994971728417973b6d9cb94fe6f2144bda435b6bf30b9a6fc93ad58477edd095ea2d75fa228", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8effd7e3476c8db0e03497d1f5ac387f60658af40f179c1dfdda18a8e2ead61e5ed7d61603a221c1722b28b3178ea051fef0e75b967d6654b3fae670bb585ee2"} 15:45:10 INFO - Running post-run listener: copy_logs_to_upload_dir 15:45:10 INFO - Copying logs to upload dir... 15:45:10 INFO - mkdir: /builds/slave/test/build/upload/logs 15:45:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.410499 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-17 15:45:10.140947) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 15:45:10.146977) ========= 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=337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99c488616be0c842fdca12aaf69e28e1b6e6ea0b0db8daa0607b367d703cf1c09e468c75c71b0193a90417654371e19241983de46e810814258d578b8c988b9c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9abcd6d8e3fe32da63faf464afc769ec309c0d5a7379bb98b248b72fc7eb8db43314efecd4a38347e89d7fc77774c0d766304e87a205e1e8fe3ddd5b5fcaf145", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/344f255a41c6b3a39ee9ea6e850c80b74e891884c77b06757f754994971728417973b6d9cb94fe6f2144bda435b6bf30b9a6fc93ad58477edd095ea2d75fa228", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8effd7e3476c8db0e03497d1f5ac387f60658af40f179c1dfdda18a8e2ead61e5ed7d61603a221c1722b28b3178ea051fef0e75b967d6654b3fae670bb585ee2"} build_url:https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/b2Y79Ct6TZem2FvxMKycGw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99c488616be0c842fdca12aaf69e28e1b6e6ea0b0db8daa0607b367d703cf1c09e468c75c71b0193a90417654371e19241983de46e810814258d578b8c988b9c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9abcd6d8e3fe32da63faf464afc769ec309c0d5a7379bb98b248b72fc7eb8db43314efecd4a38347e89d7fc77774c0d766304e87a205e1e8fe3ddd5b5fcaf145", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/344f255a41c6b3a39ee9ea6e850c80b74e891884c77b06757f754994971728417973b6d9cb94fe6f2144bda435b6bf30b9a6fc93ad58477edd095ea2d75fa228", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8effd7e3476c8db0e03497d1f5ac387f60658af40f179c1dfdda18a8e2ead61e5ed7d61603a221c1722b28b3178ea051fef0e75b967d6654b3fae670bb585ee2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 15:45:10.176432) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:45:10.176766) ========= 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=337fe3f4b1febe37b85fccc40000019e-1505675019.710268-596111854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:45:10.258858) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 15:45:10.259189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 15:45:10.259540) ========= ========= Total master_lag: 0.26 =========