builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-079 starttime: 1506681805.3 results: success (0) revision: 946b9c995ec331f4f96360409fd8d2fc49e46838 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.297880) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.298363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.298640) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.318531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.318818) ========= 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=1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 03:43:25-- 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% 86.9M=0s 2017-09-29 03:43:25 (86.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104072 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.458789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.459205) ========= 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=1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020282 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.518242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:25.522232) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 946b9c995ec331f4f96360409fd8d2fc49e46838 --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 946b9c995ec331f4f96360409fd8d2fc49e46838 --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=1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 03:43:25,607 truncating revision to first 12 chars 2017-09-29 03:43:25,607 Setting DEBUG logging. 2017-09-29 03:43:25,607 attempt 1/10 2017-09-29 03:43:25,607 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/946b9c995ec3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 03:43:25,997 unpacking tar archive at: mozilla-central-946b9c995ec3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653844 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:26.193927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:26.194252) ========= script_repo_revision: 946b9c995ec331f4f96360409fd8d2fc49e46838 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:26.194654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:26.194928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 03:43:26.217139) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-29 03:43:26.217529) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:43:26 INFO - MultiFileLogger online at 20170929 03:43:26 in /builds/slave/test 03:43:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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 03:43:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:26 INFO - {'append_to_log': False, 03:43:26 INFO - 'base_work_dir': '/builds/slave/test', 03:43:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:43:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:26 INFO - 'branch': 'Firefox-Non-PGO', 03:43:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:26 INFO - 'code_coverage': False, 03:43:26 INFO - 'config_files': ('talos/linux_config.py',), 03:43:26 INFO - 'default_actions': ('clobber', 03:43:26 INFO - 'read-buildbot-config', 03:43:26 INFO - 'download-and-extract', 03:43:26 INFO - 'populate-webroot', 03:43:26 INFO - 'create-virtualenv', 03:43:26 INFO - 'install', 03:43:26 INFO - 'setup-mitmproxy', 03:43:26 INFO - 'run-tests'), 03:43:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:26 INFO - 'disable_ccov_upload': False, 03:43:26 INFO - 'disable_stylo': False, 03:43:26 INFO - 'download_minidump_stackwalk': True, 03:43:26 INFO - 'download_symbols': 'ondemand', 03:43:26 INFO - 'enable_stylo': False, 03:43:26 INFO - 'enable_webrender': False, 03:43:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:43:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:26 INFO - 'gecko_profile': False, 03:43:26 INFO - 'gecko_profile_interval': 0, 03:43:26 INFO - 'installer_path': 'installer.exe', 03:43:26 INFO - 'log_level': 'info', 03:43:26 INFO - 'log_name': 'talos', 03:43:26 INFO - 'log_to_console': True, 03:43:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:43:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:43:26 INFO - 'opt_config_files': (), 03:43:26 INFO - 'pip_index': False, 03:43:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:43:26 INFO - 'system_bits': '32', 03:43:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:26 INFO - 'title': 'talos-linux64-ix-079', 03:43:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:26 INFO - 'use_talos_json': True, 03:43:26 INFO - 'verify': 'False', 03:43:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:26 INFO - 'work_dir': 'build'} 03:43:26 INFO - [mozharness: 2017-09-29 10:43:26.447418Z] Running clobber step. 03:43:26 INFO - Running pre-action listener: _resource_record_pre_action 03:43:26 INFO - Running main action method: clobber 03:43:26 INFO - rmtree: /builds/slave/test/build 03:43:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:27 INFO - Running post-action listener: _resource_record_post_action 03:43:27 INFO - [mozharness: 2017-09-29 10:43:27.442950Z] Finished clobber step (success) 03:43:27 INFO - [mozharness: 2017-09-29 10:43:27.443047Z] Running read-buildbot-config step. 03:43:27 INFO - Running pre-action listener: _resource_record_pre_action 03:43:27 INFO - Running main action method: read_buildbot_config 03:43:27 INFO - Using buildbot properties: 03:43:27 INFO - { 03:43:27 INFO - "project": "", 03:43:27 INFO - "product": "firefox", 03:43:27 INFO - "who": "archaeopteryx@coole-files.de", 03:43:27 INFO - "installer_path": "public/build/target.tar.bz2", 03:43:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:43:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:43:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:43:27 INFO - "stage_platform": "linux64", 03:43:27 INFO - "basedir": "/builds/slave/test", 03:43:27 INFO - "buildnumber": 78, 03:43:27 INFO - "platform": "ubuntu64_hw", 03:43:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:43:27 INFO - "slavebuilddir": "test", 03:43:27 INFO - "taskId": "D8-KW_HoQzW9GVEmbGd00g", 03:43:27 INFO - "branch": "mozilla-central", 03:43:27 INFO - "script_repo_revision": "production", 03:43:27 INFO - "revision": "946b9c995ec331f4f96360409fd8d2fc49e46838", 03:43:27 INFO - "slavename": "talos-linux64-ix-079", 03:43:27 INFO - "repo_path": "mozilla-central" 03:43:27 INFO - } 03:43:27 INFO - Finding installer, test and symbols from parent task. 03:43:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D8-KW_HoQzW9GVEmbGd00g'}, attempt #1 03:43:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D8-KW_HoQzW9GVEmbGd00g'}, attempt #1 03:43:28 INFO - Task dependencies: ewqrVSCKSgOWNQzmAaDlXw 03:43:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw'}, attempt #1 03:43:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 03:43:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.test_packages.json 03:43:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.crashreporter-symbols.zip 03:43:28 INFO - Running post-action listener: _resource_record_post_action 03:43:28 INFO - [mozharness: 2017-09-29 10:43:28.884998Z] Finished read-buildbot-config step (success) 03:43:28 INFO - [mozharness: 2017-09-29 10:43:28.885216Z] Running download-and-extract step. 03:43:28 INFO - Running pre-action listener: _resource_record_pre_action 03:43:28 INFO - Running main action method: download_and_extract 03:43:28 INFO - mkdir: /builds/slave/test/build/tests 03:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:28 INFO - trying https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.test_packages.json 03:43:28 INFO - Downloading https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:43:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:43:29 INFO - Downloaded 989 bytes. 03:43:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:43:29 INFO - Using the following test package requirements: 03:43:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:43:29 INFO - u'common': [u'target.common.tests.zip'], 03:43:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:43:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:43:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:43:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:43:29 INFO - u'mozbase': [u'target.common.tests.zip'], 03:43:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:43:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:43:29 INFO - u'web-platform': [u'target.common.tests.zip', 03:43:29 INFO - u'target.web-platform.tests.tar.gz'], 03:43:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:43:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:43:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.common.tests.zip 03:43:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:43:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.common.tests.zip into memory 03:43:31 INFO - Content-Length response header: 55366227 03:43:31 INFO - Bytes received: 55366227 03:43:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.talos.tests.zip 03:43:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:43:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.talos.tests.zip into memory 03:43:43 INFO - Content-Length response header: 14521355 03:43:43 INFO - Bytes received: 14521355 03:43:43 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')]} 03:43:43 INFO - trying https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 03:43:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:43:46 INFO - Downloaded 61628365 bytes. 03:43:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 03:43:46 INFO - mkdir: /builds/slave/test/properties 03:43:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:43:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:43:46 INFO - Contents: 03:43:46 INFO - build_url:https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 03:43:46 INFO - Running post-action listener: _resource_record_post_action 03:43:46 INFO - Running post-action listener: find_tests_for_verification 03:43:46 INFO - Running post-action listener: set_extra_try_arguments 03:43:46 INFO - [mozharness: 2017-09-29 10:43:46.207275Z] Finished download-and-extract step (success) 03:43:46 INFO - [mozharness: 2017-09-29 10:43:46.207477Z] Running populate-webroot step. 03:43:46 INFO - Running pre-action listener: _resource_record_pre_action 03:43:46 INFO - Running main action method: populate_webroot 03:43:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:43:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['tresize', 03:43:46 INFO - 'tcanvasmark']}, 03:43:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:43:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['dromaeo_css', 03:43:46 INFO - 'kraken']}, 03:43:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:43:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:43:46 INFO - 'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:43:46 INFO - 'tests': ['damp', 'tps']}, 03:43:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:43:46 INFO - 'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['damp', 'tps']}, 03:43:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:43:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['dromaeo_dom']}, 03:43:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:43:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['basic_compositor_video', 03:43:46 INFO - 'glvideo']}, 03:43:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:43:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:43:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:43:46 INFO - 'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['ts_paint_webext', 03:43:46 INFO - 'tp5o_webext']}, 03:43:46 INFO - 'other-e10s': {'tests': ['a11yr', 03:43:46 INFO - 'ts_paint', 03:43:46 INFO - 'tpaint', 03:43:46 INFO - 'sessionrestore', 03:43:46 INFO - 'sessionrestore_many_windows', 03:43:46 INFO - 'sessionrestore_no_auto_restore', 03:43:46 INFO - 'tabpaint', 03:43:46 INFO - 'cpstartup']}, 03:43:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['a11yr', 03:43:46 INFO - 'ts_paint', 03:43:46 INFO - 'tpaint', 03:43:46 INFO - 'sessionrestore', 03:43:46 INFO - 'sessionrestore_many_windows', 03:43:46 INFO - 'sessionrestore_no_auto_restore', 03:43:46 INFO - 'tabpaint', 03:43:46 INFO - 'cpstartup']}, 03:43:46 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:43:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:43:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['perf_reftest_singletons']}, 03:43:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['perf_reftest']}, 03:43:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:43:46 INFO - 'tsvgr_opacity', 03:43:46 INFO - 'tart', 03:43:46 INFO - 'tscrollx', 03:43:46 INFO - 'tsvg_static']}, 03:43:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['tsvgx', 03:43:46 INFO - 'tsvgr_opacity', 03:43:46 INFO - 'tart', 03:43:46 INFO - 'tscrollx', 03:43:46 INFO - 'tsvg_static']}, 03:43:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:43:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:43:46 INFO - 'talos_options': ['--disable-stylo'], 03:43:46 INFO - 'tests': ['tp5o']}, 03:43:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:43:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:43:46 INFO - 'talos_options': ['--mitmproxy', 03:43:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:43:46 INFO - '--firstNonBlankPaint'], 03:43:46 INFO - 'tests': ['tp6_google', 03:43:46 INFO - 'tp6_youtube', 03:43:46 INFO - 'tp6_amazon', 03:43:46 INFO - 'tp6_facebook']}, 03:43:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:43:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:43:46 INFO - 'talos_options': ['--disable-stylo', 03:43:46 INFO - '--mitmproxy', 03:43:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:43:46 INFO - '--firstNonBlankPaint'], 03:43:46 INFO - 'tests': ['tp6_google', 03:43:46 INFO - 'tp6_youtube', 03:43:46 INFO - 'tp6_amazon', 03:43:46 INFO - 'tp6_facebook']}, 03:43:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:43:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:43:46 INFO - 'talos_options': ['--stylo-threads=1', 03:43:46 INFO - '--mitmproxy', 03:43:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:43:46 INFO - '--firstNonBlankPaint'], 03:43:46 INFO - 'tests': ['tp6_google', 03:43:46 INFO - 'tp6_youtube', 03:43:46 INFO - 'tp6_amazon', 03:43:46 INFO - 'tp6_facebook']}, 03:43:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:43:46 INFO - 'talos_options': ['--xperf_path', 03:43:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:46 INFO - 'tests': ['tp5n']}, 03:43:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:43:46 INFO - 'talos_options': ['--disable-stylo', 03:43:46 INFO - '--xperf_path', 03:43:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:46 INFO - 'tests': ['tp5n']}}} 03:43:46 INFO - Running post-action listener: _resource_record_post_action 03:43:46 INFO - [mozharness: 2017-09-29 10:43:46.232290Z] Finished populate-webroot step (success) 03:43:46 INFO - [mozharness: 2017-09-29 10:43:46.232396Z] Running create-virtualenv step. 03:43:46 INFO - Running pre-action listener: _resource_record_pre_action 03:43:46 INFO - Running main action method: create_virtualenv 03:43:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:43:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:43:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:43:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:43:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:43:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:43:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:43:47 INFO - Installing pip...............done. 03:43:47 INFO - Return code: 0 03:43:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:43:47 INFO - Reading from file tmpfile_stdout 03:43:47 INFO - Output received: 03:43:47 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:43:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:43: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')]} 03:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43: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')]} 03:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, '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': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', '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 03:43:47 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 03:43:47 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 03:43:47 INFO - Using env: {'DISPLAY': ':0', 03:43:47 INFO - 'HOME': '/home/cltbld', 03:43:47 INFO - 'LANG': 'en_US.UTF-8', 03:43:47 INFO - 'LANGUAGE': 'en_US:en', 03:43:47 INFO - 'LOGNAME': 'cltbld', 03:43:47 INFO - 'MAIL': '/var/mail/cltbld', 03:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:47 INFO - 'MOZ_NO_REMOTE': '1', 03:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:47 INFO - 'NO_EM_RESTART': '1', 03:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:47 INFO - 'PWD': '/builds/slave/test', 03:43:47 INFO - 'SHELL': '/bin/bash', 03:43:47 INFO - 'SHLVL': '1', 03:43:47 INFO - 'TERM': 'linux', 03:43:47 INFO - 'TMOUT': '86400', 03:43:47 INFO - 'USER': 'cltbld', 03:43:47 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:47 INFO - '_': '/tools/buildbot/bin/python'} 03:43:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:43:48 INFO - Downloading/unpacking pip>=1.5 03:43:48 INFO - Running setup.py egg_info for package pip 03:43:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:43:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:43:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:43:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:43:48 INFO - Installing collected packages: pip 03:43:48 INFO - Found existing installation: pip 1.1 03:43:48 INFO - Uninstalling pip: 03:43:48 INFO - Successfully uninstalled pip 03:43:48 INFO - Running setup.py install for pip 03:43:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:43:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:43:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:43:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:43:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:43:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:43:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:43:48 INFO - Successfully installed pip 03:43:48 INFO - Cleaning up... 03:43:48 INFO - Return code: 0 03:43:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:43:48 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')]} 03:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:48 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')]} 03:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:48 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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, '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': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', '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 03:43:48 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 03:43:48 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 03:43:48 INFO - Using env: {'DISPLAY': ':0', 03:43:48 INFO - 'HOME': '/home/cltbld', 03:43:48 INFO - 'LANG': 'en_US.UTF-8', 03:43:48 INFO - 'LANGUAGE': 'en_US:en', 03:43:48 INFO - 'LOGNAME': 'cltbld', 03:43:48 INFO - 'MAIL': '/var/mail/cltbld', 03:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:48 INFO - 'MOZ_NO_REMOTE': '1', 03:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:48 INFO - 'NO_EM_RESTART': '1', 03:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:48 INFO - 'PWD': '/builds/slave/test', 03:43:48 INFO - 'SHELL': '/bin/bash', 03:43:48 INFO - 'SHLVL': '1', 03:43:48 INFO - 'TERM': 'linux', 03:43:48 INFO - 'TMOUT': '86400', 03:43:48 INFO - 'USER': 'cltbld', 03:43:48 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:48 INFO - '_': '/tools/buildbot/bin/python'} 03:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:49 INFO - Downloading/unpacking psutil>=3.1.1 03:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:43:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:50 INFO - Installing collected packages: psutil 03:43:50 INFO - Running setup.py install for psutil 03:43:50 INFO - building 'psutil._psutil_linux' extension 03:43:50 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 03:43:50 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 03:43:50 INFO - building 'psutil._psutil_posix' extension 03:43:50 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 03:43:50 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 03:43:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:50 INFO - Successfully installed psutil 03:43:50 INFO - Cleaning up... 03:43:50 INFO - Return code: 0 03:43:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:43:50 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')]} 03:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:50 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')]} 03:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:50 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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, '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': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', '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 03:43:50 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 03:43:50 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 03:43:50 INFO - Using env: {'DISPLAY': ':0', 03:43:50 INFO - 'HOME': '/home/cltbld', 03:43:50 INFO - 'LANG': 'en_US.UTF-8', 03:43:50 INFO - 'LANGUAGE': 'en_US:en', 03:43:50 INFO - 'LOGNAME': 'cltbld', 03:43:50 INFO - 'MAIL': '/var/mail/cltbld', 03:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:50 INFO - 'MOZ_NO_REMOTE': '1', 03:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:50 INFO - 'NO_EM_RESTART': '1', 03:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:50 INFO - 'PWD': '/builds/slave/test', 03:43:50 INFO - 'SHELL': '/bin/bash', 03:43:50 INFO - 'SHLVL': '1', 03:43:50 INFO - 'TERM': 'linux', 03:43:50 INFO - 'TMOUT': '86400', 03:43:50 INFO - 'USER': 'cltbld', 03:43:50 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:50 INFO - '_': '/tools/buildbot/bin/python'} 03:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:43: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 03:43: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 03:43: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 03:43: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 03:43:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:43:52 INFO - Installing collected packages: mozsystemmonitor 03:43:52 INFO - Running setup.py install for mozsystemmonitor 03:43:52 INFO - Successfully installed mozsystemmonitor 03:43:52 INFO - Cleaning up... 03:43:52 INFO - Return code: 0 03:43:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:43:52 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')]} 03:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:52 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')]} 03:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:52 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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, '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': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', '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 03:43:52 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 03:43:52 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 03:43:52 INFO - Using env: {'DISPLAY': ':0', 03:43:52 INFO - 'HOME': '/home/cltbld', 03:43:52 INFO - 'LANG': 'en_US.UTF-8', 03:43:52 INFO - 'LANGUAGE': 'en_US:en', 03:43:52 INFO - 'LOGNAME': 'cltbld', 03:43:52 INFO - 'MAIL': '/var/mail/cltbld', 03:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:52 INFO - 'MOZ_NO_REMOTE': '1', 03:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:52 INFO - 'NO_EM_RESTART': '1', 03:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:52 INFO - 'PWD': '/builds/slave/test', 03:43:52 INFO - 'SHELL': '/bin/bash', 03:43:52 INFO - 'SHLVL': '1', 03:43:52 INFO - 'TERM': 'linux', 03:43:52 INFO - 'TMOUT': '86400', 03:43:52 INFO - 'USER': 'cltbld', 03:43:52 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:52 INFO - '_': '/tools/buildbot/bin/python'} 03:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:43: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 03:43: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 03:43: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 03:43: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 03:43:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:43:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:43: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 03:43: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 03:43: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 03:43: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 03:43:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:43:55 INFO - warning: no files found matching '*.txt' 03:43:55 INFO - no previously-included directories found matching 'build' 03:43:55 INFO - no previously-included directories found matching 'dist' 03:43:55 INFO - no previously-included directories found matching '.git*' 03:43:55 INFO - Installing collected packages: jsonschema, functools32 03:43:55 INFO - Running setup.py install for functools32 03:43:55 INFO - warning: no files found matching '*.txt' 03:43:55 INFO - no previously-included directories found matching 'build' 03:43:55 INFO - no previously-included directories found matching 'dist' 03:43:55 INFO - no previously-included directories found matching '.git*' 03:43:55 INFO - Successfully installed jsonschema functools32 03:43:55 INFO - Cleaning up... 03:43:55 INFO - Return code: 0 03:43:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:43: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')]} 03:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43: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')]} 03:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43: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', '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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, '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': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', '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 03:43: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:43: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 functools32==3.2.3-2 03:43:55 INFO - Using env: {'DISPLAY': ':0', 03:43:55 INFO - 'HOME': '/home/cltbld', 03:43:55 INFO - 'LANG': 'en_US.UTF-8', 03:43:55 INFO - 'LANGUAGE': 'en_US:en', 03:43:55 INFO - 'LOGNAME': 'cltbld', 03:43:55 INFO - 'MAIL': '/var/mail/cltbld', 03:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:55 INFO - 'MOZ_NO_REMOTE': '1', 03:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:55 INFO - 'NO_EM_RESTART': '1', 03:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:55 INFO - 'PWD': '/builds/slave/test', 03:43:55 INFO - 'SHELL': '/bin/bash', 03:43:55 INFO - 'SHLVL': '1', 03:43:55 INFO - 'TERM': 'linux', 03:43:55 INFO - 'TMOUT': '86400', 03:43:55 INFO - 'USER': 'cltbld', 03:43:55 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:55 INFO - '_': '/tools/buildbot/bin/python'} 03:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:43:55 INFO - Cleaning up... 03:43:55 INFO - Return code: 0 03:43:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:43: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')]} 03:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43: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')]} 03:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43: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', '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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, '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': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', '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 03:43: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:43: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 blobuploader==1.2.4 03:43:55 INFO - Using env: {'DISPLAY': ':0', 03:43:55 INFO - 'HOME': '/home/cltbld', 03:43:55 INFO - 'LANG': 'en_US.UTF-8', 03:43:55 INFO - 'LANGUAGE': 'en_US:en', 03:43:55 INFO - 'LOGNAME': 'cltbld', 03:43:55 INFO - 'MAIL': '/var/mail/cltbld', 03:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:55 INFO - 'MOZ_NO_REMOTE': '1', 03:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:55 INFO - 'NO_EM_RESTART': '1', 03:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:55 INFO - 'PWD': '/builds/slave/test', 03:43:55 INFO - 'SHELL': '/bin/bash', 03:43:55 INFO - 'SHLVL': '1', 03:43:55 INFO - 'TERM': 'linux', 03:43:55 INFO - 'TMOUT': '86400', 03:43:55 INFO - 'USER': 'cltbld', 03:43:55 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:55 INFO - '_': '/tools/buildbot/bin/python'} 03:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:43:56 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 03:43:56 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 03:43:56 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 03:43:56 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 03:43:58 INFO - Downloading blobuploader-1.2.4.tar.gz 03:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:43:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:43: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 03:43: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 03:43: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 03:43: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 03:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:43:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:43: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 03:43: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 03:43: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 03:43: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 03:43:58 INFO - Downloading docopt-0.6.1.tar.gz 03:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:43:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:43:58 INFO - Running setup.py install for blobuploader 03:43:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:43:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:43:58 INFO - Running setup.py install for requests 03:43:59 INFO - Running setup.py install for docopt 03:43:59 INFO - Successfully installed blobuploader requests docopt 03:43:59 INFO - Cleaning up... 03:43:59 INFO - Return code: 0 03:43:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:59 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')]} 03:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:59 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')]} 03:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:59 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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, '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': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', '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 03:43:59 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 03:43:59 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 03:43:59 INFO - Using env: {'DISPLAY': ':0', 03:43:59 INFO - 'HOME': '/home/cltbld', 03:43:59 INFO - 'LANG': 'en_US.UTF-8', 03:43:59 INFO - 'LANGUAGE': 'en_US:en', 03:43:59 INFO - 'LOGNAME': 'cltbld', 03:43:59 INFO - 'MAIL': '/var/mail/cltbld', 03:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:59 INFO - 'MOZ_NO_REMOTE': '1', 03:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:59 INFO - 'NO_EM_RESTART': '1', 03:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:59 INFO - 'PWD': '/builds/slave/test', 03:43:59 INFO - 'SHELL': '/bin/bash', 03:43:59 INFO - 'SHLVL': '1', 03:43:59 INFO - 'TERM': 'linux', 03:43:59 INFO - 'TMOUT': '86400', 03:43:59 INFO - 'USER': 'cltbld', 03:43:59 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:59 INFO - '_': '/tools/buildbot/bin/python'} 03:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:59 INFO - Running setup.py (path:/tmp/pip-ZlzE36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:59 INFO - Running setup.py (path:/tmp/pip-_w0G3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:59 INFO - Running setup.py (path:/tmp/pip-y0CSuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:59 INFO - Running setup.py (path:/tmp/pip-frptDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:59 INFO - Running setup.py (path:/tmp/pip-pmXAMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:59 INFO - Running setup.py (path:/tmp/pip-DrFFFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:00 INFO - Running setup.py (path:/tmp/pip-PqDRqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:00 INFO - Running setup.py (path:/tmp/pip-QyCDet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:00 INFO - Running setup.py (path:/tmp/pip-PaMyt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:00 INFO - Running setup.py (path:/tmp/pip-4iEuly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:00 INFO - Running setup.py (path:/tmp/pip-3DuHY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:00 INFO - Running setup.py (path:/tmp/pip-gtm9GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:00 INFO - Running setup.py (path:/tmp/pip-ggPkLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:00 INFO - Running setup.py (path:/tmp/pip-F7RXth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:00 INFO - Running setup.py (path:/tmp/pip-ntZR80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:00 INFO - Running setup.py (path:/tmp/pip-5y1gYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:00 INFO - Running setup.py (path:/tmp/pip-UApWZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:44:00 INFO - Running setup.py install for manifestparser 03:44:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:44:00 INFO - Running setup.py install for mozcrash 03:44:01 INFO - Running setup.py install for mozdebug 03:44:01 INFO - Running setup.py install for mozdevice 03:44:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Running setup.py install for mozfile 03:44:01 INFO - Running setup.py install for mozhttpd 03:44:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Running setup.py install for mozinfo 03:44:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Running setup.py install for mozInstall 03:44:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Running setup.py install for mozleak 03:44:01 INFO - Running setup.py install for mozlog 03:44:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Running setup.py install for moznetwork 03:44:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:44:01 INFO - Running setup.py install for mozprocess 03:44:02 INFO - Running setup.py install for mozprofile 03:44:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:44:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:44:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:44:02 INFO - Running setup.py install for mozrunner 03:44:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:44:02 INFO - Running setup.py install for mozscreenshot 03:44:02 INFO - Running setup.py install for moztest 03:44:02 INFO - Running setup.py install for mozversion 03:44:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:44:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:44:02 INFO - Cleaning up... 03:44:02 INFO - Return code: 0 03:44:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:02 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')]} 03:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:02 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')]} 03:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:02 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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, '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': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', '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 03:44:02 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 03:44:02 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 03:44:02 INFO - Using env: {'DISPLAY': ':0', 03:44:02 INFO - 'HOME': '/home/cltbld', 03:44:02 INFO - 'LANG': 'en_US.UTF-8', 03:44:02 INFO - 'LANGUAGE': 'en_US:en', 03:44:02 INFO - 'LOGNAME': 'cltbld', 03:44:02 INFO - 'MAIL': '/var/mail/cltbld', 03:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:02 INFO - 'MOZ_NO_REMOTE': '1', 03:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:02 INFO - 'NO_EM_RESTART': '1', 03:44:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:02 INFO - 'PWD': '/builds/slave/test', 03:44:02 INFO - 'SHELL': '/bin/bash', 03:44:02 INFO - 'SHLVL': '1', 03:44:02 INFO - 'TERM': 'linux', 03:44:02 INFO - 'TMOUT': '86400', 03:44:02 INFO - 'USER': 'cltbld', 03:44:02 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:02 INFO - '_': '/tools/buildbot/bin/python'} 03:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:02 INFO - Running setup.py (path:/tmp/pip-uf7_6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:02 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)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:02 INFO - Running setup.py (path:/tmp/pip-H3Uqwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:02 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)) 03:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:02 INFO - Running setup.py (path:/tmp/pip-uwGwFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:03 INFO - Running setup.py (path:/tmp/pip-fS91ZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:03 INFO - Running setup.py (path:/tmp/pip-8FSmVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:03 INFO - Running setup.py (path:/tmp/pip-0naDXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:03 INFO - Running setup.py (path:/tmp/pip-qXIchw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:03 INFO - Running setup.py (path:/tmp/pip-HvGUDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:03 INFO - Running setup.py (path:/tmp/pip-VhcXPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:03 INFO - Running setup.py (path:/tmp/pip-wNgiF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:03 INFO - Running setup.py (path:/tmp/pip-asWGMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:03 INFO - Running setup.py (path:/tmp/pip-cshsro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:03 INFO - Running setup.py (path:/tmp/pip-sTklTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:03 INFO - Running setup.py (path:/tmp/pip-ay_Jn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:03 INFO - Running setup.py (path:/tmp/pip-eHUvO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:03 INFO - Running setup.py (path:/tmp/pip-JTKM79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:03 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)) 03:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:03 INFO - Running setup.py (path:/tmp/pip-7LAabZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:04 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)) 03:44:04 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)) 03:44:04 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)) 03:44:04 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)) 03:44:04 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)) 03:44:04 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)) 03:44:04 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)) 03:44:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:05 INFO - Downloading blessings-1.6.tar.gz 03:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:05 INFO - Installing collected packages: blessings 03:44:05 INFO - Running setup.py install for blessings 03:44:05 INFO - Successfully installed blessings 03:44:05 INFO - Cleaning up... 03:44:05 INFO - Return code: 0 03:44:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:05 INFO - Reading from file tmpfile_stdout 03:44:05 INFO - Current package versions: 03:44:05 INFO - argparse == 1.2.1 03:44:05 INFO - blessings == 1.6 03:44:05 INFO - blobuploader == 1.2.4 03:44:05 INFO - docopt == 0.6.1 03:44:05 INFO - functools32 == 3.2.3-2 03:44:05 INFO - jsonschema == 2.5.1 03:44:05 INFO - manifestparser == 1.1 03:44:05 INFO - mozInstall == 1.13 03:44:05 INFO - mozcrash == 1.0 03:44:05 INFO - mozdebug == 0.1 03:44:05 INFO - mozdevice == 0.51 03:44:05 INFO - mozfile == 1.2 03:44:05 INFO - mozhttpd == 0.7 03:44:05 INFO - mozinfo == 0.10 03:44:05 INFO - mozleak == 0.1 03:44:05 INFO - mozlog == 3.5 03:44:05 INFO - moznetwork == 0.27 03:44:05 INFO - mozprocess == 0.25 03:44:05 INFO - mozprofile == 0.28 03:44:05 INFO - mozrunner == 6.13 03:44:05 INFO - mozscreenshot == 0.1 03:44:05 INFO - mozsystemmonitor == 0.3 03:44:05 INFO - moztest == 0.8 03:44:05 INFO - mozversion == 1.4 03:44:05 INFO - psutil == 3.1.1 03:44:05 INFO - requests == 1.2.3 03:44:05 INFO - wsgiref == 0.1.2 03:44:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:05 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')]} 03:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:05 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')]} 03:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:05 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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, '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': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', '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 03:44:05 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 03:44:05 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 03:44:05 INFO - Using env: {'DISPLAY': ':0', 03:44:05 INFO - 'HOME': '/home/cltbld', 03:44:05 INFO - 'LANG': 'en_US.UTF-8', 03:44:05 INFO - 'LANGUAGE': 'en_US:en', 03:44:05 INFO - 'LOGNAME': 'cltbld', 03:44:05 INFO - 'MAIL': '/var/mail/cltbld', 03:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:05 INFO - 'MOZ_NO_REMOTE': '1', 03:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:05 INFO - 'NO_EM_RESTART': '1', 03:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:05 INFO - 'PWD': '/builds/slave/test', 03:44:05 INFO - 'SHELL': '/bin/bash', 03:44:05 INFO - 'SHLVL': '1', 03:44:05 INFO - 'TERM': 'linux', 03:44:05 INFO - 'TMOUT': '86400', 03:44:05 INFO - 'USER': 'cltbld', 03:44:05 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:05 INFO - '_': '/tools/buildbot/bin/python'} 03:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:05 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)) 03:44:05 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)) 03:44:05 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)) 03:44:05 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)) 03:44:05 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)) 03:44:05 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)) 03:44:05 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)) 03:44:05 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)) 03:44:05 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)) 03:44:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:44: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 03:44: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 03:44: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 03:44: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 03:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:44:06 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)) 03:44:06 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)) 03:44:07 INFO - Installing collected packages: simplejson 03:44:07 INFO - Running setup.py install for simplejson 03:44:07 INFO - building 'simplejson._speedups' extension 03:44:07 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 03:44:07 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 03:44:07 INFO - Successfully installed simplejson 03:44:07 INFO - Cleaning up... 03:44:08 INFO - Return code: 0 03:44:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:08 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')]} 03:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:08 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')]} 03:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:08 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 0x1c0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd5b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f78df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, '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': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', '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 03:44:08 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 03:44:08 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 03:44:08 INFO - Using env: {'DISPLAY': ':0', 03:44:08 INFO - 'HOME': '/home/cltbld', 03:44:08 INFO - 'LANG': 'en_US.UTF-8', 03:44:08 INFO - 'LANGUAGE': 'en_US:en', 03:44:08 INFO - 'LOGNAME': 'cltbld', 03:44:08 INFO - 'MAIL': '/var/mail/cltbld', 03:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:08 INFO - 'MOZ_NO_REMOTE': '1', 03:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:08 INFO - 'NO_EM_RESTART': '1', 03:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:08 INFO - 'PWD': '/builds/slave/test', 03:44:08 INFO - 'SHELL': '/bin/bash', 03:44:08 INFO - 'SHLVL': '1', 03:44:08 INFO - 'TERM': 'linux', 03:44:08 INFO - 'TMOUT': '86400', 03:44:08 INFO - 'USER': 'cltbld', 03:44:08 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:08 INFO - '_': '/tools/buildbot/bin/python'} 03:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:44:08 INFO - Cleaning up... 03:44:08 INFO - Return code: 0 03:44:08 INFO - Running post-action listener: _resource_record_post_action 03:44:08 INFO - Running post-action listener: _start_resource_monitoring 03:44:08 INFO - Starting resource monitoring. 03:44:08 INFO - [mozharness: 2017-09-29 10:44:08.297977Z] Finished create-virtualenv step (success) 03:44:08 INFO - [mozharness: 2017-09-29 10:44:08.298495Z] Running install step. 03:44:08 INFO - Running pre-action listener: _resource_record_pre_action 03:44:08 INFO - Running main action method: install 03:44:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:08 INFO - Reading from file tmpfile_stdout 03:44:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:08 INFO - Reading from file tmpfile_stdout 03:44:08 INFO - Output received: 03:44:08 INFO - Usage: mozinstall [options] installer 03:44:08 INFO - Options: 03:44:08 INFO - -h, --help show this help message and exit 03:44:08 INFO - -d DEST, --destination=DEST 03:44:08 INFO - Directory to install application into. [default: 03:44:08 INFO - "/builds/slave/test"] 03:44:08 INFO - --app=APP Application being installed. [default: firefox] 03:44:08 INFO - mkdir: /builds/slave/test/build/application 03:44:08 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'] 03:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:44:26 INFO - Reading from file tmpfile_stdout 03:44:26 INFO - Output received: 03:44:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:44:26 INFO - Running post-action listener: _resource_record_post_action 03:44:26 INFO - [mozharness: 2017-09-29 10:44:26.420237Z] Finished install step (success) 03:44:26 INFO - [mozharness: 2017-09-29 10:44:26.420383Z] Running setup-mitmproxy step. 03:44:26 INFO - Running pre-action listener: _resource_record_pre_action 03:44:26 INFO - Running main action method: setup_mitmproxy 03:44:26 INFO - Skipping: mitmproxy is not required 03:44:26 INFO - Running post-action listener: _resource_record_post_action 03:44:26 INFO - [mozharness: 2017-09-29 10:44:26.420953Z] Finished setup-mitmproxy step (success) 03:44:26 INFO - [mozharness: 2017-09-29 10:44:26.421082Z] Running run-tests step. 03:44:26 INFO - Running pre-action listener: _resource_record_pre_action 03:44:26 INFO - Running pre-action listener: _set_gcov_prefix 03:44:26 INFO - Running main action method: run_tests 03:44:26 WARNING - Try message not found. 03:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:26 INFO - Python 2.7.3 03:44:26 INFO - Return code: 0 03:44:26 INFO - grabbing minidump binary from tooltool 03:44:26 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')]} 03:44:26 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 0x1f7c440>, '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 0x1f7d130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f77320>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:26 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 03:44:26 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 03:44:26 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 03:44:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:26 INFO - Return code: 0 03:44:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:44:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:26 INFO - ENV: RUST_BACKTRACE is now full 03:44:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:44:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:26 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:44:26 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:44:26 INFO - Using env: {'DISPLAY': ':0', 03:44:26 INFO - 'HOME': '/home/cltbld', 03:44:26 INFO - 'LANG': 'en_US.UTF-8', 03:44:26 INFO - 'LANGUAGE': 'en_US:en', 03:44:26 INFO - 'LOGNAME': 'cltbld', 03:44:26 INFO - 'MAIL': '/var/mail/cltbld', 03:44:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:26 INFO - 'MOZ_NO_REMOTE': '1', 03:44:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:26 INFO - 'NO_EM_RESTART': '1', 03:44:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:26 INFO - 'PWD': '/builds/slave/test', 03:44:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:26 INFO - 'RUST_BACKTRACE': 'full', 03:44:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:44:26 INFO - 'SHELL': '/bin/bash', 03:44:26 INFO - 'SHLVL': '1', 03:44:26 INFO - 'TERM': 'linux', 03:44:26 INFO - 'TMOUT': '86400', 03:44:26 INFO - 'USER': 'cltbld', 03:44:26 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:26 INFO - '_': '/tools/buildbot/bin/python'} 03:44:26 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:44:26 INFO - mozversion application_buildid: 20170929094722 03:44:26 INFO - mozversion application_changeset: 946b9c995ec331f4f96360409fd8d2fc49e46838 03:44:26 INFO - mozversion application_display_name: Nightly 03:44:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:26 INFO - mozversion application_name: Firefox 03:44:26 INFO - mozversion application_remotingname: firefox 03:44:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:44:26 INFO - mozversion application_vendor: Mozilla 03:44:26 INFO - mozversion application_version: 58.0a1 03:44:26 INFO - mozversion platform_buildid: 20170929094722 03:44:26 INFO - mozversion platform_changeset: 946b9c995ec331f4f96360409fd8d2fc49e46838 03:44:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:44:26 INFO - mozversion platform_version: 58.0a1 03:44:26 INFO - using testdate: 1506681866 03:44:26 INFO - actual date: 1506681866 03:44:26 INFO - starting webserver on 'localhost:47336' 03:44:26 INFO - SUITE-START | Running 2 tests 03:44:26 INFO - TEST-START | dromaeo_css 03:44:26 INFO - Initialising browser for dromaeo_css test... 03:44:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47336/getInfo.html -profile /tmp/tmp43t_S3/profile 03:44:26 INFO - TEST-INFO | started process 32434 (/builds/slave/test/build/application/firefox/firefox http://localhost:47336/getInfo.html) 03:44:33 INFO - TEST-INFO | 32434: exit 0 03:44:33 INFO - Browser initialized. 03:44:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:44:33 INFO - Using env: {'DISPLAY': ':0', 03:44:33 INFO - 'HOME': '/home/cltbld', 03:44:33 INFO - 'JSGC_DISABLE_POISONING': '1', 03:44:33 INFO - 'LANG': 'en_US.UTF-8', 03:44:33 INFO - 'LANGUAGE': 'en_US:en', 03:44:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:44:33 INFO - 'LOGNAME': 'cltbld', 03:44:33 INFO - 'MAIL': '/var/mail/cltbld', 03:44:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:33 INFO - 'MOZ_CRASHREPORTER': '1', 03:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:44:33 INFO - 'MOZ_NO_REMOTE': '1', 03:44:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:33 INFO - 'NO_EM_RESTART': '1', 03:44:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:33 INFO - 'PWD': '/builds/slave/test', 03:44:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:33 INFO - 'RUST_BACKTRACE': 'full', 03:44:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:44:33 INFO - 'SHELL': '/bin/bash', 03:44:33 INFO - 'SHLVL': '1', 03:44:33 INFO - 'STYLO_FORCE_DISABLED': '1', 03:44:33 INFO - 'TERM': 'linux', 03:44:33 INFO - 'TMOUT': '86400', 03:44:33 INFO - 'USER': 'cltbld', 03:44:33 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 03:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:33 INFO - '_': '/tools/buildbot/bin/python'} 03:44:33 INFO - TEST-INFO | started process 32667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp43t_S3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:34 INFO - PID 32667 | 03:44:34 INFO - PID 32667 | (/builds/slave/test/build/application/firefox/firefox:32716): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:44:34 INFO - PID 32667 | 03:44:44 INFO - PID 32667 | RSS: Main: 151142400 03:44:44 INFO - PID 32667 | 03:47:42 INFO - PID 32667 | Cycle 1(1): loaded http://localhost:47336/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47336/tests/dromaeo/cssquery-ext.html) 03:47:43 INFO - PID 32667 | RSS: Main: 151474176 03:47:43 INFO - PID 32667 | 03:50:45 INFO - PID 32667 | Cycle 1(1): loaded http://localhost:47336/tests/dromaeo/cssquery-ext.html (next: http://localhost:47336/tests/dromaeo/cssquery-jquery.html) 03:50:45 INFO - PID 32667 | RSS: Main: 149291008 03:50:45 INFO - PID 32667 | 03:53:47 INFO - PID 32667 | Cycle 1(1): loaded http://localhost:47336/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47336/tests/dromaeo/cssquery-mootools.html) 03:53:48 INFO - PID 32667 | RSS: Main: 150786048 03:53:48 INFO - PID 32667 | 03:56:49 INFO - PID 32667 | Cycle 1(1): loaded http://localhost:47336/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47336/tests/dromaeo/cssquery-prototype.html) 03:56:50 INFO - PID 32667 | RSS: Main: 150675456 03:56:50 INFO - PID 32667 | 03:59:53 INFO - PID 32667 | Cycle 1(1): loaded http://localhost:47336/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47336/tests/dromaeo/cssquery-yui.html) 03:59:54 INFO - PID 32667 | RSS: Main: 153247744 03:59:54 INFO - PID 32667 | 04:02:55 INFO - PID 32667 | Cycle 1(1): loaded http://localhost:47336/tests/dromaeo/cssquery-yui.html (next: http://localhost:47336/tests/dromaeo/cssquery-dojo.html) 04:02:55 INFO - PID 32667 | RSS: Main: 154226688 04:02:55 INFO - PID 32667 | 04:02:55 INFO - PID 32667 | __start_tp_report 04:02:55 INFO - PID 32667 | _x_x_mozilla_page_load 04:02:55 INFO - PID 32667 | _x_x_mozilla_page_load_details 04:02:55 INFO - PID 32667 | |i|pagename|runs| 04:02:55 INFO - PID 32667 | |0;dojo.html;3209.9197520061994;3235.9676403235962;3241.222106694391;3250.268689544853;3254.023792862141;6226;6429.421352078312;6429.485641148709;6433.228012638484;6576.1122248496495;6338.841528961778;6376.9362306376925;6412.519061070427;6461;6491.2535058468175;5867.823965281027;5902.203202567652;5906.940930590682;5926.792562260322;5991;5961.076033214837;6024.1566180734735;6028.125921741344;6029.457348838604;6042.244719410074;5929.258842644669;5979.252593425822;6055.848603784896;6068.514518838504;6073.514118870502;5700.059490184156;5807.709614519257;5846.064629659234;5856.092305692582;5899.2920849497905;5822.941770582324;5837.387074357174;5883.205767221413;5899.941000589982;5902.409759024106;6133.907991380132;6324.778632747878;6424.903626445607;6501.219853617549;6510.609363438209;6752.324767523258;6770.8307292317595;6780.660966951633;6800.285969973131;6823.590584564942;6870.416014638762;6878.759243426506;6890.621015844126;6990.965045174792;6994.33553812387;6405.231372235315;6475.384838440341;6496.090547323379;6499.480041596708;6502.93497065028;7029.211088471951;7107.75122870697;7138.9286107139305;7209.855802883913;7240.4569657275915;6630.834229144213;6715.932840671629;6728.158980127484;6791.966040169867;6813.3527314905;6870.828229294208;6883.65581720922;6990.895136572955;7002.474814388941;7013.298670133048;6855.383015528626;6873.48448866337;6913.861722765517;6932.341427564374;6948.6178260196175;6694.397504224546;6907.067545881242;6928.064711264015;7004.614746188907;7014.158301003912;5341.86645333862;5375.086235340002;5396.217548455452;5401.864953376197;5414.18787181918;4718.9292160617615;4734.928976065362;4777.474477807438;4784.617230621542;4809.879753006203;5891.3814049525035;5902.940970590325;5905.173275741399;5991.191189189403;6004.519638428916;6919.238883722786;6965.965170174117;7015.438764898796;7038.859222815618;7054.964725176341;5756.222909907193;5825.446582574648;5826.126081087871;5915.1718759373725;5920.141579470953;5895.410458954156;5953.136795164677;5955.672438015864;5964.701764911737;5969.940300597025;6621;6642.43539299165;6714.29499902513;6719.697613607399;6721.529492935545;6896.689648965909;6918.273581273894;6918.619475928772;7013.859722805618;7016.19313778922;6468.029795530708;6586.5389422739945;6604.768833090819;6634.635095069624;6637.6349300788925;6726.3609957054005;6806.965965170142;6808.897866531907;6813.89779153323;6830.146231721035;6957.339052789976;7009.1589009319205;7016.26329235423;7035.261297563887;7057.823554411181;6682.599044057372;6685.565438246693;6773.525853190229;6786.083878676315;6794;6552.082708420729;6660.034295027291;6667.299933506912;6689.665516724242;6785.830354240986;6511.153550038464;6573.474122070127;6602.933970660232;6607.108040414482;6714.630695311609;6765.1205343305055;6814.727410903508;6849.554778939353;6861.382475577222;6863.931360686329;6522.380373864476;6549.869002619826;6596;6643.335666433318;6665.13353264092 04:02:55 INFO - PID 32667 | |1;ext.html;865.1607940297911;886.9246114080303;887.7026196224268;892.0455113029053;894.9597268122934;39545.80227098864;42881;43247;43251;43317.56682433175;39042.60957390425;39393;39425.40861887074;39426.80286598563;39435.0141246469;7081.044059052039;7199.89200161998;7207.639618019104;7793.649285782125;8115.066767321775;7967.840643187133;8100.554469504175;8102.473339232931;8104.068032176317;8106.837863242732;8011.078725946532;8023.518588884656;8045.275925166734;8067.314278286352;8082.2725954664065;8035.55804430762;8044.155363686817;8044.3966702497255;8080.151584083704;8084.5149291042135;7876.842463150762;7887.763367098996;7928.563928983961;7947.920520794776;7957.442978991473;39053.21893562113;39169.21661566753;39252.411213831816;39314;39400.60599393998;3582.498450216972;3635.763675361093;3642.5993140754495;3644.21649345392;3645.5989841117457;32129.357412851612;32260.193495162574;32277.83861080703;32347.83826080878;32365.352692946246;5254.92117618236;5288.0745869472685;5325.174597937326;5327.627066105374;5346;198539;199144;200355;200360.99999999854;200570.9971450148;43833;44325.55674443214;51041.48958510441;51200.48799512032;51284.74357628188;53212;53879.46120538823;54397;54422.72788636031;54423.45576544263;16581.336746530244;16587.83412165863;16730.330786768394;16747.330106795835;16755.916220419065;13617.795733064011;13665.111767735065;13673.794893076612;13676.589702308947;13678;14773.778393324108;14830.70338593222;14839.258037098318;14879.256037198096;14964.775528367083;5801.854953626109;5933.584649074523;5945.732442040118;5974.85062873423;5977.193078934288;987.5950860147449;987.916027137687;1010.5604062232952;1012.2155329619457;1023.8208313545249;23190.3042908713;23225.535489290458;23376.532469350517;23472.295831125095;23686.170984015476;1104.6465131157952;1125.5047778977223;1126.4424110065406;1128.7347473343757;1130.7964566377966;12259.69350766238;12466.376681165906;12487.562935297403;12509.249445033327;12534.81197782034;211429;226292;234338;235765;236147;54116.45883541114;54117.72941135269;54262.45737542653;54307;54308.45691543034;1423.871851533367;1471.6762312291278;1481.6147801571453;1486.294010345099;1494.6562290673205;22961.88519057394;23026.539469210857;23041.65437518405;23093.268004899364;23218.883905580366;38682.41976370413;38798.03004924899;38846.6115338843;38871;38884.2223155541;196602;196887;197025;197171;197627;31711.524327135572;32106.51840222352;35061.29877402387;35145.64854351424;35346.05596692207;44898.77550612226;44944;45060.54939450695;45321.54678453173;45345.319820202065;32298;32869.34261314713;32873.83563082169;33004.33991320208;33155;32600.673993259763;32610.673893260762;32622;33057.33885322232;33613.32773344568;35546.64453355433;36682.44976325304;36863.63136368602;37061.44407833831;37076;31395;31927.36145277035;31946.840265799452;31970.20074498156;32139.67860321367;23658.763412365657;23883.641745373487;24027.759722402552;24140.275791726275;24430.87784561066 04:02:55 INFO - PID 32667 | |2;jquery.html;591.8342863998082;596.6241268001164;602.3616559469523;604.3110853626863;620.2928661326089;22029.66955495669;22799.31602051937;22840.88579557102;22852.542949141007;22881.54236915265;23722.288331350042;24941.25176244711;25278.620820687705;25435.364115897064;25514.234572962796;6453.903191452132;6639.535232533724;6642.734290628369;6649.368310010541;6663.833404164886;6125.418085281891;6533.640649764261;6554.7705830295945;6569.211694596655;6616.569922954993;6310.368963103699;6356.745730170811;6356.904646430284;6373.362663733636;6373.3945275198785;6384.936150638504;6395.8401039973905;6399.008153736178;6401.551891367606;6401.9359806402035;5914.940850591482;5973.611715238496;6139.355367686373;6140.723667434976;6145.139680444697;27616.585751213748;28100.578491322645;28182.436351273063;28193.436131277464;28194;2038.7043878637514;2059.2792522617115;2064.1743302678897;2068.5449201175716;2082.79172082792;18616.534586635305;18669;18868.1509332079;18927.526811829677;19765.209391624318;2448.09420514409;2476.182859656309;2496.188738659943;2543.7583429574347;2548.2227920484247;123709.38145309305;129769;135331;141673;141856;14804.001459802788;14877.404903803943;15009;15093;15715.607109822346;23481.17815876436;23556.29331120069;23581;23597.410064748517;23636.881815590812;10074.345167564084;10182;10252.179825614083;10254.077133058061;10256.692299231036;9363.25093992479;9402.858957115648;9484.90515094854;9508.239340852715;9528.714138575853;8908.510031948304;9254.907450925404;9289.767755806024;9356.204722598655;9555.474448905377;2638.14260365382;2647.880845361963;2657.5747880339054;2705.621213030138;2826.1804076817903;914.8719179314901;955.3790036476346;962.153305091515;971.8007808399261;975.0693626619334;19057.618847623246;19196.61606767857;19501.609967800563;19534;19641.116149773294;998.6904059741504;1020.7039958411978;1023.6212601337553;1038.08129805123;1041.5729550884253;10652.573897044187;10801.67594972152;10805.02754752076;10856.620018299322;10947.671569852917;484921;497936;499143;504682;505219;110135;110399;110645;114222;114409;1045.0646671229208;1081.9296745711504;1139.846120773685;1156.658785658216;1193.427154965604;19649.214031438583;19697.310594129136;19727.60544789125;20021.499462513555;20287.79712202859;58069;58461.4153858456;58553.414465854796;59346.40653593409;59515;74081.6295918517;74491;75221.24778752142;75619.62190189013;75898.62050689931;14558.927205363905;14919.92540037293;14930.776038359216;14944.551663450115;14947.476838310607;21853.453663658536;21875.343739687836;22166;22197.556048879254;22248.443788905406;18309.3591724289;18350;18404.07979600988;18528.722069169242;18651;15720.449784257953;15832.92083539575;16243.756343654619;16519.256633451765;16762.99422034682;17959.551011224823;18181;18395;18893.338733144275;19009.23963041518;14451;14586;14600.196989165273;14620.415183392544;14647.853521464649;17557.385491507735;18037.368692095715;18060.54848628795;18260.36088736888;18313.450596482126 04:02:55 INFO - PID 32667 | |3;mootools.html;1329.5811819276928;1391.4225596377503;1391.9652008699782;1392.5474220878214;1405.1849927042317;15289.464868729583;15925.442609508655;15926.920365398171;15975.201239937986;15989.520314390558;15482.61293467664;15515.069095854256;15615.609609759762;15631.687366252669;15636.218189090558;2704.8106632535732;2810.114813833646;2821.830690158597;2823.3506293552496;2825.9152225433268;2739.0824073935255;2755.779537636994;2803.789715771315;2804.383035732136;2804.9859750701216;2786.289496178472;2824.4633519631307;2825.1100903215524;2826.23691603267;2828.193964720055;2717.660292463442;2752.40823223007;2817.281593193743;2820.027090653721;2825.604415381838;2647.7352264773563;2684.932876678079;2687.6237326774267;2693.070890542779;2699.4061306512535;15285.541433757006;15593.142377169252;15646.452374166964;15662.686746265124;15710.371585136581;8180.9590952044855;8347.29048030918;8352.331813454908;8457.95771021147;8465.899433073722;5517.5585953124055;5753.0219862623035;5883.441073098049;5898.852528686817;5915.497182739472;1940.40817550647;1978.6636271833822;1990.442676050708;2019.6465618516702;2033.2680235115347;27775.722242777716;27890.3027424314;27907.581386279224;27909.30226744307;27973.300667483272;6812.48906332027;7005.649717514206;7096.822579435556;7267.927320726725;7271.418286537064;17150.313987440364;17220.569485762706;17241.224144913507;17276;17297.91351043262;7928.6035698214855;8201.671933122727;8214.055383630839;8233.17668233172;8238.176182381834;7260.23767504415;7297.452691048193;7443.8883416748795;7534.886976695354;7539.886901696479;5174.379074511083;5351.9464805351445;5364.302640656768;5365.08793505105;5365.919511207335;1402.7755559110494;1446.096189881324;1501.3319073012406;1533.77760224769;1541.6300087978805;871.7733389318822;881.7663319220412;882.7263548300048;893.7229458867641;900.4327273817453;7925.326347260432;8101.756947291591;8145.6741730331305;8161.551114688749;8200.384971127189;963.7638778499172;972.3242346569208;979.9265055120894;1001.9298649094493;1002.4737013068197;4604.539546045368;4699.78850951708;4730.52694730531;4781.402324709411;5088.491150884956;21935.232266870582;22636.434089147573;22720.20479283217;23027.76972230256;23212;23015.079396823938;23092.4226894329;23142.76857231406;23178.768212318;23187;10443.582256709646;10600.469976501145;10757.946210269056;11006.339619622848;11211.60759373418;8111.797205069921;8170.264676179172;8180.46826956246;8316.542590157358;8358.122397148212;19048.238070477026;19169;19384.2246310146;19678.21287148498;20060.398188054383;19981.500462488555;20131.46384744207;20162.899185504564;20500.077187775187;20838.58322833565;11587.536498539965;11822;11854.644360669194;11871.525138994344;11873.762524749629;13981.44074237019;14060.718785624435;14089.506867259597;14110.294485275901;14261.500847470288;11818.349990750592;11922.821157682469;12002.1598488105;12309.44607492683;12317.322547259628;11415.771684566429;11696.239744416585;11817.822732658846;11848.644540663794;11916.75576220222;10169.288149829441;10211.846822297523;10425.791484170426;10444.843327349943;10452.372857628567;7382.040334756662;7465.6267186641535;7487.288707572772;7499.362554182738;7601.0878694557005;7542.585157816373;7569.924300756922;7601.277878601524;7748.57382843949;7797.259260370256 04:02:55 INFO - PID 32667 | |4;prototype.html;503.7224315704655;507.66240450100685;516.5583426170624;523.9292695486108;527.2276115490805;6307.148534947786;6349.841253968647;6425.421712045915;6458.354164583539;6463.676816159185;6242.625442473455;6280.214973128359;6281.654509002003;6303.779367722131;6378.034214090459;5177;5200.973995130019;5224.7387630618505;5244.816431424901;5276.630635855492;4918.336024636664;5254.264402983586;5284.788608455658;5290.576753859701;5303.204519322113;4942.802287908479;4969.279454479099;4981.327520784684;5009.29869818224;5011.498850114977;4959.429665588467;4996.1756310208775;5005.874853128665;5009.173486374744;5010.674306170124;4410.713303635285;4421.801018954123;4463.955360446386;4477.955220447819;4478.910421791546;6084.482818960394;6138.588124731292;6206.920681571679;6228.750849965996;6253.405926436982;5638.154276858463;5690.7439165237665;5709.457601527848;5742.885142297131;5776.8844623107725;6461;6480.189976252968;6522.173591542272;6526.2494813096155;6594.439472644831;4822.421309442854;4828.106800241966;4851.345068415754;4858.5384388483035;4861.659683822134;6656.334366563354;6756.695948682321;6841.110655614788;6926.238113807477;7020.964895175543;4957.553820156131;4971.2543118531785;4993.80024799004;5045.722485263273;5053.191489361684;5020.59835213182;5032.370953630796;5037.319961805183;5062.569681577033;5113.642045056885;5620.662760234317;5676.687782171937;5697.23087383198;5722.54219662426;5773.6824474654295;6609.636469994197;6614.503912206604;6660.96669516659;6701.698423570951;6746.414592570742;1723.629419674776;1735.8350956659096;1764.4794785538297;1776.8845025073329;1790.937317193918;1139.86013986014;1208.1241100202458;1220.9633710988685;1222.1383924333325;1227.5212667059855;5690.402507736628;5740.913886291709;5766.971165144148;5789.3921138279875;5814.651120932757;6602.504812139013;6644.468442524587;6662;6684.195267277808;6705.161854768154;5610;5629.43705629442;5706.514946229534;5710.600257981984;5730.312362516442;3495.1961048958883;3582.5880023797595;3583.5699716033723;3615.475756015363;3624.52881125452;6384.3934826191435;6426.196725409324;6532.542722009509;6579.967100164468;6593.307702691244;6682.498812589075;6837.222322196265;6890.414314783199;6903.482238832108;6932.341427564374;6079.8480037998515;6374.776882809079;6490.058941453557;6529.575577587441;6587.155596433006;6547;6638.933610664025;6640.76757313511;6670.533062685566;6670.866582668416;6553.868922621617;6600.80197594073;6609.801705948829;6719.563228390139;6752.223494298219;6261.186045814015;6271.592346497463;6305.8108256752375;6371.267304260069;6441.1626488556185;4975.353204083446;4980.153373926513;5007.924881126859;5020.941414020234;5068.695878247317;6437.485001199986;6542.149520562297;6622.933770662232;6645.833854153685;6841.289677580605;6377.7767778127545;6467.773627923;6501.739930402731;6569.835754106186;6584.242812076673;6484.805455836333;6498.545101842826;6522.543421960418;6558.80323590293;6594.901076483952;6440.806775796734;6454.870902581828;6460.935390646034;6462.903056454063;6518;6529.706163222571;6644.667766611747;6708.530402871752;6713.6643167842385;6731.730730770714;6310.990241561328;6346.524010699124;6413.807585772434;6460.900207432509;6498.342922554718 04:02:55 INFO - PID 32667 | |5;yui.html;904.6336233825299;919.6781126605687;921.0605182713637;927.2952556057394;942.1567696911264;19810.900945495287;20920.895395523003;20959.266425675105;20992.790072099273;21123;17355.739663905053;17400.47798566042;17446.214920328584;17610.911945440253;17611.911940440314;922.6125027488438;933.3000249812641;937.0208132501552;937.9437233765962;939.0046550656292;969.9224062075017;972.4019727867346;972.4943029624591;972.5526257921365;974.3910056214866;1000.7798284377461;1028.9022542858415;1040.7242080848544;1043.9582416703322;1044.0186224948561;1032.7108409645236;1033.7467320506448;1034.886162522122;1035.9119474844647;1036.3988886445882;725.1588157737;746.936510396617;746.9514481558681;748.6556184155295;748.7940816275513;20852.687209691867;20921;21022.47443813917;21041.789582104135;21045.052972616268;22196.667049994103;22316.77257750823;22601.32196034105;22988.195413160625;23017.88491057534;18059.458216253402;18547.629047419112;18583.814161858343;18646.53383665419;18651.906740466347;3683.834227459771;3699.426588878728;3704.573973992998;3720.0885782983073;3722.3671975764187;115015;148493.25753371272;150966.24516877456;151533.24233378764;153624;17521.64956700859;17868.55328616795;17906.462806115836;17923.641527169646;17930.282788688568;32154.83922580419;32207.677923220468;32763.836180818944;32770.34459310848;32770.83614581912;8782.692605758768;8897.332700047393;8912.643494260286;8917.598708058153;8939.553022348857;4072.266991941479;4123.670106391482;4184.225918205142;4203.957960420418;4223.873283801429;5627.437256274422;5679.886402271932;5709.571782116358;5728.398518155534;5747.511461525817;1005.9044390782864;1031.8142734307746;1035.4770840725384;1037.962037962038;1043.634727845248;631.4254028833831;643.2634633344794;672.9697163627649;682.6552590941543;687.1410736579276;12495.50017999288;12763.936180319039;12965.416556254992;13595.456181752817;13732.244726540137;696.3036963036963;696.3767428151878;718.396546900606;720.0639169080175;724.2286964382915;5812.505936995318;5876.794312199053;5978.641281523122;6035;6117.724702388403;124225;124262.37868810598;124778.37610811887;126761;127446;99316;104001.47999260106;107555.46222268995;109681.45159274152;113763;97363;98229;99089;100202.4989875046;101431.4928425368;11230.606928757454;11320.547178112784;11337.26307789991;11531.538738450703;11627;45471.77264113658;46672.53327466682;47174.34889778841;47545;47577.52422475731;61919.38080619136;62258;62320.06519902114;62724.68637656783;63660.68169659122;16196.514104576881;16222.51332460028;16255.431059912846;16403.343866245694;16508.504744857673;18024;18156.818431815514;18229.088545572402;18283.81716182821;18370.908145459187;16814.915925420293;16880.409185678443;16895.831041689427;17017.74473382925;17021;16830;17121.315147394464;17152.828471715624;17212.655746885244;17335.82664173342;16782;16914.069726164686;16924.069176195426;17054.14729263507;17072.402465913634;11433.314001159957;11615.941920290345;11900.107491937966;11950.880491194977;11993.460294286604;12675.93662031684;12810.935945320214;12819.551315703906;12823.038272129814;12828.037897157565 04:02:55 INFO - PID 32667 | __end_tp_report 04:02:55 INFO - PID 32667 | __start_cc_report 04:02:55 INFO - PID 32667 | _x_x_mozilla_cycle_collect,297 04:02:55 INFO - PID 32667 | __end_cc_report 04:02:55 INFO - PID 32667 | __startTimestamp1506682975881__endTimestamp 04:02:55 INFO - PID 32667 | 04:02:55 INFO - PID 32667 | ------- Summary: start ------- 04:02:55 INFO - PID 32667 | Number of tests: 6 04:02:55 INFO - PID 32667 | 04:02:55 INFO - PID 32667 | [#0] dojo.html Cycles:165 Average:6342.39 Median:6596.00 stddev:766.21 (11.6%) stddev-sans-first:728.09 04:02:55 INFO - PID 32667 | Values: 3209.9 3236.0 3241.2 3250.3 3254.0 6226.0 6429.4 6429.5 6433.2 6576.1 6338.8 6376.9 6412.5 6461.0 6491.3 5867.8 5902.2 5906.9 5926.8 5991.0 5961.1 6024.2 6028.1 6029.5 6042.2 5929.3 5979.3 6055.8 6068.5 6073.5 5700.1 5807.7 5846.1 5856.1 5899.3 5822.9 5837.4 5883.2 5899.9 5902.4 6133.9 6324.8 6424.9 6501.2 6510.6 6752.3 6770.8 6780.7 6800.3 6823.6 6870.4 6878.8 6890.6 6991.0 6994.3 6405.2 6475.4 6496.1 6499.5 6502.9 7029.2 7107.8 7138.9 7209.9 7240.5 6630.8 6715.9 6728.2 6792.0 6813.4 6870.8 6883.7 6990.9 7002.5 7013.3 6855.4 6873.5 6913.9 6932.3 6948.6 6694.4 6907.1 6928.1 7004.6 7014.2 5341.9 5375.1 5396.2 5401.9 5414.2 4718.9 4734.9 4777.5 4784.6 4809.9 5891.4 5902.9 5905.2 5991.2 6004.5 6919.2 6966.0 7015.4 7038.9 7055.0 5756.2 5825.4 5826.1 5915.2 5920.1 5895.4 5953.1 5955.7 5964.7 5969.9 6621.0 6642.4 6714.3 6719.7 6721.5 6896.7 6918.3 6918.6 7013.9 7016.2 6468.0 6586.5 6604.8 6634.6 6637.6 6726.4 6807.0 6808.9 6813.9 6830.1 6957.3 7009.2 7016.3 7035.3 7057.8 6682.6 6685.6 6773.5 6786.1 6794.0 6552.1 6660.0 6667.3 6689.7 6785.8 6511.2 6573.5 6602.9 6607.1 6714.6 6765.1 6814.7 6849.6 6861.4 6863.9 6522.4 6549.9 6596.0 6643.3 6665.1 04:02:55 INFO - PID 32667 | 04:02:55 INFO - PID 32667 | [#1] ext.html Cycles:180 Average:38186.65 Median:3639.18 stddev:54141.89 (1487.7%) stddev-sans-first:54221.25 04:02:55 INFO - PID 32667 | Values: 865.2 886.9 887.7 892.0 895.0 39545.8 42881.0 43247.0 43251.0 43317.6 39042.6 39393.0 39425.4 39426.8 39435.0 7081.0 7199.9 7207.6 7793.6 8115.1 7967.8 8100.6 8102.5 8104.1 8106.8 8011.1 8023.5 8045.3 8067.3 8082.3 8035.6 8044.2 8044.4 8080.2 8084.5 7876.8 7887.8 7928.6 7947.9 7957.4 39053.2 39169.2 39252.4 39314.0 39400.6 3582.5 3635.8 3642.6 3644.2 3645.6 32129.4 32260.2 32277.8 32347.8 32365.4 5254.9 5288.1 5325.2 5327.6 5346.0 198539.0 199144.0 200355.0 200361.0 200571.0 43833.0 44325.6 51041.5 51200.5 51284.7 53212.0 53879.5 54397.0 54422.7 54423.5 16581.3 16587.8 16730.3 16747.3 16755.9 13617.8 13665.1 13673.8 13676.6 13678.0 14773.8 14830.7 14839.3 14879.3 14964.8 5801.9 5933.6 5945.7 5974.9 5977.2 987.6 987.9 1010.6 1012.2 1023.8 23190.3 23225.5 23376.5 23472.3 23686.2 1104.6 1125.5 1126.4 1128.7 1130.8 12259.7 12466.4 12487.6 12509.2 12534.8 211429.0 226292.0 234338.0 235765.0 236147.0 54116.5 54117.7 54262.5 54307.0 54308.5 1423.9 1471.7 1481.6 1486.3 1494.7 22961.9 23026.5 23041.7 23093.3 23218.9 38682.4 38798.0 38846.6 38871.0 38884.2 196602.0 196887.0 197025.0 197171.0 197627.0 31711.5 32106.5 35061.3 35145.6 35346.1 44898.8 44944.0 45060.5 45321.5 45345.3 32298.0 32869.3 32873.8 33004.3 33155.0 32600.7 32610.7 32622.0 33057.3 33613.3 35546.6 36682.4 36863.6 37061.4 37076.0 31395.0 31927.4 31946.8 31970.2 32139.7 23658.8 23883.6 24027.8 24140.3 24430.9 04:02:55 INFO - PID 32667 | 04:02:55 INFO - PID 32667 | [#2] jquery.html Cycles:180 Average:34905.71 Median:22820.10 stddev:83730.92 (366.9%) stddev-sans-first:83926.17 04:02:55 INFO - PID 32667 | Values: 591.8 596.6 602.4 604.3 620.3 22029.7 22799.3 22840.9 22852.5 22881.5 23722.3 24941.3 25278.6 25435.4 25514.2 6453.9 6639.5 6642.7 6649.4 6663.8 6125.4 6533.6 6554.8 6569.2 6616.6 6310.4 6356.7 6356.9 6373.4 6373.4 6384.9 6395.8 6399.0 6401.6 6401.9 5914.9 5973.6 6139.4 6140.7 6145.1 27616.6 28100.6 28182.4 28193.4 28194.0 2038.7 2059.3 2064.2 2068.5 2082.8 18616.5 18669.0 18868.2 18927.5 19765.2 2448.1 2476.2 2496.2 2543.8 2548.2 123709.4 129769.0 135331.0 141673.0 141856.0 14804.0 14877.4 15009.0 15093.0 15715.6 23481.2 23556.3 23581.0 23597.4 23636.9 10074.3 10182.0 10252.2 10254.1 10256.7 9363.3 9402.9 9484.9 9508.2 9528.7 8908.5 9254.9 9289.8 9356.2 9555.5 2638.1 2647.9 2657.6 2705.6 2826.2 914.9 955.4 962.2 971.8 975.1 19057.6 19196.6 19501.6 19534.0 19641.1 998.7 1020.7 1023.6 1038.1 1041.6 10652.6 10801.7 10805.0 10856.6 10947.7 484921.0 497936.0 499143.0 504682.0 505219.0 110135.0 110399.0 110645.0 114222.0 114409.0 1045.1 1081.9 1139.8 1156.7 1193.4 19649.2 19697.3 19727.6 20021.5 20287.8 58069.0 58461.4 58553.4 59346.4 59515.0 74081.6 74491.0 75221.2 75619.6 75898.6 14558.9 14919.9 14930.8 14944.6 14947.5 21853.5 21875.3 22166.0 22197.6 22248.4 18309.4 18350.0 18404.1 18528.7 18651.0 15720.4 15832.9 16243.8 16519.3 16763.0 17959.6 18181.0 18395.0 18893.3 19009.2 14451.0 14586.0 14600.2 14620.4 14647.9 17557.4 18037.4 18060.5 18260.4 18313.5 04:02:55 INFO - PID 32667 | 04:02:55 INFO - PID 32667 | [#3] mootools.html Cycles:180 Average:9655.14 Median:2696.24 stddev:7023.80 (260.5%) stddev-sans-first:7015.65 04:02:55 INFO - PID 32667 | Values: 1329.6 1391.4 1392.0 1392.5 1405.2 15289.5 15925.4 15926.9 15975.2 15989.5 15482.6 15515.1 15615.6 15631.7 15636.2 2704.8 2810.1 2821.8 2823.4 2825.9 2739.1 2755.8 2803.8 2804.4 2805.0 2786.3 2824.5 2825.1 2826.2 2828.2 2717.7 2752.4 2817.3 2820.0 2825.6 2647.7 2684.9 2687.6 2693.1 2699.4 15285.5 15593.1 15646.5 15662.7 15710.4 8181.0 8347.3 8352.3 8458.0 8465.9 5517.6 5753.0 5883.4 5898.9 5915.5 1940.4 1978.7 1990.4 2019.6 2033.3 27775.7 27890.3 27907.6 27909.3 27973.3 6812.5 7005.6 7096.8 7267.9 7271.4 17150.3 17220.6 17241.2 17276.0 17297.9 7928.6 8201.7 8214.1 8233.2 8238.2 7260.2 7297.5 7443.9 7534.9 7539.9 5174.4 5351.9 5364.3 5365.1 5365.9 1402.8 1446.1 1501.3 1533.8 1541.6 871.8 881.8 882.7 893.7 900.4 7925.3 8101.8 8145.7 8161.6 8200.4 963.8 972.3 979.9 1001.9 1002.5 4604.5 4699.8 4730.5 4781.4 5088.5 21935.2 22636.4 22720.2 23027.8 23212.0 23015.1 23092.4 23142.8 23178.8 23187.0 10443.6 10600.5 10757.9 11006.3 11211.6 8111.8 8170.3 8180.5 8316.5 8358.1 19048.2 19169.0 19384.2 19678.2 20060.4 19981.5 20131.5 20162.9 20500.1 20838.6 11587.5 11822.0 11854.6 11871.5 11873.8 13981.4 14060.7 14089.5 14110.3 14261.5 11818.3 11922.8 12002.2 12309.4 12317.3 11415.8 11696.2 11817.8 11848.6 11916.8 10169.3 10211.8 10425.8 10444.8 10452.4 7382.0 7465.6 7487.3 7499.4 7601.1 7542.6 7569.9 7601.3 7748.6 7797.3 04:02:55 INFO - PID 32667 | 04:02:55 INFO - PID 32667 | [#4] prototype.html Cycles:180 Average:5522.57 Median:6248.02 stddev:1541.29 (24.7%) stddev-sans-first:1498.87 04:02:55 INFO - PID 32667 | Values: 503.7 507.7 516.6 523.9 527.2 6307.1 6349.8 6425.4 6458.4 6463.7 6242.6 6280.2 6281.7 6303.8 6378.0 5177.0 5201.0 5224.7 5244.8 5276.6 4918.3 5254.3 5284.8 5290.6 5303.2 4942.8 4969.3 4981.3 5009.3 5011.5 4959.4 4996.2 5005.9 5009.2 5010.7 4410.7 4421.8 4464.0 4478.0 4478.9 6084.5 6138.6 6206.9 6228.8 6253.4 5638.2 5690.7 5709.5 5742.9 5776.9 6461.0 6480.2 6522.2 6526.2 6594.4 4822.4 4828.1 4851.3 4858.5 4861.7 6656.3 6756.7 6841.1 6926.2 7021.0 4957.6 4971.3 4993.8 5045.7 5053.2 5020.6 5032.4 5037.3 5062.6 5113.6 5620.7 5676.7 5697.2 5722.5 5773.7 6609.6 6614.5 6661.0 6701.7 6746.4 1723.6 1735.8 1764.5 1776.9 1790.9 1139.9 1208.1 1221.0 1222.1 1227.5 5690.4 5740.9 5767.0 5789.4 5814.7 6602.5 6644.5 6662.0 6684.2 6705.2 5610.0 5629.4 5706.5 5710.6 5730.3 3495.2 3582.6 3583.6 3615.5 3624.5 6384.4 6426.2 6532.5 6580.0 6593.3 6682.5 6837.2 6890.4 6903.5 6932.3 6079.8 6374.8 6490.1 6529.6 6587.2 6547.0 6638.9 6640.8 6670.5 6670.9 6553.9 6600.8 6609.8 6719.6 6752.2 6261.2 6271.6 6305.8 6371.3 6441.2 4975.4 4980.2 5007.9 5020.9 5068.7 6437.5 6542.1 6622.9 6645.8 6841.3 6377.8 6467.8 6501.7 6569.8 6584.2 6484.8 6498.5 6522.5 6558.8 6594.9 6440.8 6454.9 6460.9 6462.9 6518.0 6529.7 6644.7 6708.5 6713.7 6731.7 6311.0 6346.5 6413.8 6460.9 6498.3 04:02:55 INFO - PID 32667 | 04:02:55 INFO - PID 32667 | [#5] yui.html Cycles:180 Average:25189.22 Median:19231.40 stddev:36199.69 (188.2%) stddev-sans-first:36255.31 04:02:55 INFO - PID 32667 | Values: 904.6 919.7 921.1 927.3 942.2 19810.9 20920.9 20959.3 20992.8 21123.0 17355.7 17400.5 17446.2 17610.9 17611.9 922.6 933.3 937.0 937.9 939.0 969.9 972.4 972.5 972.6 974.4 1000.8 1028.9 1040.7 1044.0 1044.0 1032.7 1033.7 1034.9 1035.9 1036.4 725.2 746.9 747.0 748.7 748.8 20852.7 20921.0 21022.5 21041.8 21045.1 22196.7 22316.8 22601.3 22988.2 23017.9 18059.5 18547.6 18583.8 18646.5 18651.9 3683.8 3699.4 3704.6 3720.1 3722.4 115015.0 148493.3 150966.2 151533.2 153624.0 17521.6 17868.6 17906.5 17923.6 17930.3 32154.8 32207.7 32763.8 32770.3 32770.8 8782.7 8897.3 8912.6 8917.6 8939.6 4072.3 4123.7 4184.2 4204.0 4223.9 5627.4 5679.9 5709.6 5728.4 5747.5 1005.9 1031.8 1035.5 1038.0 1043.6 631.4 643.3 673.0 682.7 687.1 12495.5 12763.9 12965.4 13595.5 13732.2 696.3 696.4 718.4 720.1 724.2 5812.5 5876.8 5978.6 6035.0 6117.7 124225.0 124262.4 124778.4 126761.0 127446.0 99316.0 104001.5 107555.5 109681.5 113763.0 97363.0 98229.0 99089.0 100202.5 101431.5 11230.6 11320.5 11337.3 11531.5 11627.0 45471.8 46672.5 47174.3 47545.0 47577.5 61919.4 62258.0 62320.1 62724.7 63660.7 16196.5 16222.5 16255.4 16403.3 16508.5 18024.0 18156.8 18229.1 18283.8 18370.9 16814.9 16880.4 16895.8 17017.7 17021.0 16830.0 17121.3 17152.8 17212.7 17335.8 16782.0 16914.1 16924.1 17054.1 17072.4 11433.3 11615.9 11900.1 11950.9 11993.5 12675.9 12810.9 12819.6 12823.0 12828.0 04:02:55 INFO - PID 32667 | -------- Summary: end -------- 04:02:55 INFO - PID 32667 | 04:02:56 INFO - TEST-INFO | 32667: exit 0 04:02:56 INFO - TEST-OK | dromaeo_css | took 1109839ms 04:02:56 INFO - TEST-START | kraken 04:02:56 INFO - Initialising browser for kraken test... 04:02:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47336/getInfo.html -profile /tmp/tmpcWPmlW/profile 04:02:56 INFO - TEST-INFO | started process 563 (/builds/slave/test/build/application/firefox/firefox http://localhost:47336/getInfo.html) 04:03:02 INFO - TEST-INFO | 563: exit 0 04:03:02 INFO - Browser initialized. 04:03:02 INFO - Running cycle 1/1 for kraken test... 04:03:02 INFO - Using env: {'DISPLAY': ':0', 04:03:02 INFO - 'HOME': '/home/cltbld', 04:03:02 INFO - 'JSGC_DISABLE_POISONING': '1', 04:03:02 INFO - 'LANG': 'en_US.UTF-8', 04:03:02 INFO - 'LANGUAGE': 'en_US:en', 04:03:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:03:02 INFO - 'LOGNAME': 'cltbld', 04:03:02 INFO - 'MAIL': '/var/mail/cltbld', 04:03:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:03:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:03:02 INFO - 'MOZ_CRASHREPORTER': '1', 04:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:03:02 INFO - 'MOZ_NO_REMOTE': '1', 04:03:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:02 INFO - 'NO_EM_RESTART': '1', 04:03:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:02 INFO - 'PWD': '/builds/slave/test', 04:03:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:03:02 INFO - 'RUST_BACKTRACE': 'full', 04:03:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:03:02 INFO - 'SHELL': '/bin/bash', 04:03:02 INFO - 'SHLVL': '1', 04:03:02 INFO - 'STYLO_FORCE_DISABLED': '1', 04:03:02 INFO - 'TERM': 'linux', 04:03:02 INFO - 'TMOUT': '86400', 04:03:02 INFO - 'USER': 'cltbld', 04:03:02 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857', 04:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:02 INFO - '_': '/tools/buildbot/bin/python'} 04:03:02 INFO - TEST-INFO | started process 805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcWPmlW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:03 INFO - PID 805 | 04:03:03 INFO - PID 805 | (/builds/slave/test/build/application/firefox/firefox:861): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:03:03 INFO - PID 805 | 04:03:13 INFO - PID 805 | RSS: Main: 151207936 04:03:13 INFO - PID 805 | 04:03:16 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47336/tests/kraken/driver.html?testName=audio-beat-detection) 04:03:17 INFO - PID 805 | RSS: Main: 157884416 04:03:17 INFO - PID 805 | 04:03:19 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47336/tests/kraken/driver.html?testName=audio-dft) 04:03:20 INFO - PID 805 | RSS: Main: 158142464 04:03:20 INFO - PID 805 | 04:03:23 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47336/tests/kraken/driver.html?testName=audio-fft) 04:03:24 INFO - PID 805 | RSS: Main: 154685440 04:03:24 INFO - PID 805 | 04:03:26 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47336/tests/kraken/driver.html?testName=audio-oscillator) 04:03:26 INFO - PID 805 | RSS: Main: 155729920 04:03:26 INFO - PID 805 | 04:03:29 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47336/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:03:29 INFO - PID 805 | RSS: Main: 155283456 04:03:29 INFO - PID 805 | 04:03:32 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47336/tests/kraken/driver.html?testName=imaging-darkroom) 04:03:33 INFO - PID 805 | RSS: Main: 157593600 04:03:33 INFO - PID 805 | 04:03:37 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47336/tests/kraken/driver.html?testName=imaging-desaturate) 04:03:37 INFO - PID 805 | RSS: Main: 158089216 04:03:37 INFO - PID 805 | 04:03:40 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47336/tests/kraken/driver.html?testName=json-parse-financial) 04:03:41 INFO - PID 805 | RSS: Main: 158351360 04:03:41 INFO - PID 805 | 04:03:42 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47336/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:03:43 INFO - PID 805 | RSS: Main: 157614080 04:03:43 INFO - PID 805 | 04:03:45 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47336/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:03:45 INFO - PID 805 | RSS: Main: 155009024 04:03:45 INFO - PID 805 | 04:03:47 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47336/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:03:48 INFO - PID 805 | RSS: Main: 155385856 04:03:48 INFO - PID 805 | 04:03:51 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:03:51 INFO - PID 805 | RSS: Main: 155271168 04:03:51 INFO - PID 805 | 04:03:54 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:03:55 INFO - PID 805 | RSS: Main: 155369472 04:03:55 INFO - PID 805 | 04:03:57 INFO - PID 805 | Cycle 1(1): loaded http://localhost:47336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47336/tests/kraken/driver.html?testName=ai-astar) 04:03:57 INFO - PID 805 | RSS: Main: 156790784 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | __start_tp_report 04:03:57 INFO - PID 805 | _x_x_mozilla_page_load 04:03:57 INFO - PID 805 | _x_x_mozilla_page_load_details 04:03:57 INFO - PID 805 | |i|pagename|runs| 04:03:57 INFO - PID 805 | |0;ai-astar;107;106;106;107;106;96;108;106;106;106 04:03:57 INFO - PID 805 | |1;audio-beat-detection;124;116;116;116;116;118;119;118;117;119 04:03:57 INFO - PID 805 | |2;audio-dft;163;164;166;163;162;162;163;166;168;167 04:03:57 INFO - PID 805 | |3;audio-fft;73;78;74;75;73;75;73;73;74;74 04:03:57 INFO - PID 805 | |4;audio-oscillator;80;80;83;84;80;78;78;79;89;79 04:03:57 INFO - PID 805 | |5;imaging-gaussian-blur;112;112;117;112;117;112;113;114;112;116 04:03:57 INFO - PID 805 | |6;imaging-darkroom;149;149;149;148;151;149;149;149;147;148 04:03:57 INFO - PID 805 | |7;imaging-desaturate;96;94;94;94;94;93;94;94;96;94 04:03:57 INFO - PID 805 | |8;json-parse-financial;51;54;51;51;53;54;53;53;52;51 04:03:57 INFO - PID 805 | |9;json-stringify-tinderbox;37;37;37;37;37;37;42;36;37;36 04:03:57 INFO - PID 805 | |10;stanford-crypto-aes;76;76;75;75;74;78;73;74;74;76 04:03:57 INFO - PID 805 | |11;stanford-crypto-ccm;110;116;113;112;112;117;109;119;107;115 04:03:57 INFO - PID 805 | |12;stanford-crypto-pbkdf2;161;164;161;178;164;166;161;159;161;168 04:03:57 INFO - PID 805 | |13;stanford-crypto-sha256-iterative;68;67;66;65;66;70;68;69;64;65 04:03:57 INFO - PID 805 | __end_tp_report 04:03:57 INFO - PID 805 | __start_cc_report 04:03:57 INFO - PID 805 | _x_x_mozilla_cycle_collect,758 04:03:57 INFO - PID 805 | __end_cc_report 04:03:57 INFO - PID 805 | __startTimestamp1506683037279__endTimestamp 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | ------- Summary: start ------- 04:03:57 INFO - PID 805 | Number of tests: 14 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#0] ai-astar Cycles:10 Average:105.40 Median:106.50 stddev:3.37 (3.2%) stddev-sans-first:3.53 04:03:57 INFO - PID 805 | Values: 107.0 106.0 106.0 107.0 106.0 96.0 108.0 106.0 106.0 106.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:118.00 stddev:2.47 (2.1%) stddev-sans-first:1.30 04:03:57 INFO - PID 805 | Values: 124.0 116.0 116.0 116.0 116.0 118.0 119.0 118.0 117.0 119.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.17 (1.3%) stddev-sans-first:2.24 04:03:57 INFO - PID 805 | Values: 163.0 164.0 166.0 163.0 162.0 162.0 163.0 166.0 168.0 167.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.00 stddev:1.55 (2.1%) stddev-sans-first:1.58 04:03:57 INFO - PID 805 | Values: 73.0 78.0 74.0 75.0 73.0 75.0 73.0 73.0 74.0 74.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#4] audio-oscillator Cycles:10 Average:81.00 Median:80.00 stddev:3.43 (4.3%) stddev-sans-first:3.62 04:03:57 INFO - PID 805 | Values: 80.0 80.0 83.0 84.0 80.0 78.0 78.0 79.0 89.0 79.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:113.50 stddev:2.16 (1.9%) stddev-sans-first:2.20 04:03:57 INFO - PID 805 | Values: 112.0 112.0 117.0 112.0 117.0 112.0 113.0 114.0 112.0 116.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 04:03:57 INFO - PID 805 | Values: 149.0 149.0 149.0 148.0 151.0 149.0 149.0 149.0 147.0 148.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.95 (1.0%) stddev-sans-first:0.78 04:03:57 INFO - PID 805 | Values: 96.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 96.0 94.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:53.00 stddev:1.25 (2.4%) stddev-sans-first:1.24 04:03:57 INFO - PID 805 | Values: 51.0 54.0 51.0 51.0 53.0 54.0 53.0 53.0 52.0 51.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:1.70 (4.6%) stddev-sans-first:1.80 04:03:57 INFO - PID 805 | Values: 37.0 37.0 37.0 37.0 37.0 37.0 42.0 36.0 37.0 36.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.50 stddev:1.45 (1.9%) stddev-sans-first:1.50 04:03:57 INFO - PID 805 | Values: 76.0 76.0 75.0 75.0 74.0 78.0 73.0 74.0 74.0 76.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#11] stanford-crypto-ccm Cycles:10 Average:113.00 Median:114.00 stddev:3.77 (3.3%) stddev-sans-first:3.84 04:03:57 INFO - PID 805 | Values: 110.0 116.0 113.0 112.0 112.0 117.0 109.0 119.0 107.0 115.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.00 stddev:5.54 (3.4%) stddev-sans-first:5.74 04:03:57 INFO - PID 805 | Values: 161.0 164.0 161.0 178.0 164.0 166.0 161.0 159.0 161.0 168.0 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.93 (2.9%) stddev-sans-first:2.00 04:03:57 INFO - PID 805 | Values: 68.0 67.0 66.0 65.0 66.0 70.0 68.0 69.0 64.0 65.0 04:03:57 INFO - PID 805 | -------- Summary: end -------- 04:03:57 INFO - PID 805 | 04:03:57 INFO - PID 805 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:03:57 INFO - TEST-INFO | 805: exit 0 04:03:57 INFO - TEST-OK | kraken | took 61297ms 04:03:57 INFO - SUITE-END | took 1171s 04:03:57 INFO - Completed test suite (00:19:31) 04:03:57 INFO - javascript benchmark 04:03:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8655.65368805383, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3209.9197520061994, 3235.9676403235962, 3241.222106694391, 3250.268689544853, 3254.023792862141, 6226.0, 6429.421352078312, 6429.485641148709, 6433.228012638484, 6576.1122248496495, 6338.841528961778, 6376.9362306376925, 6412.519061070427, 6461.0, 6491.2535058468175, 5867.823965281027, 5902.203202567652, 5906.940930590682, 5926.792562260322, 5991.0, 5961.076033214837, 6024.1566180734735, 6028.125921741344, 6029.457348838604, 6042.244719410074, 5929.258842644669, 5979.252593425822, 6055.848603784896, 6068.514518838504, 6073.514118870502, 5700.059490184156, 5807.709614519257, 5846.064629659234, 5856.092305692582, 5899.2920849497905, 5822.941770582324, 5837.387074357174, 5883.205767221413, 5899.941000589982, 5902.409759024106, 6133.907991380132, 6324.778632747878, 6424.903626445607, 6501.219853617549, 6510.609363438209, 6752.324767523258, 6770.8307292317595, 6780.660966951633, 6800.285969973131, 6823.590584564942, 6870.416014638762, 6878.759243426506, 6890.621015844126, 6990.965045174792, 6994.33553812387, 6405.231372235315, 6475.384838440341, 6496.090547323379, 6499.480041596708, 6502.93497065028, 7029.211088471951, 7107.75122870697, 7138.9286107139305, 7209.855802883913, 7240.4569657275915, 6630.834229144213, 6715.932840671629, 6728.158980127484, 6791.966040169867, 6813.3527314905, 6870.828229294208, 6883.65581720922, 6990.895136572955, 7002.474814388941, 7013.298670133048, 6855.383015528626, 6873.48448866337, 6913.861722765517, 6932.341427564374, 6948.6178260196175, 6694.397504224546, 6907.067545881242, 6928.064711264015, 7004.614746188907, 7014.158301003912, 5341.86645333862, 5375.086235340002, 5396.217548455452, 5401.864953376197, 5414.18787181918, 4718.9292160617615, 4734.928976065362, 4777.474477807438, 4784.617230621542, 4809.879753006203, 5891.3814049525035, 5902.940970590325, 5905.173275741399, 5991.191189189403, 6004.519638428916, 6919.238883722786, 6965.965170174117, 7015.438764898796, 7038.859222815618, 7054.964725176341, 5756.222909907193, 5825.446582574648, 5826.126081087871, 5915.1718759373725, 5920.141579470953, 5895.410458954156, 5953.136795164677, 5955.672438015864, 5964.701764911737, 5969.940300597025, 6621.0, 6642.43539299165, 6714.29499902513, 6719.697613607399, 6721.529492935545, 6896.689648965909, 6918.273581273894, 6918.619475928772, 7013.859722805618, 7016.19313778922, 6468.029795530708, 6586.5389422739945, 6604.768833090819, 6634.635095069624, 6637.6349300788925, 6726.3609957054005, 6806.965965170142, 6808.897866531907, 6813.89779153323, 6830.146231721035, 6957.339052789976, 7009.1589009319205, 7016.26329235423, 7035.261297563887, 7057.823554411181, 6682.599044057372, 6685.565438246693, 6773.525853190229, 6786.083878676315, 6794.0, 6552.082708420729, 6660.034295027291, 6667.299933506912, 6689.665516724242, 6785.830354240986, 6511.153550038464, 6573.474122070127, 6602.933970660232, 6607.108040414482, 6714.630695311609, 6765.1205343305055, 6814.727410903508, 6849.554778939353, 6861.382475577222, 6863.931360686329, 6522.380373864476, 6549.869002619826, 6596.0, 6643.335666433318, 6665.13353264092], "value": 6283.838549848235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.1607940297911, 886.9246114080303, 887.7026196224268, 892.0455113029053, 894.9597268122934, 39545.80227098864, 42881.0, 43247.0, 43251.0, 43317.56682433175, 39042.60957390425, 39393.0, 39425.40861887074, 39426.80286598563, 39435.0141246469, 7081.044059052039, 7199.89200161998, 7207.639618019104, 7793.649285782125, 8115.066767321775, 7967.840643187133, 8100.554469504175, 8102.473339232931, 8104.068032176317, 8106.837863242732, 8011.078725946532, 8023.518588884656, 8045.275925166734, 8067.314278286352, 8082.2725954664065, 8035.55804430762, 8044.155363686817, 8044.3966702497255, 8080.151584083704, 8084.5149291042135, 7876.842463150762, 7887.763367098996, 7928.563928983961, 7947.920520794776, 7957.442978991473, 39053.21893562113, 39169.21661566753, 39252.411213831816, 39314.0, 39400.60599393998, 3582.498450216972, 3635.763675361093, 3642.5993140754495, 3644.21649345392, 3645.5989841117457, 32129.357412851612, 32260.193495162574, 32277.83861080703, 32347.83826080878, 32365.352692946246, 5254.92117618236, 5288.0745869472685, 5325.174597937326, 5327.627066105374, 5346.0, 198539.0, 199144.0, 200355.0, 200360.99999999854, 200570.9971450148, 43833.0, 44325.55674443214, 51041.48958510441, 51200.48799512032, 51284.74357628188, 53212.0, 53879.46120538823, 54397.0, 54422.72788636031, 54423.45576544263, 16581.336746530244, 16587.83412165863, 16730.330786768394, 16747.330106795835, 16755.916220419065, 13617.795733064011, 13665.111767735065, 13673.794893076612, 13676.589702308947, 13678.0, 14773.778393324108, 14830.70338593222, 14839.258037098318, 14879.256037198096, 14964.775528367083, 5801.854953626109, 5933.584649074523, 5945.732442040118, 5974.85062873423, 5977.193078934288, 987.5950860147449, 987.916027137687, 1010.5604062232952, 1012.2155329619457, 1023.8208313545249, 23190.3042908713, 23225.535489290458, 23376.532469350517, 23472.295831125095, 23686.170984015476, 1104.6465131157952, 1125.5047778977223, 1126.4424110065406, 1128.7347473343757, 1130.7964566377966, 12259.69350766238, 12466.376681165906, 12487.562935297403, 12509.249445033327, 12534.81197782034, 211429.0, 226292.0, 234338.0, 235765.0, 236147.0, 54116.45883541114, 54117.72941135269, 54262.45737542653, 54307.0, 54308.45691543034, 1423.871851533367, 1471.6762312291278, 1481.6147801571453, 1486.294010345099, 1494.6562290673205, 22961.88519057394, 23026.539469210857, 23041.65437518405, 23093.268004899364, 23218.883905580366, 38682.41976370413, 38798.03004924899, 38846.6115338843, 38871.0, 38884.2223155541, 196602.0, 196887.0, 197025.0, 197171.0, 197627.0, 31711.524327135572, 32106.51840222352, 35061.29877402387, 35145.64854351424, 35346.05596692207, 44898.77550612226, 44944.0, 45060.54939450695, 45321.54678453173, 45345.319820202065, 32298.0, 32869.34261314713, 32873.83563082169, 33004.33991320208, 33155.0, 32600.673993259763, 32610.673893260762, 32622.0, 33057.33885322232, 33613.32773344568, 35546.64453355433, 36682.44976325304, 36863.63136368602, 37061.44407833831, 37076.0, 31395.0, 31927.36145277035, 31946.840265799452, 31970.20074498156, 32139.67860321367, 23658.763412365657, 23883.641745373487, 24027.759722402552, 24140.275791726275, 24430.87784561066], "value": 17513.586079715053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8342863998082, 596.6241268001164, 602.3616559469523, 604.3110853626863, 620.2928661326089, 22029.66955495669, 22799.31602051937, 22840.88579557102, 22852.542949141007, 22881.54236915265, 23722.288331350042, 24941.25176244711, 25278.620820687705, 25435.364115897064, 25514.234572962796, 6453.903191452132, 6639.535232533724, 6642.734290628369, 6649.368310010541, 6663.833404164886, 6125.418085281891, 6533.640649764261, 6554.7705830295945, 6569.211694596655, 6616.569922954993, 6310.368963103699, 6356.745730170811, 6356.904646430284, 6373.362663733636, 6373.3945275198785, 6384.936150638504, 6395.8401039973905, 6399.008153736178, 6401.551891367606, 6401.9359806402035, 5914.940850591482, 5973.611715238496, 6139.355367686373, 6140.723667434976, 6145.139680444697, 27616.585751213748, 28100.578491322645, 28182.436351273063, 28193.436131277464, 28194.0, 2038.7043878637514, 2059.2792522617115, 2064.1743302678897, 2068.5449201175716, 2082.79172082792, 18616.534586635305, 18669.0, 18868.1509332079, 18927.526811829677, 19765.209391624318, 2448.09420514409, 2476.182859656309, 2496.188738659943, 2543.7583429574347, 2548.2227920484247, 123709.38145309305, 129769.0, 135331.0, 141673.0, 141856.0, 14804.001459802788, 14877.404903803943, 15009.0, 15093.0, 15715.607109822346, 23481.17815876436, 23556.29331120069, 23581.0, 23597.410064748517, 23636.881815590812, 10074.345167564084, 10182.0, 10252.179825614083, 10254.077133058061, 10256.692299231036, 9363.25093992479, 9402.858957115648, 9484.90515094854, 9508.239340852715, 9528.714138575853, 8908.510031948304, 9254.907450925404, 9289.767755806024, 9356.204722598655, 9555.474448905377, 2638.14260365382, 2647.880845361963, 2657.5747880339054, 2705.621213030138, 2826.1804076817903, 914.8719179314901, 955.3790036476346, 962.153305091515, 971.8007808399261, 975.0693626619334, 19057.618847623246, 19196.61606767857, 19501.609967800563, 19534.0, 19641.116149773294, 998.6904059741504, 1020.7039958411978, 1023.6212601337553, 1038.08129805123, 1041.5729550884253, 10652.573897044187, 10801.67594972152, 10805.02754752076, 10856.620018299322, 10947.671569852917, 484921.0, 497936.0, 499143.0, 504682.0, 505219.0, 110135.0, 110399.0, 110645.0, 114222.0, 114409.0, 1045.0646671229208, 1081.9296745711504, 1139.846120773685, 1156.658785658216, 1193.427154965604, 19649.214031438583, 19697.310594129136, 19727.60544789125, 20021.499462513555, 20287.79712202859, 58069.0, 58461.4153858456, 58553.414465854796, 59346.40653593409, 59515.0, 74081.6295918517, 74491.0, 75221.24778752142, 75619.62190189013, 75898.62050689931, 14558.927205363905, 14919.92540037293, 14930.776038359216, 14944.551663450115, 14947.476838310607, 21853.453663658536, 21875.343739687836, 22166.0, 22197.556048879254, 22248.443788905406, 18309.3591724289, 18350.0, 18404.07979600988, 18528.722069169242, 18651.0, 15720.449784257953, 15832.92083539575, 16243.756343654619, 16519.256633451765, 16762.99422034682, 17959.551011224823, 18181.0, 18395.0, 18893.338733144275, 19009.23963041518, 14451.0, 14586.0, 14600.196989165273, 14620.415183392544, 14647.853521464649, 17557.385491507735, 18037.368692095715, 18060.54848628795, 18260.36088736888, 18313.450596482126], "value": 11954.906289999992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.5811819276928, 1391.4225596377503, 1391.9652008699782, 1392.5474220878214, 1405.1849927042317, 15289.464868729583, 15925.442609508655, 15926.920365398171, 15975.201239937986, 15989.520314390558, 15482.61293467664, 15515.069095854256, 15615.609609759762, 15631.687366252669, 15636.218189090558, 2704.8106632535732, 2810.114813833646, 2821.830690158597, 2823.3506293552496, 2825.9152225433268, 2739.0824073935255, 2755.779537636994, 2803.789715771315, 2804.383035732136, 2804.9859750701216, 2786.289496178472, 2824.4633519631307, 2825.1100903215524, 2826.23691603267, 2828.193964720055, 2717.660292463442, 2752.40823223007, 2817.281593193743, 2820.027090653721, 2825.604415381838, 2647.7352264773563, 2684.932876678079, 2687.6237326774267, 2693.070890542779, 2699.4061306512535, 15285.541433757006, 15593.142377169252, 15646.452374166964, 15662.686746265124, 15710.371585136581, 8180.9590952044855, 8347.29048030918, 8352.331813454908, 8457.95771021147, 8465.899433073722, 5517.5585953124055, 5753.0219862623035, 5883.441073098049, 5898.852528686817, 5915.497182739472, 1940.40817550647, 1978.6636271833822, 1990.442676050708, 2019.6465618516702, 2033.2680235115347, 27775.722242777716, 27890.3027424314, 27907.581386279224, 27909.30226744307, 27973.300667483272, 6812.48906332027, 7005.649717514206, 7096.822579435556, 7267.927320726725, 7271.418286537064, 17150.313987440364, 17220.569485762706, 17241.224144913507, 17276.0, 17297.91351043262, 7928.6035698214855, 8201.671933122727, 8214.055383630839, 8233.17668233172, 8238.176182381834, 7260.23767504415, 7297.452691048193, 7443.8883416748795, 7534.886976695354, 7539.886901696479, 5174.379074511083, 5351.9464805351445, 5364.302640656768, 5365.08793505105, 5365.919511207335, 1402.7755559110494, 1446.096189881324, 1501.3319073012406, 1533.77760224769, 1541.6300087978805, 871.7733389318822, 881.7663319220412, 882.7263548300048, 893.7229458867641, 900.4327273817453, 7925.326347260432, 8101.756947291591, 8145.6741730331305, 8161.551114688749, 8200.384971127189, 963.7638778499172, 972.3242346569208, 979.9265055120894, 1001.9298649094493, 1002.4737013068197, 4604.539546045368, 4699.78850951708, 4730.52694730531, 4781.402324709411, 5088.491150884956, 21935.232266870582, 22636.434089147573, 22720.20479283217, 23027.76972230256, 23212.0, 23015.079396823938, 23092.4226894329, 23142.76857231406, 23178.768212318, 23187.0, 10443.582256709646, 10600.469976501145, 10757.946210269056, 11006.339619622848, 11211.60759373418, 8111.797205069921, 8170.264676179172, 8180.46826956246, 8316.542590157358, 8358.122397148212, 19048.238070477026, 19169.0, 19384.2246310146, 19678.21287148498, 20060.398188054383, 19981.500462488555, 20131.46384744207, 20162.899185504564, 20500.077187775187, 20838.58322833565, 11587.536498539965, 11822.0, 11854.644360669194, 11871.525138994344, 11873.762524749629, 13981.44074237019, 14060.718785624435, 14089.506867259597, 14110.294485275901, 14261.500847470288, 11818.349990750592, 11922.821157682469, 12002.1598488105, 12309.44607492683, 12317.322547259628, 11415.771684566429, 11696.239744416585, 11817.822732658846, 11848.644540663794, 11916.75576220222, 10169.288149829441, 10211.846822297523, 10425.791484170426, 10444.843327349943, 10452.372857628567, 7382.040334756662, 7465.6267186641535, 7487.288707572772, 7499.362554182738, 7601.0878694557005, 7542.585157816373, 7569.924300756922, 7601.277878601524, 7748.57382843949, 7797.259260370256], "value": 6847.246528689304, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.7224315704655, 507.66240450100685, 516.5583426170624, 523.9292695486108, 527.2276115490805, 6307.148534947786, 6349.841253968647, 6425.421712045915, 6458.354164583539, 6463.676816159185, 6242.625442473455, 6280.214973128359, 6281.654509002003, 6303.779367722131, 6378.034214090459, 5177.0, 5200.973995130019, 5224.7387630618505, 5244.816431424901, 5276.630635855492, 4918.336024636664, 5254.264402983586, 5284.788608455658, 5290.576753859701, 5303.204519322113, 4942.802287908479, 4969.279454479099, 4981.327520784684, 5009.29869818224, 5011.498850114977, 4959.429665588467, 4996.1756310208775, 5005.874853128665, 5009.173486374744, 5010.674306170124, 4410.713303635285, 4421.801018954123, 4463.955360446386, 4477.955220447819, 4478.910421791546, 6084.482818960394, 6138.588124731292, 6206.920681571679, 6228.750849965996, 6253.405926436982, 5638.154276858463, 5690.7439165237665, 5709.457601527848, 5742.885142297131, 5776.8844623107725, 6461.0, 6480.189976252968, 6522.173591542272, 6526.2494813096155, 6594.439472644831, 4822.421309442854, 4828.106800241966, 4851.345068415754, 4858.5384388483035, 4861.659683822134, 6656.334366563354, 6756.695948682321, 6841.110655614788, 6926.238113807477, 7020.964895175543, 4957.553820156131, 4971.2543118531785, 4993.80024799004, 5045.722485263273, 5053.191489361684, 5020.59835213182, 5032.370953630796, 5037.319961805183, 5062.569681577033, 5113.642045056885, 5620.662760234317, 5676.687782171937, 5697.23087383198, 5722.54219662426, 5773.6824474654295, 6609.636469994197, 6614.503912206604, 6660.96669516659, 6701.698423570951, 6746.414592570742, 1723.629419674776, 1735.8350956659096, 1764.4794785538297, 1776.8845025073329, 1790.937317193918, 1139.86013986014, 1208.1241100202458, 1220.9633710988685, 1222.1383924333325, 1227.5212667059855, 5690.402507736628, 5740.913886291709, 5766.971165144148, 5789.3921138279875, 5814.651120932757, 6602.504812139013, 6644.468442524587, 6662.0, 6684.195267277808, 6705.161854768154, 5610.0, 5629.43705629442, 5706.514946229534, 5710.600257981984, 5730.312362516442, 3495.1961048958883, 3582.5880023797595, 3583.5699716033723, 3615.475756015363, 3624.52881125452, 6384.3934826191435, 6426.196725409324, 6532.542722009509, 6579.967100164468, 6593.307702691244, 6682.498812589075, 6837.222322196265, 6890.414314783199, 6903.482238832108, 6932.341427564374, 6079.8480037998515, 6374.776882809079, 6490.058941453557, 6529.575577587441, 6587.155596433006, 6547.0, 6638.933610664025, 6640.76757313511, 6670.533062685566, 6670.866582668416, 6553.868922621617, 6600.80197594073, 6609.801705948829, 6719.563228390139, 6752.223494298219, 6261.186045814015, 6271.592346497463, 6305.8108256752375, 6371.267304260069, 6441.1626488556185, 4975.353204083446, 4980.153373926513, 5007.924881126859, 5020.941414020234, 5068.695878247317, 6437.485001199986, 6542.149520562297, 6622.933770662232, 6645.833854153685, 6841.289677580605, 6377.7767778127545, 6467.773627923, 6501.739930402731, 6569.835754106186, 6584.242812076673, 6484.805455836333, 6498.545101842826, 6522.543421960418, 6558.80323590293, 6594.901076483952, 6440.806775796734, 6454.870902581828, 6460.935390646034, 6462.903056454063, 6518.0, 6529.706163222571, 6644.667766611747, 6708.530402871752, 6713.6643167842385, 6731.730730770714, 6310.990241561328, 6346.524010699124, 6413.807585772434, 6460.900207432509, 6498.342922554718], "value": 5067.3128111293245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.6336233825299, 919.6781126605687, 921.0605182713637, 927.2952556057394, 942.1567696911264, 19810.900945495287, 20920.895395523003, 20959.266425675105, 20992.790072099273, 21123.0, 17355.739663905053, 17400.47798566042, 17446.214920328584, 17610.911945440253, 17611.911940440314, 922.6125027488438, 933.3000249812641, 937.0208132501552, 937.9437233765962, 939.0046550656292, 969.9224062075017, 972.4019727867346, 972.4943029624591, 972.5526257921365, 974.3910056214866, 1000.7798284377461, 1028.9022542858415, 1040.7242080848544, 1043.9582416703322, 1044.0186224948561, 1032.7108409645236, 1033.7467320506448, 1034.886162522122, 1035.9119474844647, 1036.3988886445882, 725.1588157737, 746.936510396617, 746.9514481558681, 748.6556184155295, 748.7940816275513, 20852.687209691867, 20921.0, 21022.47443813917, 21041.789582104135, 21045.052972616268, 22196.667049994103, 22316.77257750823, 22601.32196034105, 22988.195413160625, 23017.88491057534, 18059.458216253402, 18547.629047419112, 18583.814161858343, 18646.53383665419, 18651.906740466347, 3683.834227459771, 3699.426588878728, 3704.573973992998, 3720.0885782983073, 3722.3671975764187, 115015.0, 148493.25753371272, 150966.24516877456, 151533.24233378764, 153624.0, 17521.64956700859, 17868.55328616795, 17906.462806115836, 17923.641527169646, 17930.282788688568, 32154.83922580419, 32207.677923220468, 32763.836180818944, 32770.34459310848, 32770.83614581912, 8782.692605758768, 8897.332700047393, 8912.643494260286, 8917.598708058153, 8939.553022348857, 4072.266991941479, 4123.670106391482, 4184.225918205142, 4203.957960420418, 4223.873283801429, 5627.437256274422, 5679.886402271932, 5709.571782116358, 5728.398518155534, 5747.511461525817, 1005.9044390782864, 1031.8142734307746, 1035.4770840725384, 1037.962037962038, 1043.634727845248, 631.4254028833831, 643.2634633344794, 672.9697163627649, 682.6552590941543, 687.1410736579276, 12495.50017999288, 12763.936180319039, 12965.416556254992, 13595.456181752817, 13732.244726540137, 696.3036963036963, 696.3767428151878, 718.396546900606, 720.0639169080175, 724.2286964382915, 5812.505936995318, 5876.794312199053, 5978.641281523122, 6035.0, 6117.724702388403, 124225.0, 124262.37868810598, 124778.37610811887, 126761.0, 127446.0, 99316.0, 104001.47999260106, 107555.46222268995, 109681.45159274152, 113763.0, 97363.0, 98229.0, 99089.0, 100202.4989875046, 101431.4928425368, 11230.606928757454, 11320.547178112784, 11337.26307789991, 11531.538738450703, 11627.0, 45471.77264113658, 46672.53327466682, 47174.34889778841, 47545.0, 47577.52422475731, 61919.38080619136, 62258.0, 62320.06519902114, 62724.68637656783, 63660.68169659122, 16196.514104576881, 16222.51332460028, 16255.431059912846, 16403.343866245694, 16508.504744857673, 18024.0, 18156.818431815514, 18229.088545572402, 18283.81716182821, 18370.908145459187, 16814.915925420293, 16880.409185678443, 16895.831041689427, 17017.74473382925, 17021.0, 16830.0, 17121.315147394464, 17152.828471715624, 17212.655746885244, 17335.82664173342, 16782.0, 16914.069726164686, 16924.069176195426, 17054.14729263507, 17072.402465913634, 11433.314001159957, 11615.941920290345, 11900.107491937966, 11950.880491194977, 11993.460294286604, 12675.93662031684, 12810.935945320214, 12819.551315703906, 12823.038272129814, 12828.037897157565], "value": 9211.573361605355, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1408.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 106.0, 107.0, 106.0, 96.0, 108.0, 106.0, 106.0, 106.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 116.0, 116.0, 116.0, 116.0, 118.0, 119.0, 118.0, 117.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 163.0, 162.0, 162.0, 163.0, 166.0, 168.0, 167.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 74.0, 75.0, 73.0, 75.0, 73.0, 73.0, 74.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 83.0, 84.0, 80.0, 78.0, 78.0, 79.0, 89.0, 79.0], "value": 81.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 117.0, 112.0, 117.0, 112.0, 113.0, 114.0, 112.0, 116.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 148.0, 151.0, 149.0, 149.0, 149.0, 147.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 96.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 51.0, 51.0, 53.0, 54.0, 53.0, 53.0, 52.0, 51.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 42.0, 36.0, 37.0, 36.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 75.0, 74.0, 78.0, 73.0, 74.0, 74.0, 76.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 116.0, 113.0, 112.0, 112.0, 117.0, 109.0, 119.0, 107.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 178.0, 164.0, 166.0, 161.0, 159.0, 161.0, 168.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 65.0, 66.0, 70.0, 68.0, 69.0, 64.0, 65.0], "value": 66.8, "unit": "score"}]}]} 04:03:57 INFO - Return code: 0 04:03:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:03:58 INFO - # TBPL SUCCESS # 04:03:58 INFO - Running post-action listener: _package_coverage_data 04:03:58 INFO - Running post-action listener: _resource_record_post_action 04:03:58 INFO - [mozharness: 2017-09-29 11:03:58.050212Z] Finished run-tests step (success) 04:03:58 INFO - Running post-run listener: _resource_record_post_run 04:03:58 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 341831680; Read time: 8; Write time: 298516 04:03:58 INFO - TinderboxPrint: CPU usage
13.1% 04:03:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:03:58 INFO - TinderboxPrint: I/O write bytes / time
341,831,680 / 298,516 04:03:58 INFO - TinderboxPrint: CPU idle
8,234.9 (86.9%) 04:03:58 INFO - TinderboxPrint: CPU user
1,193.5 (12.6%) 04:03:58 INFO - TinderboxPrint: Swap in / out
0 / 0 04:03:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13131776; Read time: 0; Write time: 2668 04:03:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:03:58 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 328683520; Read time: 0; Write time: 295848 04:03:58 INFO - Running post-run listener: _upload_blobber_files 04:03:58 INFO - Blob upload gear active. 04:03:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:03:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:03:58 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'] 04:03:58 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 04:03:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:03:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:03:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:04:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:00 INFO - (blobuploader) - INFO - Done attempting. 04:04:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:04:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:04:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:01 INFO - (blobuploader) - INFO - Done attempting. 04:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:04:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:04 INFO - (blobuploader) - INFO - Done attempting. 04:04:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:04:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:04:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:05 INFO - (blobuploader) - INFO - Done attempting. 04:04:05 INFO - (blobuploader) - INFO - Iteration through files over. 04:04:05 INFO - Return code: 0 04:04:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:04:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:04:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2751155648d8856f5e257195aa688f32c0dfbace4d0f459db3cf2080e9b6191ee9e6d43253c416108b35d0ce1110cbd444d0e37bfb4d1bedb0bf216fc18a512", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d327dd8f550b6160640567e258dd9c728609d853f03594e7e122f59488b2bd743c2880dec3ec0376bec9a0bb4e83d3765f61d8204ed10f00d48eaa10021f2015", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c40f8e4105c028996d4e21acb3c1a36a4f9b1ff3864793abb4a500b9b559e42cccd34fae1d34651d7985f902e3fb674df1efebd2a1a31b2f34184d721ac1f3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3447f4b27b9a00ec292f9fbfae2f6a75a576ace41fd082603b43d9b84df61f7359bbd3114911e18cd4f5e7fdcb208f85ed2f03d457e9361777790a9e6ad95da7"} 04:04:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:04:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:04:05 INFO - Contents: 04:04:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2751155648d8856f5e257195aa688f32c0dfbace4d0f459db3cf2080e9b6191ee9e6d43253c416108b35d0ce1110cbd444d0e37bfb4d1bedb0bf216fc18a512", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d327dd8f550b6160640567e258dd9c728609d853f03594e7e122f59488b2bd743c2880dec3ec0376bec9a0bb4e83d3765f61d8204ed10f00d48eaa10021f2015", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c40f8e4105c028996d4e21acb3c1a36a4f9b1ff3864793abb4a500b9b559e42cccd34fae1d34651d7985f902e3fb674df1efebd2a1a31b2f34184d721ac1f3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3447f4b27b9a00ec292f9fbfae2f6a75a576ace41fd082603b43d9b84df61f7359bbd3114911e18cd4f5e7fdcb208f85ed2f03d457e9361777790a9e6ad95da7"} 04:04:05 INFO - Running post-run listener: copy_logs_to_upload_dir 04:04:05 INFO - Copying logs to upload dir... 04:04:05 INFO - mkdir: /builds/slave/test/build/upload/logs 04:04:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.296805 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-29 04:04:05.629335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 04:04:05.638307) ========= 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=1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857 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/d2751155648d8856f5e257195aa688f32c0dfbace4d0f459db3cf2080e9b6191ee9e6d43253c416108b35d0ce1110cbd444d0e37bfb4d1bedb0bf216fc18a512", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d327dd8f550b6160640567e258dd9c728609d853f03594e7e122f59488b2bd743c2880dec3ec0376bec9a0bb4e83d3765f61d8204ed10f00d48eaa10021f2015", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c40f8e4105c028996d4e21acb3c1a36a4f9b1ff3864793abb4a500b9b559e42cccd34fae1d34651d7985f902e3fb674df1efebd2a1a31b2f34184d721ac1f3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3447f4b27b9a00ec292f9fbfae2f6a75a576ace41fd082603b43d9b84df61f7359bbd3114911e18cd4f5e7fdcb208f85ed2f03d457e9361777790a9e6ad95da7"} build_url:https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/ewqrVSCKSgOWNQzmAaDlXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2751155648d8856f5e257195aa688f32c0dfbace4d0f459db3cf2080e9b6191ee9e6d43253c416108b35d0ce1110cbd444d0e37bfb4d1bedb0bf216fc18a512", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d327dd8f550b6160640567e258dd9c728609d853f03594e7e122f59488b2bd743c2880dec3ec0376bec9a0bb4e83d3765f61d8204ed10f00d48eaa10021f2015", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c40f8e4105c028996d4e21acb3c1a36a4f9b1ff3864793abb4a500b9b559e42cccd34fae1d34651d7985f902e3fb674df1efebd2a1a31b2f34184d721ac1f3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3447f4b27b9a00ec292f9fbfae2f6a75a576ace41fd082603b43d9b84df61f7359bbd3114911e18cd4f5e7fdcb208f85ed2f03d457e9361777790a9e6ad95da7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 04:04:05.677507) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:04:05.683058) ========= 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=1258088b6da462a47ba2cd90000001a2-1506678066.373737-80768857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:04:05.744408) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 04:04:05.748968) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 04:04:05.749635) ========= ========= Total master_lag: 0.29 =========